builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-045 starttime: 1471988050.3 results: success (0) buildid: 20160823113035 builduid: eef621d86ad847eda10a4e9eb12ca50a revision: 6e17a469a1b137c535adee7e476f86ee9dfcc071 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 14:34:10.300301) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 14:34:10.300820) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 14:34:10.301122) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 14:34:10.315604) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 14:34:10.315938) ========= 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=4300f881736b422476174874000001bc-1471988049.319340-2108220558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-23 14:34: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-08-23 14:34:10 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079169 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 14:34:10.409738) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 14:34:10.410093) ========= 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=4300f881736b422476174874000001bc-1471988049.319340-2108220558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018495 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 14:34:10.460701) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-23 14:34:10.461127) ========= 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=4300f881736b422476174874000001bc-1471988049.319340-2108220558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-23 14:34:10,469 truncating revision to first 12 chars 2016-08-23 14:34:10,469 Setting DEBUG logging. 2016-08-23 14:34:10,469 attempt 1/10 2016-08-23 14:34:10,469 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:34:11,180 unpacking tar archive at: fx-team-6e17a469a1b1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.002683 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-23 14:34:11.477992) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 14:34:11.478411) ========= script_repo_revision: 6e17a469a1b137c535adee7e476f86ee9dfcc071 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 14:34:11.478862) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 14:34:11.479174) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 14:34:11.488891) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-08-23 14:34:11.489326) ========= /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=4300f881736b422476174874000001bc-1471988049.319340-2108220558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:34:11 INFO - MultiFileLogger online at 20160823 14:34:11 in /builds/slave/test 14:34: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:34:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:34:11 INFO - {'append_to_log': False, 14:34:11 INFO - 'base_work_dir': '/builds/slave/test', 14:34:11 INFO - 'blob_upload_branch': 'Fx-Team', 14:34:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:34:11 INFO - 'branch': 'Fx-Team', 14:34:11 INFO - 'buildbot_json_path': 'buildprops.json', 14:34:11 INFO - 'config_files': ('talos/linux_config.py',), 14:34:11 INFO - 'default_actions': ('clobber', 14:34:11 INFO - 'read-buildbot-config', 14:34:11 INFO - 'download-and-extract', 14:34:11 INFO - 'populate-webroot', 14:34:11 INFO - 'create-virtualenv', 14:34:11 INFO - 'install', 14:34:11 INFO - 'run-tests'), 14:34:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:34:11 INFO - 'download_minidump_stackwalk': True, 14:34:11 INFO - 'download_symbols': 'ondemand', 14:34:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:34:11 INFO - 'tooltool.py': '/tools/tooltool.py', 14:34:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:34:11 INFO - '/tools/misc-python/virtualenv.py')}, 14:34:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:34:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:34:11 INFO - 'installer_path': 'installer.exe', 14:34:11 INFO - 'log_level': 'info', 14:34:11 INFO - 'log_name': 'talos', 14:34:11 INFO - 'log_to_console': True, 14:34:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:34:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:34:11 INFO - 'opt_config_files': (), 14:34:11 INFO - 'pip_index': False, 14:34:11 INFO - 'sps_profile': False, 14:34:11 INFO - 'sps_profile_interval': 0, 14:34:11 INFO - 'suite': 'dromaeojs', 14:34:11 INFO - 'system_bits': '32', 14:34:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:34:11 INFO - 'title': 'talos-linux64-ix-045', 14:34:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:34:11 INFO - 'use_talos_json': True, 14:34:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:34:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:34:11 INFO - 'work_dir': 'build'} 14:34:11 INFO - [mozharness: 2016-08-23 21:34:11.590212Z] Running clobber step. 14:34:11 INFO - Running pre-action listener: _resource_record_pre_action 14:34:11 INFO - Running main action method: clobber 14:34:11 INFO - rmtree: /builds/slave/test/build 14:34:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:34:12 INFO - Running post-action listener: _resource_record_post_action 14:34:12 INFO - [mozharness: 2016-08-23 21:34:12.041779Z] Finished clobber step (success) 14:34:12 INFO - [mozharness: 2016-08-23 21:34:12.041879Z] Running read-buildbot-config step. 14:34:12 INFO - Running pre-action listener: _resource_record_pre_action 14:34:12 INFO - Running main action method: read_buildbot_config 14:34:12 INFO - Using buildbot properties: 14:34:12 INFO - { 14:34:12 INFO - "project": "", 14:34:12 INFO - "product": "firefox", 14:34:12 INFO - "script_repo_revision": "production", 14:34:12 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:34:12 INFO - "repository": "", 14:34:12 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:34:12 INFO - "buildid": "20160823113035", 14:34:12 INFO - "pgo_build": "True", 14:34:12 INFO - "basedir": "/builds/slave/test", 14:34:12 INFO - "buildnumber": 1005, 14:34:12 INFO - "slavename": "talos-linux64-ix-045", 14:34:12 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:34:12 INFO - "platform": "ubuntu64_hw", 14:34:12 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:34:12 INFO - "branch": "fx-team", 14:34:12 INFO - "repo_path": "integration/fx-team", 14:34:12 INFO - "revision": "6e17a469a1b137c535adee7e476f86ee9dfcc071", 14:34:12 INFO - "stage_platform": "linux64-pgo", 14:34:12 INFO - "builduid": "eef621d86ad847eda10a4e9eb12ca50a", 14:34:12 INFO - "slavebuilddir": "test" 14:34:12 INFO - } 14:34: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:34:12 INFO - Running post-action listener: _resource_record_post_action 14:34:12 INFO - [mozharness: 2016-08-23 21:34:12.044278Z] Finished read-buildbot-config step (success) 14:34:12 INFO - [mozharness: 2016-08-23 21:34:12.044366Z] Running download-and-extract step. 14:34:12 INFO - Running pre-action listener: _resource_record_pre_action 14:34:12 INFO - Running main action method: download_and_extract 14:34:12 INFO - mkdir: /builds/slave/test/build/tests 14:34: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:34: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:34: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:34: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:34:12 INFO - Downloaded 1361 bytes. 14:34:12 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:34:12 INFO - Using the following test package requirements: 14:34:12 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:34:12 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:34:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:34:12 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:34:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:34:12 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:34:12 INFO - u'jsshell-linux-x86_64.zip'], 14:34:12 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:34:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:34:12 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:34:12 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:34:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:34:12 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:34:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:34:12 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:34:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:34:12 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:34:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:34:12 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:34: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:34:12 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:34:12 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:34:12 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:34:13 INFO - Downloaded 21914758 bytes. 14:34: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:34:17 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:34:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:17 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:34:17 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:34:17 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:34:18 INFO - Downloaded 21914758 bytes. 14:34:18 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:34:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:23 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:34:23 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:34:23 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:34:23 INFO - Downloaded 14413981 bytes. 14:34:23 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:34:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:24 INFO - trying https://queue.taskcluster.net/v1/task/LB11U0A_QnO3IpL1biu6mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:34:24 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:34:24 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:34:25 INFO - Downloaded 59734754 bytes. 14:34:25 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:34:25 INFO - mkdir: /builds/slave/test/properties 14:34:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:34:25 INFO - Writing to file /builds/slave/test/properties/build_url 14:34:25 INFO - Contents: 14:34:25 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:34:26 INFO - Running post-action listener: _resource_record_post_action 14:34:26 INFO - Running post-action listener: set_extra_try_arguments 14:34:26 INFO - [mozharness: 2016-08-23 21:34:26.603646Z] Finished download-and-extract step (success) 14:34:26 INFO - [mozharness: 2016-08-23 21:34:26.603869Z] Running populate-webroot step. 14:34:26 INFO - Running pre-action listener: _resource_record_pre_action 14:34:26 INFO - Running main action method: populate_webroot 14:34:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:34:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:34:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:34:26 INFO - '--tppagecycles', 14:34:26 INFO - '7'], 14:34:26 INFO - 'tests': ['tsvgm']}}, 14:34:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:34:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:34:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:34:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:34:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:34:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:34:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:26 INFO - 'talos_options': ['--disable-e10s'], 14:34:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:34:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:34:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:26 INFO - 'talos_options': ['--disable-e10s'], 14:34:26 INFO - 'tests': ['damp', 'tps']}, 14:34:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:26 INFO - 'tests': ['damp', 'tps']}, 14:34:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:34:26 INFO - 'tests': ['dromaeo_dom']}, 14:34:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:34:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:34:26 INFO - 'tests': ['basic_compositor_video']}, 14:34:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:34:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:34:26 INFO - 'tests': ['a11yr', 14:34:26 INFO - 'ts_paint', 14:34:26 INFO - 'tpaint', 14:34:26 INFO - 'sessionrestore', 14:34:26 INFO - 'sessionrestore_no_auto_restore', 14:34:26 INFO - 'tabpaint']}, 14:34:26 INFO - 'other-e10s': {'tests': ['a11yr', 14:34:26 INFO - 'ts_paint', 14:34:26 INFO - 'tpaint', 14:34:26 INFO - 'sessionrestore', 14:34:26 INFO - 'sessionrestore_no_auto_restore', 14:34:26 INFO - 'tabpaint']}, 14:34:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:34:26 INFO - 'ts_paint', 14:34:26 INFO - 'tpaint', 14:34:26 INFO - 'sessionrestore', 14:34:26 INFO - 'sessionrestore_no_auto_restore', 14:34:26 INFO - 'tabpaint']}, 14:34:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:34:26 INFO - 'ts_paint', 14:34:26 INFO - 'tpaint', 14:34:26 INFO - 'sessionrestore', 14:34:26 INFO - 'sessionrestore_no_auto_restore', 14:34:26 INFO - 'tabpaint']}, 14:34:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:34:26 INFO - 'tests': ['a11yr', 14:34:26 INFO - 'ts_paint', 14:34:26 INFO - 'tpaint', 14:34:26 INFO - 'sessionrestore', 14:34:26 INFO - 'sessionrestore_no_auto_restore', 14:34:26 INFO - 'tabpaint']}, 14:34:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:34:26 INFO - 'tests': ['a11yr', 14:34:26 INFO - 'ts_paint', 14:34:26 INFO - 'tpaint', 14:34:26 INFO - 'sessionrestore', 14:34:26 INFO - 'sessionrestore_no_auto_restore', 14:34:26 INFO - 'tabpaint']}, 14:34:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:34:26 INFO - 'tests': ['tsvgx', 14:34:26 INFO - 'tsvgr_opacity', 14:34:26 INFO - 'tart', 14:34:26 INFO - 'tscrollx', 14:34:26 INFO - 'cart']}, 14:34:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:34:26 INFO - 'tsvgr_opacity', 14:34:26 INFO - 'tart', 14:34:26 INFO - 'tscrollx', 14:34:26 INFO - 'cart']}, 14:34:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:26 INFO - 'talos_options': ['--disable-e10s'], 14:34:26 INFO - 'tests': ['tp5o']}, 14:34:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:26 INFO - 'tests': ['tp5o']}, 14:34:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:26 INFO - 'talos_options': ['--disable-e10s', 14:34:26 INFO - '--xperf_path', 14:34:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:34:26 INFO - 'tests': ['tp5n']}, 14:34:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:26 INFO - 'talos_options': ['--xperf_path', 14:34:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:34:26 INFO - 'tests': ['tp5n']}}, 14:34:26 INFO - 'talos.zip': {'path': '', 14:34:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:34:26 INFO - Running post-action listener: _resource_record_post_action 14:34:26 INFO - [mozharness: 2016-08-23 21:34:26.623209Z] Finished populate-webroot step (success) 14:34:26 INFO - [mozharness: 2016-08-23 21:34:26.623297Z] Running create-virtualenv step. 14:34:26 INFO - Running pre-action listener: _resource_record_pre_action 14:34:26 INFO - Running main action method: create_virtualenv 14:34:26 INFO - Creating virtualenv /builds/slave/test/build/venv 14:34:26 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:34:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:34:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:34:26 INFO - Using real prefix '/usr' 14:34:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:34:27 INFO - Installing distribute.............................................................................................................................................................................................done. 14:34:29 INFO - Installing pip.................done. 14:34:29 INFO - Return code: 0 14:34:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:34:29 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:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:29 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:34:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:29 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 0x7f3857debf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1689370>, '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 0x168c8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x168cd80>, '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': '4300f881736b422476174874000001bc-1471988049.319340-2108220558', '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:34:29 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:34:29 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:34:29 INFO - Using env: {'DISPLAY': ':0', 14:34:29 INFO - 'HOME': '/home/cltbld', 14:34:29 INFO - 'LANG': 'en_US.UTF-8', 14:34:29 INFO - 'LANGUAGE': 'en_US:en', 14:34:29 INFO - 'LOGNAME': 'cltbld', 14:34:29 INFO - 'MAIL': '/var/mail/cltbld', 14:34:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:29 INFO - 'MOZ_NO_REMOTE': '1', 14:34:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:34:29 INFO - 'NO_EM_RESTART': '1', 14:34:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:34:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:29 INFO - 'PWD': '/builds/slave/test', 14:34:29 INFO - 'SHELL': '/bin/bash', 14:34:29 INFO - 'SHLVL': '1', 14:34:29 INFO - 'TERM': 'linux', 14:34:29 INFO - 'TMOUT': '86400', 14:34:29 INFO - 'USER': 'cltbld', 14:34:29 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1471988049.319340-2108220558', 14:34:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:29 INFO - '_': '/tools/buildbot/bin/python'} 14:34:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:29 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:34:29 INFO - Cleaning up... 14:34:29 INFO - Return code: 0 14:34:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:34:29 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:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:29 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:34:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:29 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 0x7f3857debf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1689370>, '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 0x168c8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x168cd80>, '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': '4300f881736b422476174874000001bc-1471988049.319340-2108220558', '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:34:29 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:34:29 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:34:29 INFO - Using env: {'DISPLAY': ':0', 14:34:29 INFO - 'HOME': '/home/cltbld', 14:34:29 INFO - 'LANG': 'en_US.UTF-8', 14:34:29 INFO - 'LANGUAGE': 'en_US:en', 14:34:29 INFO - 'LOGNAME': 'cltbld', 14:34:29 INFO - 'MAIL': '/var/mail/cltbld', 14:34:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:29 INFO - 'MOZ_NO_REMOTE': '1', 14:34:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:34:29 INFO - 'NO_EM_RESTART': '1', 14:34:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:34:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:29 INFO - 'PWD': '/builds/slave/test', 14:34:29 INFO - 'SHELL': '/bin/bash', 14:34:29 INFO - 'SHLVL': '1', 14:34:29 INFO - 'TERM': 'linux', 14:34:29 INFO - 'TMOUT': '86400', 14:34:29 INFO - 'USER': 'cltbld', 14:34:29 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1471988049.319340-2108220558', 14:34:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:29 INFO - '_': '/tools/buildbot/bin/python'} 14:34:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:29 INFO - Downloading/unpacking psutil>=3.1.1 14:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:34:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:34:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:34:31 INFO - Installing collected packages: psutil 14:34:31 INFO - Running setup.py install for psutil 14:34:31 INFO - building 'psutil._psutil_linux' extension 14:34:31 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:34:31 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:34:31 INFO - building 'psutil._psutil_posix' extension 14:34:31 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:34:31 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:34:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:34:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:34:32 INFO - Successfully installed psutil 14:34:32 INFO - Cleaning up... 14:34:32 INFO - Return code: 0 14:34:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:34: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:34:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34: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:34:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3857debf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1689370>, '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 0x168c8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x168cd80>, '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': '4300f881736b422476174874000001bc-1471988049.319340-2108220558', '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:34: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:34: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 mozsystemmonitor==0.3 14:34:32 INFO - Using env: {'DISPLAY': ':0', 14:34:32 INFO - 'HOME': '/home/cltbld', 14:34:32 INFO - 'LANG': 'en_US.UTF-8', 14:34:32 INFO - 'LANGUAGE': 'en_US:en', 14:34:32 INFO - 'LOGNAME': 'cltbld', 14:34:32 INFO - 'MAIL': '/var/mail/cltbld', 14:34:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:32 INFO - 'MOZ_NO_REMOTE': '1', 14:34:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:34:32 INFO - 'NO_EM_RESTART': '1', 14:34:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:34:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:32 INFO - 'PWD': '/builds/slave/test', 14:34:32 INFO - 'SHELL': '/bin/bash', 14:34:32 INFO - 'SHLVL': '1', 14:34:32 INFO - 'TERM': 'linux', 14:34:32 INFO - 'TMOUT': '86400', 14:34:32 INFO - 'USER': 'cltbld', 14:34:32 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1471988049.319340-2108220558', 14:34:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:32 INFO - '_': '/tools/buildbot/bin/python'} 14:34:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:34: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:34: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:34: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:34: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:34: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:34: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:34:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:34:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:34:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:34:34 INFO - Installing collected packages: mozsystemmonitor 14:34:34 INFO - Running setup.py install for mozsystemmonitor 14:34:34 INFO - Successfully installed mozsystemmonitor 14:34:34 INFO - Cleaning up... 14:34:34 INFO - Return code: 0 14:34:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:34:34 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:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:34 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:34:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:34 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 0x7f3857debf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1689370>, '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 0x168c8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x168cd80>, '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': '4300f881736b422476174874000001bc-1471988049.319340-2108220558', '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:34:34 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:34:34 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:34:34 INFO - Using env: {'DISPLAY': ':0', 14:34:34 INFO - 'HOME': '/home/cltbld', 14:34:34 INFO - 'LANG': 'en_US.UTF-8', 14:34:34 INFO - 'LANGUAGE': 'en_US:en', 14:34:34 INFO - 'LOGNAME': 'cltbld', 14:34:34 INFO - 'MAIL': '/var/mail/cltbld', 14:34:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:34 INFO - 'MOZ_NO_REMOTE': '1', 14:34:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:34:34 INFO - 'NO_EM_RESTART': '1', 14:34:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:34:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:34 INFO - 'PWD': '/builds/slave/test', 14:34:34 INFO - 'SHELL': '/bin/bash', 14:34:34 INFO - 'SHLVL': '1', 14:34:34 INFO - 'TERM': 'linux', 14:34:34 INFO - 'TMOUT': '86400', 14:34:34 INFO - 'USER': 'cltbld', 14:34:34 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1471988049.319340-2108220558', 14:34:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:34 INFO - '_': '/tools/buildbot/bin/python'} 14:34:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:34 INFO - Downloading/unpacking jsonschema==2.5.1 14:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:34:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:34: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:34: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:34: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:34: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:34: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:34: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:34:36 INFO - Downloading functools32-3.2.3-2.tar.gz 14:34:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:34:36 INFO - warning: no files found matching '*.txt' 14:34:36 INFO - no previously-included directories found matching 'build' 14:34:36 INFO - no previously-included directories found matching 'dist' 14:34:36 INFO - no previously-included directories found matching '.git*' 14:34:36 INFO - Installing collected packages: jsonschema, functools32 14:34:36 INFO - Running setup.py install for functools32 14:34:36 INFO - warning: no files found matching '*.txt' 14:34:36 INFO - no previously-included directories found matching 'build' 14:34:36 INFO - no previously-included directories found matching 'dist' 14:34:36 INFO - no previously-included directories found matching '.git*' 14:34:36 INFO - Successfully installed jsonschema functools32 14:34:36 INFO - Cleaning up... 14:34:37 INFO - Return code: 0 14:34:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:34:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3857debf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1689370>, '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 0x168c8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x168cd80>, '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': '4300f881736b422476174874000001bc-1471988049.319340-2108220558', '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:34:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:34:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:34:37 INFO - Using env: {'DISPLAY': ':0', 14:34:37 INFO - 'HOME': '/home/cltbld', 14:34:37 INFO - 'LANG': 'en_US.UTF-8', 14:34:37 INFO - 'LANGUAGE': 'en_US:en', 14:34:37 INFO - 'LOGNAME': 'cltbld', 14:34:37 INFO - 'MAIL': '/var/mail/cltbld', 14:34:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:37 INFO - 'MOZ_NO_REMOTE': '1', 14:34:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:34:37 INFO - 'NO_EM_RESTART': '1', 14:34:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:34:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:37 INFO - 'PWD': '/builds/slave/test', 14:34:37 INFO - 'SHELL': '/bin/bash', 14:34:37 INFO - 'SHLVL': '1', 14:34:37 INFO - 'TERM': 'linux', 14:34:37 INFO - 'TMOUT': '86400', 14:34:37 INFO - 'USER': 'cltbld', 14:34:37 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1471988049.319340-2108220558', 14:34:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:37 INFO - '_': '/tools/buildbot/bin/python'} 14:34:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:34:37 INFO - Cleaning up... 14:34:37 INFO - Return code: 0 14:34:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:34:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3857debf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1689370>, '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 0x168c8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x168cd80>, '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': '4300f881736b422476174874000001bc-1471988049.319340-2108220558', '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:34:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:34:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:34:37 INFO - Using env: {'DISPLAY': ':0', 14:34:37 INFO - 'HOME': '/home/cltbld', 14:34:37 INFO - 'LANG': 'en_US.UTF-8', 14:34:37 INFO - 'LANGUAGE': 'en_US:en', 14:34:37 INFO - 'LOGNAME': 'cltbld', 14:34:37 INFO - 'MAIL': '/var/mail/cltbld', 14:34:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:37 INFO - 'MOZ_NO_REMOTE': '1', 14:34:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:34:37 INFO - 'NO_EM_RESTART': '1', 14:34:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:34:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:37 INFO - 'PWD': '/builds/slave/test', 14:34:37 INFO - 'SHELL': '/bin/bash', 14:34:37 INFO - 'SHLVL': '1', 14:34:37 INFO - 'TERM': 'linux', 14:34:37 INFO - 'TMOUT': '86400', 14:34:37 INFO - 'USER': 'cltbld', 14:34:37 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1471988049.319340-2108220558', 14:34:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:37 INFO - '_': '/tools/buildbot/bin/python'} 14:34:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:37 INFO - Downloading/unpacking blobuploader==1.2.4 14:34:37 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:34:37 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:34:37 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:34:37 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:34:37 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:34:37 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:34:39 INFO - Downloading blobuploader-1.2.4.tar.gz 14:34:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:34:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:34:39 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:34:39 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:34:39 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:34:39 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:34:39 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:34:39 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:34:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:34:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:34:39 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:34:39 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:34:39 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:34:39 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:34:39 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:34:39 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:34:39 INFO - Downloading docopt-0.6.1.tar.gz 14:34:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:34:40 INFO - Installing collected packages: blobuploader, requests, docopt 14:34:40 INFO - Running setup.py install for blobuploader 14:34:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:34:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:34:40 INFO - Running setup.py install for requests 14:34:40 INFO - Running setup.py install for docopt 14:34:40 INFO - Successfully installed blobuploader requests docopt 14:34:40 INFO - Cleaning up... 14:34:40 INFO - Return code: 0 14:34:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:34: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:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34: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:34:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:40 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 0x7f3857debf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1689370>, '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 0x168c8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x168cd80>, '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': '4300f881736b422476174874000001bc-1471988049.319340-2108220558', '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:34:40 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:34:40 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:34:40 INFO - Using env: {'DISPLAY': ':0', 14:34:40 INFO - 'HOME': '/home/cltbld', 14:34:40 INFO - 'LANG': 'en_US.UTF-8', 14:34:40 INFO - 'LANGUAGE': 'en_US:en', 14:34:40 INFO - 'LOGNAME': 'cltbld', 14:34:40 INFO - 'MAIL': '/var/mail/cltbld', 14:34:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:40 INFO - 'MOZ_NO_REMOTE': '1', 14:34:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:34:40 INFO - 'NO_EM_RESTART': '1', 14:34:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:34:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:40 INFO - 'PWD': '/builds/slave/test', 14:34:40 INFO - 'SHELL': '/bin/bash', 14:34:40 INFO - 'SHLVL': '1', 14:34:40 INFO - 'TERM': 'linux', 14:34:40 INFO - 'TMOUT': '86400', 14:34:40 INFO - 'USER': 'cltbld', 14:34:40 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1471988049.319340-2108220558', 14:34:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:40 INFO - '_': '/tools/buildbot/bin/python'} 14:34:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:34:40 INFO - Running setup.py (path:/tmp/pip-lnvQa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:34:40 INFO - Running setup.py (path:/tmp/pip-bLAWsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:34:40 INFO - Running setup.py (path:/tmp/pip-7DuwKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:34:41 INFO - Running setup.py (path:/tmp/pip-8jw3vK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:34:41 INFO - Running setup.py (path:/tmp/pip-NlGo_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:34:41 INFO - Running setup.py (path:/tmp/pip-6chFvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:34:41 INFO - Running setup.py (path:/tmp/pip-aO4U1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:34:41 INFO - Running setup.py (path:/tmp/pip-A0yxcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:34:41 INFO - Running setup.py (path:/tmp/pip-ndtB_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:34:41 INFO - Running setup.py (path:/tmp/pip-oeoRce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:34:41 INFO - Running setup.py (path:/tmp/pip-NKps3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:34:41 INFO - Running setup.py (path:/tmp/pip-MCcRXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:34:41 INFO - Running setup.py (path:/tmp/pip-DQ5L2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:34:41 INFO - Running setup.py (path:/tmp/pip-XDOMwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:34:41 INFO - Running setup.py (path:/tmp/pip-g4n1et-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:34:41 INFO - Running setup.py (path:/tmp/pip-U6QUJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:34:42 INFO - Running setup.py (path:/tmp/pip-dvIHWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:34:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:34:42 INFO - Running setup.py install for manifestparser 14:34:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:34:42 INFO - Running setup.py install for mozcrash 14:34:42 INFO - Running setup.py install for mozdebug 14:34:42 INFO - Running setup.py install for mozdevice 14:34:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:34:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:34:42 INFO - Running setup.py install for mozfile 14:34:42 INFO - Running setup.py install for mozhttpd 14:34:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:34:42 INFO - Running setup.py install for mozinfo 14:34:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:34:42 INFO - Running setup.py install for mozInstall 14:34:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:34:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:34:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:34:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:34:42 INFO - Running setup.py install for mozleak 14:34:42 INFO - Running setup.py install for mozlog 14:34:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:34:43 INFO - Running setup.py install for moznetwork 14:34:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:34:43 INFO - Running setup.py install for mozprocess 14:34:43 INFO - Running setup.py install for mozprofile 14:34:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:34:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:34:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:34:43 INFO - Running setup.py install for mozrunner 14:34:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:34:43 INFO - Running setup.py install for mozscreenshot 14:34:43 INFO - Running setup.py install for moztest 14:34:43 INFO - Running setup.py install for mozversion 14:34:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:34:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:34:43 INFO - Cleaning up... 14:34:43 INFO - Return code: 0 14:34:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:34:43 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:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:43 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:34:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:43 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 0x7f3857debf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1689370>, '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 0x168c8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x168cd80>, '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': '4300f881736b422476174874000001bc-1471988049.319340-2108220558', '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:34:43 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:34:43 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:34:43 INFO - Using env: {'DISPLAY': ':0', 14:34:43 INFO - 'HOME': '/home/cltbld', 14:34:43 INFO - 'LANG': 'en_US.UTF-8', 14:34:43 INFO - 'LANGUAGE': 'en_US:en', 14:34:43 INFO - 'LOGNAME': 'cltbld', 14:34:43 INFO - 'MAIL': '/var/mail/cltbld', 14:34:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:43 INFO - 'MOZ_NO_REMOTE': '1', 14:34:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:34:43 INFO - 'NO_EM_RESTART': '1', 14:34:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:34:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:43 INFO - 'PWD': '/builds/slave/test', 14:34:43 INFO - 'SHELL': '/bin/bash', 14:34:43 INFO - 'SHLVL': '1', 14:34:43 INFO - 'TERM': 'linux', 14:34:43 INFO - 'TMOUT': '86400', 14:34:43 INFO - 'USER': 'cltbld', 14:34:43 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1471988049.319340-2108220558', 14:34:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:43 INFO - '_': '/tools/buildbot/bin/python'} 14:34:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:34:44 INFO - Running setup.py (path:/tmp/pip-lf8lHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:34:44 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:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:34:44 INFO - Running setup.py (path:/tmp/pip-32o6F6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:34:44 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:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:34:44 INFO - Running setup.py (path:/tmp/pip-KD4Uck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:34:44 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:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:34:44 INFO - Running setup.py (path:/tmp/pip-c0mPO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:34:44 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:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:34:44 INFO - Running setup.py (path:/tmp/pip-V77ERk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:34:44 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:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:34:44 INFO - Running setup.py (path:/tmp/pip-6MFzww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:34:44 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:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:34:44 INFO - Running setup.py (path:/tmp/pip-OpOmjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:34:44 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:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:34:44 INFO - Running setup.py (path:/tmp/pip-0iqSeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:34:44 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:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:34:44 INFO - Running setup.py (path:/tmp/pip-oBXE64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:34:44 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:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:34:44 INFO - Running setup.py (path:/tmp/pip-Wx4_sv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:34:44 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:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:34:44 INFO - Running setup.py (path:/tmp/pip-zPBPI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:34:44 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:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:34:44 INFO - Running setup.py (path:/tmp/pip-7zDlCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:34:44 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:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:34:44 INFO - Running setup.py (path:/tmp/pip-Ni1WYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:34:45 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:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:34:45 INFO - Running setup.py (path:/tmp/pip-_2xgCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:34:45 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:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:34:45 INFO - Running setup.py (path:/tmp/pip-STc0Wn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:34:45 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:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:34:45 INFO - Running setup.py (path:/tmp/pip-WkOD_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:34:45 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:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:34:45 INFO - Running setup.py (path:/tmp/pip-qBRz2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:34:45 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:34:45 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:34:45 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:34:45 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:34:45 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:34:45 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:34:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:34:45 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:34:45 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:34:45 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:34:45 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:34:45 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:34:45 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:34:47 INFO - Downloading blessings-1.6.tar.gz 14:34:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:34:47 INFO - Installing collected packages: blessings 14:34:47 INFO - Running setup.py install for blessings 14:34:47 INFO - Successfully installed blessings 14:34:47 INFO - Cleaning up... 14:34:47 INFO - Return code: 0 14:34:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:34:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:34:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:34:47 INFO - Reading from file tmpfile_stdout 14:34:47 INFO - Current package versions: 14:34:47 INFO - argparse == 1.2.1 14:34:47 INFO - blessings == 1.6 14:34:47 INFO - blobuploader == 1.2.4 14:34:47 INFO - docopt == 0.6.1 14:34:47 INFO - functools32 == 3.2.3-2 14:34:47 INFO - jsonschema == 2.5.1 14:34:47 INFO - manifestparser == 1.1 14:34:47 INFO - mozInstall == 1.12 14:34:47 INFO - mozcrash == 0.17 14:34:47 INFO - mozdebug == 0.1 14:34:47 INFO - mozdevice == 0.48 14:34:47 INFO - mozfile == 1.2 14:34:47 INFO - mozhttpd == 0.7 14:34:47 INFO - mozinfo == 0.9 14:34:47 INFO - mozleak == 0.1 14:34:47 INFO - mozlog == 3.3 14:34:47 INFO - moznetwork == 0.27 14:34:47 INFO - mozprocess == 0.23 14:34:47 INFO - mozprofile == 0.28 14:34:47 INFO - mozrunner == 6.12 14:34:47 INFO - mozscreenshot == 0.1 14:34:47 INFO - mozsystemmonitor == 0.3 14:34:47 INFO - moztest == 0.7 14:34:47 INFO - mozversion == 1.4 14:34:47 INFO - psutil == 3.1.1 14:34:47 INFO - requests == 1.2.3 14:34:47 INFO - wsgiref == 0.1.2 14:34:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:34: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:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34: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:34:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:47 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 0x7f3857debf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1689370>, '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 0x168c8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x168cd80>, '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': '4300f881736b422476174874000001bc-1471988049.319340-2108220558', '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:34:47 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:34:47 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:34:47 INFO - Using env: {'DISPLAY': ':0', 14:34:47 INFO - 'HOME': '/home/cltbld', 14:34:47 INFO - 'LANG': 'en_US.UTF-8', 14:34:47 INFO - 'LANGUAGE': 'en_US:en', 14:34:47 INFO - 'LOGNAME': 'cltbld', 14:34:47 INFO - 'MAIL': '/var/mail/cltbld', 14:34:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:47 INFO - 'MOZ_NO_REMOTE': '1', 14:34:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:34:47 INFO - 'NO_EM_RESTART': '1', 14:34:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:34:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:47 INFO - 'PWD': '/builds/slave/test', 14:34:47 INFO - 'SHELL': '/bin/bash', 14:34:47 INFO - 'SHLVL': '1', 14:34:47 INFO - 'TERM': 'linux', 14:34:47 INFO - 'TMOUT': '86400', 14:34:47 INFO - 'USER': 'cltbld', 14:34:47 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1471988049.319340-2108220558', 14:34:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:47 INFO - '_': '/tools/buildbot/bin/python'} 14:34:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:47 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:34:47 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:34:47 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:34:47 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:34:47 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:34:47 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:34:47 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:34:47 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:34:47 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:34:47 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:34:47 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:34:47 INFO - Cleaning up... 14:34:47 INFO - Return code: 0 14:34:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:34: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:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34: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:34:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:47 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 0x7f3857debf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1689370>, '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 0x168c8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x168cd80>, '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': '4300f881736b422476174874000001bc-1471988049.319340-2108220558', '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:34:47 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:34:47 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:34:47 INFO - Using env: {'DISPLAY': ':0', 14:34:47 INFO - 'HOME': '/home/cltbld', 14:34:47 INFO - 'LANG': 'en_US.UTF-8', 14:34:47 INFO - 'LANGUAGE': 'en_US:en', 14:34:47 INFO - 'LOGNAME': 'cltbld', 14:34:47 INFO - 'MAIL': '/var/mail/cltbld', 14:34:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:47 INFO - 'MOZ_NO_REMOTE': '1', 14:34:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:34:47 INFO - 'NO_EM_RESTART': '1', 14:34:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:34:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:47 INFO - 'PWD': '/builds/slave/test', 14:34:47 INFO - 'SHELL': '/bin/bash', 14:34:47 INFO - 'SHLVL': '1', 14:34:47 INFO - 'TERM': 'linux', 14:34:47 INFO - 'TMOUT': '86400', 14:34:47 INFO - 'USER': 'cltbld', 14:34:47 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1471988049.319340-2108220558', 14:34:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:47 INFO - '_': '/tools/buildbot/bin/python'} 14:34:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:34:48 INFO - Cleaning up... 14:34:48 INFO - Return code: 0 14:34:48 INFO - Running post-action listener: _resource_record_post_action 14:34:48 INFO - Running post-action listener: _start_resource_monitoring 14:34:48 INFO - Starting resource monitoring. 14:34:48 INFO - [mozharness: 2016-08-23 21:34:48.143042Z] Finished create-virtualenv step (success) 14:34:48 INFO - [mozharness: 2016-08-23 21:34:48.143540Z] Running install step. 14:34:48 INFO - Running pre-action listener: _resource_record_pre_action 14:34:48 INFO - Running main action method: install 14:34:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:34:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:34:48 INFO - Reading from file tmpfile_stdout 14:34:48 INFO - Detecting whether we're running mozinstall >=1.0... 14:34:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:34:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:34:48 INFO - Reading from file tmpfile_stdout 14:34:48 INFO - Output received: 14:34:48 INFO - Usage: mozinstall [options] installer 14:34:48 INFO - Options: 14:34:48 INFO - -h, --help show this help message and exit 14:34:48 INFO - -d DEST, --destination=DEST 14:34:48 INFO - Directory to install application into. [default: 14:34:48 INFO - "/builds/slave/test"] 14:34:48 INFO - --app=APP Application being installed. [default: firefox] 14:34:48 INFO - mkdir: /builds/slave/test/build/application 14:34:48 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:34:48 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:35:05 INFO - Reading from file tmpfile_stdout 14:35:05 INFO - Output received: 14:35:05 INFO - /builds/slave/test/build/application/firefox/firefox 14:35:05 INFO - Running post-action listener: _resource_record_post_action 14:35:05 INFO - [mozharness: 2016-08-23 21:35:05.441195Z] Finished install step (success) 14:35:05 INFO - [mozharness: 2016-08-23 21:35:05.441490Z] Running run-tests step. 14:35:05 INFO - Running pre-action listener: _resource_record_pre_action 14:35:05 INFO - Running main action method: run_tests 14:35:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:35:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:35:05 INFO - Python 2.7.3 14:35:05 INFO - Return code: 0 14:35:05 INFO - grabbing minidump binary from tooltool 14:35:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:05 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 0x1689370>, '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 0x168c8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x168cd80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:35:05 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:35:05 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:35:05 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:35:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:35:05 INFO - Return code: 0 14:35:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:35:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:35:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:35:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:35:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:35:05 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-045', '--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:35:05 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-045 --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:35:05 INFO - Using env: {'DISPLAY': ':0', 14:35:05 INFO - 'HOME': '/home/cltbld', 14:35:05 INFO - 'LANG': 'en_US.UTF-8', 14:35:05 INFO - 'LANGUAGE': 'en_US:en', 14:35:05 INFO - 'LOGNAME': 'cltbld', 14:35:05 INFO - 'MAIL': '/var/mail/cltbld', 14:35:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:35:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:35:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:05 INFO - 'MOZ_NO_REMOTE': '1', 14:35:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:35:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:35:05 INFO - 'NO_EM_RESTART': '1', 14:35:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:35:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:05 INFO - 'PWD': '/builds/slave/test', 14:35:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:35:05 INFO - 'SHELL': '/bin/bash', 14:35:05 INFO - 'SHLVL': '1', 14:35:05 INFO - 'TERM': 'linux', 14:35:05 INFO - 'TMOUT': '86400', 14:35:05 INFO - 'USER': 'cltbld', 14:35:05 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1471988049.319340-2108220558', 14:35:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:05 INFO - '_': '/tools/buildbot/bin/python'} 14:35:05 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-045', '--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:35:05 INFO - mozversion application_buildid: 20160823113035 14:35:05 INFO - mozversion application_changeset: 6e17a469a1b137c535adee7e476f86ee9dfcc071 14:35:05 INFO - mozversion application_display_name: Nightly 14:35:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:35:05 INFO - mozversion application_name: Firefox 14:35:05 INFO - mozversion application_remotingname: firefox 14:35:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:35:05 INFO - mozversion application_vendor: Mozilla 14:35:05 INFO - mozversion application_version: 51.0a1 14:35:05 INFO - mozversion platform_buildid: 20160823113035 14:35:05 INFO - mozversion platform_changeset: 6e17a469a1b137c535adee7e476f86ee9dfcc071 14:35:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:35:05 INFO - mozversion platform_version: 51.0a1 14:35:05 INFO - using testdate: 1471988105 14:35:05 INFO - actual date: 1471988105 14:35:05 INFO - starting webserver on 'localhost:41948' 14:35:05 INFO - SUITE-START | Running 2 tests 14:35:05 INFO - TEST-START | dromaeo_css 14:35:05 INFO - operating with platform_type : linux_ 14:35:05 INFO - Initialising browser for dromaeo_css test... 14:35:05 INFO - TEST-INFO | started process 5046 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF8SSFt/profile http://localhost:41948/getInfo.html) 14:35:11 INFO - PROCESS | 5046 | __metrics Screen width/height:1600/1200 14:35:11 INFO - PROCESS | 5046 | colorDepth:24 14:35:11 INFO - PROCESS | 5046 | Browser inner width/height: 1024/697 14:35:11 INFO - PROCESS | 5046 | __metrics 14:35:11 INFO - PROCESS | 5046 | 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:35:11 INFO - PROCESS | 5046 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:35:12 INFO - PROCESS | 5046 | console.error: PushService: 14:35:12 INFO - PROCESS | 5046 | stateChangeProcessEnqueue: Error transitioning state 14:35:12 INFO - PROCESS | 5046 | UnknownError 14:35:13 INFO - TEST-INFO | 5046: exit 0 14:35:13 INFO - Browser initialized. 14:35:13 INFO - Running cycle 1/1 for dromaeo_css test... 14:35:13 INFO - TEST-INFO | started process 5126 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF8SSFt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:35:25 INFO - PROCESS | 5126 | RSS: Main: 184496128 14:35:25 INFO - PROCESS | 5126 | 14:36:16 INFO - PROCESS | 5126 | 1471988176809 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:38:26 INFO - PROCESS | 5126 | Cycle 1(1): loaded http://localhost:41948/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41948/tests/dromaeo/cssquery-ext.html) 14:38:27 INFO - PROCESS | 5126 | RSS: Main: 312741888 14:38:27 INFO - PROCESS | 5126 | 14:41:30 INFO - PROCESS | 5126 | Cycle 1(1): loaded http://localhost:41948/tests/dromaeo/cssquery-ext.html (next: http://localhost:41948/tests/dromaeo/cssquery-jquery.html) 14:41:31 INFO - PROCESS | 5126 | RSS: Main: 275611648 14:41:31 INFO - PROCESS | 5126 | 14:44:33 INFO - PROCESS | 5126 | Cycle 1(1): loaded http://localhost:41948/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41948/tests/dromaeo/cssquery-mootools.html) 14:44:33 INFO - PROCESS | 5126 | RSS: Main: 248954880 14:44:33 INFO - PROCESS | 5126 | 14:47:35 INFO - PROCESS | 5126 | Cycle 1(1): loaded http://localhost:41948/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41948/tests/dromaeo/cssquery-prototype.html) 14:47:36 INFO - PROCESS | 5126 | RSS: Main: 277577728 14:47:36 INFO - PROCESS | 5126 | 14:50:39 INFO - PROCESS | 5126 | Cycle 1(1): loaded http://localhost:41948/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41948/tests/dromaeo/cssquery-yui.html) 14:50:40 INFO - PROCESS | 5126 | RSS: Main: 220131328 14:50:40 INFO - PROCESS | 5126 | 14:53:43 INFO - PROCESS | 5126 | Cycle 1(1): loaded http://localhost:41948/tests/dromaeo/cssquery-yui.html (next: http://localhost:41948/tests/dromaeo/cssquery-dojo.html) 14:53:43 INFO - PROCESS | 5126 | RSS: Main: 311975936 14:53:43 INFO - PROCESS | 5126 | 14:53:43 INFO - PROCESS | 5126 | __start_tp_report 14:53:43 INFO - PROCESS | 5126 | _x_x_mozilla_page_load 14:53:43 INFO - PROCESS | 5126 | _x_x_mozilla_page_load_details 14:53:43 INFO - PROCESS | 5126 | |i|pagename|runs| 14:53:43 INFO - PROCESS | 5126 | |0;dojo.html;2979.150941981535;2989.402119576085;2997.2057404787734;3022.6826183250746;3060.1431599152247;5167.534921857032;5188.974055129724;5276.445973172815;5282.471752824716;5285.127953887609;5292.364916210051;5294.047071527124;5329.094054010818;5329.653572517784;5417.810376636819;4870.683405578644;4906.4112306523175;4940.481249468808;4942.382202224722;4946.5795407390415;4868.951310486903;4882.414110306768;4903.190973489388;4909.263610458442;4960.0823847588135;4967.602591792648;5000.774965126578;5025.572826309768;5032.7735251913755;5035.446100928895;4888.217885138396;4923.606111511089;4925.704457732548;4949.62877784164;4956.90086198274;4752.95247047532;4802.2316429371485;4808.855734327941;4812.903741925177;4849.151398505247;5186.740662966837;5223.71269580173;5250.474952504757;5251.52736253739;5257.7896884124975;5667.121596152603;5667.433256674341;5670.858228544278;5679.460451257124;5699.2306038684665;5557.138643510222;5650.3219613646215;5710.371859095538;5713.628614140109;5796.710164491758;5326.520613144836;5338.172583249602;5344.171653393731;5351.277577527062;5359.866003349869;5883.205767221456;5890.410958904075;5891;5893.381194974551;5895.911561326584;5503.091989821714;5555.055640541118;5594.468525490153;5594.496495315359;5689.6586204827845;5693;5698.17376480408;5698.487136157766;5699.487046165865;5706.029974904276;5662.178984047372;5662.2639056922335;5679.914801277984;5688.516476099578;5688.857778555569;5494.423085576037;5526.668399895939;5612.35457922336;5613.8596535086135;5648.717564121777;4392.560743925582;4398.670099742532;4434.711743736647;4449.2658711312915;4452.643788496913;3895.8052097395016;3918.4318273850704;3934.213157368538;3941.2511622791576;3945.8027098645525;5299.6290259681455;5432.538234250133;5453.672779633234;5495.368032676293;5509.090999985037;5742.339630942495;5811.4479124483105;5826.941730582725;5830.62100963436;5842.561807864342;5438.972805135949;5456;5456.536194423518;5457.126859702428;5457.208704737791;4818.566329030404;4997.85006449807;5007.098722229961;5014.573761230264;5077.847664570068;5933.406659334119;5962.0758782387065;5975.790847320323;6020.247469066367;6049.667268300285;5664;5700.486956173964;5715.114157305624;5729.4843464088435;5739.2252045973255;5720.456556627114;5900.350961394157;5939;5957;5966.701664916824;5604.131359639263;5606.635568688022;5620.803271885465;5659.151127330933;5724.742386592697;5725.770969161187;5751.654900705804;5755.597108202385;5755.625884317506;5761.395053519488;5411.756470958738;5601.691906945157;5601.971990140023;5617.662940223436;5636.577256705681;5533.446655334596;5567.777288908398;5568.359638641608;5605.915911261416;5665.773369065356;5476.2607048049595;5519.834404967857;5524;5530.446955304598;5531.197976293495;5469.206964989975;5654.293213348332;5677.034904066236;5680.261565996394;5684.3747187808485;5310.787568497217;5440.537554307928;5468.863278418072;5471.616986811045;5552.139418390156 14:53:43 INFO - PROCESS | 5126 | |1;ext.html;551.1292158389743;587.2952457051537;588.9911651325231;617.1298469158487;637.5760119520519;32509;35326.47010294848;35332.64667353326;35349.646503534954;35365.469517957215;35325;36258.368373423196;44084.338734919;45268.77365613176;45297.7735111324;8737.432066915662;8891.73324800257;8898.955505222497;8914.777130571723;8914.777130571723;8761.123887611251;8827.602757875911;8830.381873268874;8839.16027977341;8867.68963086292;8010.319122874563;8866.778330541723;10396.532156052957;10670.253082284244;10670.51982660782;10601.84097238542;10666.893331066745;10681.359118452918;10695.197860160519;10708;10514.264001519896;10594.099501542378;10595.470226488645;10596.41719705416;10604.04563589273;41827.1634567307;42077;42125.57874421247;42141.36787948183;42250.78874605638;2929.6630887448005;2973.851307434641;2987.074007057819;3043.193553708269;3044.710752478511;31116;31727.682723172704;31983.200419989455;32083.679163208304;33323.83395079312;3636.181859081712;3719.256148770257;3766.0584853786554;3782.56500502443;3847.903802404934;240774;242487.78756106284;243174;243306;244123;58867.41132588705;59243.99999999914;59331.703341483015;59341;59443.702781485816;36051.63948360483;37034;37091;62796;62986.37013629897;13373.933130334286;13508.932455337661;13512.662183445493;13515.729685406237;13516.391762370717;10010.099091081693;10060.849087263698;10095.798084038424;10186.03232692893;10201.132903703268;18445.169967351503;18461.630767384577;18473;18523;18617.162227699788;5736.282964629421;6828.419584335288;6860.554063985925;7136.357727804522;7292.45306602007;1020.9183265338755;1043.2071625564627;1066.586921850083;1113.0872684398878;1154.3131836557236;29968.95108671186;30913.381732365677;31208.531872021937;31328.686713133033;31811.840940795148;1050.5640159333943;1069.3049517813483;1101.2676570080966;1118.9664310070712;1124.8087825069758;15895.68208635844;16863.325466981183;16905.7464138038;16951.152442377832;16951.377802974694;574717;580180;580529;581729;584581;58612.7069364659;59271.40728592659;59275.407245927854;59325.40674593285;59336;1215.914885957992;1281.9743605127844;1320.0891384944357;1328.5084518728133;1328.7608230518406;29269;31806.84096579502;33026.33947320992;33355.666443335256;33877.66122338844;50636.74681626568;51540.48459515357;51655.22517162171;51691;51767.482325176265;480476;487973;490533;490556.1888762276;492651;38185.80907095447;38508.22983540258;38721.80639096787;43607.78196108999;44671.55328446674;35632.28735425329;48348.51651483581;48738;48889.511104888494;52305.21542176794;40300;41038.38442423306;41554.168916620896;42114.1577168461;43019.35470968;41591;41910.37134442925;41942.790286048374;41974.58025419707;42354.78822605867;41716.165676686905;41851.23338899513;43403.348949765146;44463.33305000492;44623;35287;36872.63127368692;37386.252274954895;37878.431823522114;38517;28046.268895464535;28499.715002849705;28504;28608.284792880346;28717.425651487272 14:53:43 INFO - PROCESS | 5126 | |2;jquery.html;391.2956677979636;393.97636141831475;402.9677625789937;406.55076140864344;416.6208750037467;13319.866801331984;18541.62916741666;19937;20296.492587685316;20322.491937701565;15646.608834779136;16110.919445402757;16165.83834161658;16370.672586548262;16467.423640172598;5721.485066344038;5940.554458415614;5946.405359464041;5949;5955;5699.943000569982;5850.707464626773;5862.384449632791;5899.351071382144;5902.114682797594;5807;5877.588568800185;5880.941190588103;5883.47048765611;5883.47048765611;5608.85977850557;5768.365479797261;5827.125931110325;5862.706864656771;5870.324912635037;5192;5198.090334191501;5198.090334191501;5198.480151984809;5201.219817027476;23154;23502.412439689146;23934.401639959142;24394.14620488292;24549.38626534333;2117.93646190613;2365.491419344832;2477.380654836291;2478.938026549333;2991.7307442330293;13958.511452099128;15179.241037948059;15369.846301536953;15771.921140394224;15778.76331855023;1920.932767353136;1966.3117908731972;1997.2809788476136;2034.6947957806299;2091.7280753501946;80535.59732201361;81229.9999999994;82750;83160;84329;10824.296420732628;10844.258730737884;10970.725731856768;11047.72380690473;11289.60486382989;15649.217539122998;15671;15686.843131568767;15694;15697.293621787047;7467.850642987219;7570;7577.772666820004;7775.844483110306;7793.493422927491;6842.315768423118;6983.720651173896;7078.071670222973;7079.2920707929825;7158.785236442915;6085.482733967574;6361.968190159019;6569.9343006569325;6735;6743.561668491532;1939.8448124150316;1955.1495099631707;1960.578475627747;1995.9501012474805;2007.8755896697603;872.341382256405;1016.6340117557673;1043.1811028342715;1098.2696506823033;1101.658485869383;19160;19501;19570.21719131219;19790;20332.288369906983;964.1370972979284;992.4987881120132;1021.1677482851452;1034.343192073039;1065.8934106589434;11021.338719676845;11507.76984460306;11734.354610496333;11754.35351055683;11784.76430471403;527462;533966;550415;559410;560599;80219.59890200512;81765;82013;82722;84937;911.6353458616474;912.8402529557434;925.1349987761464;925.3522534226069;942.7454587261539;16543.25555349988;16793.832061679226;17228.655426891644;17620.383286584907;17895.642087158445;39152.412713809885;39664.80167599259;40911.7954410226;41443;42288.577114228465;52897;53168.734156328974;53283.46716532785;56032;56257.43742562686;7923.247291507298;8520.786980325542;8642;8664.306855451423;8834.646614135363;9961.750956226153;12884.742305154032;13193.142445740996;13443.529476468277;13729;11393.202475826612;11635.592754253561;11964.521419143137;12018.819717704417;12354.938225308815;11381.146414019147;11718.589849355232;11905.464254108412;12144.453499592717;12364.938175309066;6884.8967265490055;11545.826812597987;11894.226875253082;11972.521099155936;12248.510059597873;8703.303735701254;8806.471611703319;8874.911250887408;9259.907400926175;9285.582148803454;8480.660773568989;11395.127208498183;11970.162088653711;12005.279683219034;12258.877411225774 14:53:43 INFO - PROCESS | 5126 | |3;mootools.html;1290.406413049997;1355.4036224061413;1360.9183448993067;1396.225095072235;1750.107445202947;8006.55963921984;8362.540060296682;8410.201030902062;8579.44233624814;8603.354748393864;8723.781905452366;8733.083026282244;8772.561371931393;8793.472391656489;8841.115888411156;2089.300084471704;2394.580948334039;2422.9394265143337;2425.1027119965547;2426.502566973766;2405.675233843426;2469.394998225437;2487.465194983078;2489.3900994256433;2494.787943024845;2379.2505360811374;2388.653645221442;2388.9641655375094;2399.3521749127726;2406.362313986795;2348.7768661977084;2421.1889017179265;2429.2105065853666;2429.829911906176;2429.9514009719705;2410.4696966667307;2442.7312995570474;2446.7675570820743;2450.4608986023045;2452.4359397338535;8895.644174233023;8952.8657070144;8960.731178064669;8967.686130985385;8974.102589741038;4692.6245900327895;4825.589824864891;4829.1790395632825;4833.10587541306;4836.395450568679;3295.7857739246874;3374.9325013499592;3554.1647712787476;3563.6614521620404;3564.946525802115;1178.4755783676267;1195.0678470792795;1223.1254652923114;1242.9875701243052;1264.5890085722085;12404.56584019564;12432.067594930417;12442;12452;12528.74942501154;4476.35092911526;4554.772261386917;4710.576048155683;4771.66598338113;4774.641901857305;9414.576344064533;9415.340926135243;9425.90574094264;9426.245900327956;9426.905730942603;5001.274815151855;5006.424261209934;5006.849794506171;5011.949880501221;5012.899742005139;3973.205358928226;4452.621527170162;4689.648276379286;4692.41344831896;4692.929606055912;3763.34141525232;3807.904802379963;3914.8629797956933;3942.3692209246383;4000.219957108336;1173.5716463490935;1200.8558972923306;1204.644629834201;1208.4984731336572;1215.3619349841404;822.658596682382;896.8071864549154;934.7756538430864;942.3686130292721;966.2559828931684;5635.492805647511;5850.23946886902;5886.411358864165;5927.555433342516;5928.4960778334325;454.3548161610521;462.2702939144358;468.8405941979743;475.30842623982716;486.8612445453029;3803.3344164771056;3805.8858234253016;3849.922021833891;3872.1094148345474;3917.666998305119;10690.251682382313;10955.397453139994;11097.1122310215;11168.162387820947;11170.664880053611;11052.668419947415;11059.170562207706;11064.557417703363;11077.944610277058;11131.610393636183;8254.463459875209;8272.37957153216;8274;8278.793030174294;8317.916820831835;5700.346899399128;5720.342160651412;5827.7179020615395;5889.5582831286965;5941.168236446987;10108.191344692259;10146.746331341776;10155.593776248867;10184.847227291744;10202.438865862152;9861.704148875546;10188.337758045704;10198.643047493302;10495.842562361418;10517;6757.3242675734;7239.927600723925;7319.34125928669;7348.706051758084;7383.630818459163;8423.4945903246;8621;8735.43219690718;8757.824843503222;8773.868391974253;7517.548947063194;7661.195574464601;7692.499987500794;7726.111497177896;7875.448718589644;7313;7688.077430708351;7745.22547745221;7819.452638315263;7976.960115199619;6767.35710107539;6895.724171033103;6898.724051037902;6920.100386949664;6920.134983127109;5126.487351264844;5185.299984502044;5217.399999000164;5249.763760630704;5392.676439413648;5207.3230480037355;5224.216367544898;5270;5295.7087360195555;5429.782808687608 14:53:43 INFO - PROCESS | 5126 | |4;prototype.html;329.1901921273667;331.9883804066857;333.9682730140636;344.38871003967955;349.51243015992685;5118.9488105118935;5193.143770925985;5211.7133557654315;5250.107481728106;5303.4431384704585;5117.437081920985;5157.174852023677;5162.845114646567;5166.844994650157;5191.896162076756;4104.897377565562;4108.342665173573;4109;4120.896977575555;4150.547308442036;3857.3635350167187;3948.9210215795665;4089.325261331877;4109.116539943911;4130.13267213884;4076.449679293302;4081.530623978251;4097.242010228102;4098.7950602469755;4122.649574786146;4076.30702780528;4089.26393249215;4101.118259574191;4103.363978583295;4137.668986481074;3415.7267418606452;3512.8594856205723;3567.250877315741;3582.22982058856;3606.4049431843714;4986;4992.600591952635;4997.875053123665;5017.724025178613;5030.195168772979;4581.770911454414;4594.196015697273;4594.793234304464;4612.76936153191;4655.114678555191;5284.128118860383;5320.654157479751;5349.117395629716;5368.35579730431;5378.731063446851;3918.8432462701458;3934.8426062957446;3936.563154448634;3936.566977632458;3942.4874766280486;5590.301212348457;5623.9437605623825;5651.5761317900915;5681.460261275172;5685.744141513642;3936.8622098226424;3999.7800120993625;4053.5338436079637;4055.4525139105845;4079.449274347925;4114.403411505375;4117.3206420940205;4119.361498967664;4122.42286079949;4123.484564429446;4712.363830882856;4724.291356296514;4731.361266229083;4733.195356789354;4737.881552961204;5351.86620334487;5371.248025276464;5393.2449457076045;5459.563234941195;5503.7066289422755;1396.818413606245;1405.4448492845472;1407.3526177958254;1414.561485939362;1425.1520345394474;889.9555022248861;913.5934509143367;925.3106435705442;934.2292608597799;938.9436883506056;4633.837815676435;4676.415448068991;4684.227102528044;4709.976450117796;5021.6735912165595;5398.1362981923485;5433.103537916279;5455.208994695747;5479.123340265618;5546.27898373217;5258.8159414420315;5261.553682338074;5288.365396152486;5292.497212764782;5299.417064122943;2823.759980401689;2890.869910854017;2928.531434970437;2945.4683564546317;2971.1680729395803;5748.856278593069;5755.215883076176;5755.453231942959;5762.798302059407;5780;5665.6968897153065;5674.943250567524;5674.9501342251815;5690.4025077367105;5691.971540142273;5515.641483303652;5737.99585072619;5745.052066408995;5782.479576838021;5808.5062769665055;5589.580781441489;5603.635763675348;5604.8318550443555;5608.10270356741;5619.353774316006;5273.815416460406;5524.889502209853;5526.005319042611;5543.334799824047;5588;5721.971390143022;5744.195812586157;5806.303243610793;5833.649981001154;5869.970650146722;4076.7553946763287;4079.755214687128;4126.66986641062;4134.441850350285;4135.875923722293;5326.866828329323;5602.663840169603;5638.943610564006;5673.290838645169;5685.857853553694;5413.512783849473;5463.754131064191;5469.699166545878;5477.643953143033;5490.423505532021;5418.512333889968;5438.510534051954;5450.209719590716;5464.98897703926;5467.617266791286;5174.301469301596;5319.840404787863;5382.219578161066;5388.299521062237;5407.242985981887;5455.690634247831;5459.836204913859;5482.437505310967;5483.479069488392;5494.532964698045;5118.590512759045;5171.405288391883;5355.25026496283;5359.222912677717;5372.301600791872 14:53:43 INFO - PROCESS | 5126 | |5;yui.html;646.8706258748251;653.3727621483375;654.4894981914106;710.545251039335;744.8212429017037;14348.64128396788;14476.276186190687;15026.17356045417;15047.02194357366;15098.245087745623;13600.523981660644;13693.17840929545;13706.383212755425;13729.382177801997;13759.93120034401;784.8626490364192;808.5189312359137;811.9106898241189;812.2202685421972;812.8130529978108;667.6594936582354;784.8194915169514;791.1811275330006;802.5866678660494;810.5217921426357;849.0957130655862;853.8804567360575;853.9402241843073;854.2738672128672;854.3805740837905;840.1640367834044;848.088305072047;850.3027517435705;850.6724910909313;851.6550796927254;502.5878779400856;593.7268856326095;596.2219303808528;605.4823126227101;619.3837132053591;12881.806772898413;12914.483420663162;12946.611601651966;12954.935225323907;12996.090273680846;13887.513937012156;14448;14514.70970580593;14591.635209119751;15002.324895379734;12301.876981230163;12309.56916507918;12362.876371236262;12382.380880956007;12413.131080824345;4469.597736203725;4488.41650585425;4514.751688657123;4540.091981603659;4659.404186237599;85448.14551854464;85798.14201858027;87808;88191;89121;10622.840657390145;11160.16298777595;11364.715882103013;11401.657950261506;11514.596989105341;23419.180328688755;23479.530409391715;23495.295141145794;23508.764912351;23610.88194559016;8530.317574594017;8649.91350086491;8779.165979231962;8928.464292142493;9009.873765779277;4748.335233067373;4781.808727650925;4787.257975013878;4791.329213910055;4863.224922903115;3372.3929692655556;3456.6197718250974;3462.4113900636953;3482.7736197147105;3500.789952602852;509.19292920720335;518.3365292425701;523.0584947095214;551.401729123905;556.5325126893348;502.49248259257683;536.948989845964;588.352811906899;594.6194435561245;599.6821684507219;9051.683191088281;9054.456732596065;9194.218491428304;9256.352055356061;9261.583228754722;596.4572239262251;599.2120361724319;601.7382438639206;608.9786857459968;609.7347653770536;3867.323218436762;4260.808263628082;4264.147170565837;4606.7673752209375;4901.975490122598;68151.3184868155;68169.31830681629;68395.65802170958;98955;99995.50002250087;105671;107905;108307.45846270719;108680;110721;94696;95169;96239;102860;104793.47603261935;9355.906440935503;9588.856167157637;9750.21998240125;9808.16630586408;9819;44775.77612111918;52558.21162682639;52802.73598632136;52949;54438.45561544334;49353;49813.750931245115;56701.716491417275;81285.59357203176;82637.58681206555;11307.434628268718;11326.603568875049;11480.540778368771;11533.82699259495;12168.391580420766;13539.187648740713;14101.929490352482;14254.857451425767;14539.85460145385;15149.318280677617;9304.395214311047;13031.934840325737;13398.397072131582;13412.12821166621;13617.931910340782;12167.33079680626;12171.878281217074;12287.324197168884;12397.93801030989;12866.356682165668;12442.688932776753;12575;13144.40850161726;13470.124441911245;13473.932630336785;10089;10110;10486.265961382935;11168.553257869595;11276.379799111128;9848.803023939337;10603.151747860307;10626.8405973912;10690.465476726287;10702.571897124339 14:53:43 INFO - PROCESS | 5126 | __end_tp_report 14:53:43 INFO - PROCESS | 5126 | __start_cc_report 14:53:43 INFO - PROCESS | 5126 | _x_x_mozilla_cycle_collect,1089 14:53:43 INFO - PROCESS | 5126 | __end_cc_report 14:53:43 INFO - PROCESS | 5126 | __startTimestamp1471989223441__endTimestamp 14:53:43 INFO - PROCESS | 5126 | 14:53:43 INFO - PROCESS | 5126 | ------- Summary: start ------- 14:53:43 INFO - PROCESS | 5126 | Number of tests: 6 14:53:43 INFO - PROCESS | 5126 | 14:53:43 INFO - PROCESS | 5126 | [#0] dojo.html Cycles:165 Average:5312.55 Median:5503.09 stddev:602.35 (10.9%) stddev-sans-first:575.71 14:53:43 INFO - PROCESS | 5126 | Values: 2979.2 2989.4 2997.2 3022.7 3060.1 5167.5 5189.0 5276.4 5282.5 5285.1 5292.4 5294.0 5329.1 5329.7 5417.8 4870.7 4906.4 4940.5 4942.4 4946.6 4869.0 4882.4 4903.2 4909.3 4960.1 4967.6 5000.8 5025.6 5032.8 5035.4 4888.2 4923.6 4925.7 4949.6 4956.9 4753.0 4802.2 4808.9 4812.9 4849.2 5186.7 5223.7 5250.5 5251.5 5257.8 5667.1 5667.4 5670.9 5679.5 5699.2 5557.1 5650.3 5710.4 5713.6 5796.7 5326.5 5338.2 5344.2 5351.3 5359.9 5883.2 5890.4 5891.0 5893.4 5895.9 5503.1 5555.1 5594.5 5594.5 5689.7 5693.0 5698.2 5698.5 5699.5 5706.0 5662.2 5662.3 5679.9 5688.5 5688.9 5494.4 5526.7 5612.4 5613.9 5648.7 4392.6 4398.7 4434.7 4449.3 4452.6 3895.8 3918.4 3934.2 3941.3 3945.8 5299.6 5432.5 5453.7 5495.4 5509.1 5742.3 5811.4 5826.9 5830.6 5842.6 5439.0 5456.0 5456.5 5457.1 5457.2 4818.6 4997.9 5007.1 5014.6 5077.8 5933.4 5962.1 5975.8 6020.2 6049.7 5664.0 5700.5 5715.1 5729.5 5739.2 5720.5 5900.4 5939.0 5957.0 5966.7 5604.1 5606.6 5620.8 5659.2 5724.7 5725.8 5751.7 5755.6 5755.6 5761.4 5411.8 5601.7 5602.0 5617.7 5636.6 5533.4 5567.8 5568.4 5605.9 5665.8 5476.3 5519.8 5524.0 5530.4 5531.2 5469.2 5654.3 5677.0 5680.3 5684.4 5310.8 5440.5 5468.9 5471.6 5552.1 14:53:43 INFO - PROCESS | 5126 | 14:53:43 INFO - PROCESS | 5126 | [#1] ext.html Cycles:180 Average:59641.90 Median:37062.50 stddev:122699.74 (331.1%) stddev-sans-first:122963.74 14:53:43 INFO - PROCESS | 5126 | Values: 551.1 587.3 589.0 617.1 637.6 32509.0 35326.5 35332.6 35349.6 35365.5 35325.0 36258.4 44084.3 45268.8 45297.8 8737.4 8891.7 8899.0 8914.8 8914.8 8761.1 8827.6 8830.4 8839.2 8867.7 8010.3 8866.8 10396.5 10670.3 10670.5 10601.8 10666.9 10681.4 10695.2 10708.0 10514.3 10594.1 10595.5 10596.4 10604.0 41827.2 42077.0 42125.6 42141.4 42250.8 2929.7 2973.9 2987.1 3043.2 3044.7 31116.0 31727.7 31983.2 32083.7 33323.8 3636.2 3719.3 3766.1 3782.6 3847.9 240774.0 242487.8 243174.0 243306.0 244123.0 58867.4 59244.0 59331.7 59341.0 59443.7 36051.6 37034.0 37091.0 62796.0 62986.4 13373.9 13508.9 13512.7 13515.7 13516.4 10010.1 10060.8 10095.8 10186.0 10201.1 18445.2 18461.6 18473.0 18523.0 18617.2 5736.3 6828.4 6860.6 7136.4 7292.5 1020.9 1043.2 1066.6 1113.1 1154.3 29969.0 30913.4 31208.5 31328.7 31811.8 1050.6 1069.3 1101.3 1119.0 1124.8 15895.7 16863.3 16905.7 16951.2 16951.4 574717.0 580180.0 580529.0 581729.0 584581.0 58612.7 59271.4 59275.4 59325.4 59336.0 1215.9 1282.0 1320.1 1328.5 1328.8 29269.0 31806.8 33026.3 33355.7 33877.7 50636.7 51540.5 51655.2 51691.0 51767.5 480476.0 487973.0 490533.0 490556.2 492651.0 38185.8 38508.2 38721.8 43607.8 44671.6 35632.3 48348.5 48738.0 48889.5 52305.2 40300.0 41038.4 41554.2 42114.2 43019.4 41591.0 41910.4 41942.8 41974.6 42354.8 41716.2 41851.2 43403.3 44463.3 44623.0 35287.0 36872.6 37386.3 37878.4 38517.0 28046.3 28499.7 28504.0 28608.3 28717.4 14:53:43 INFO - PROCESS | 5126 | 14:53:43 INFO - PROCESS | 5126 | [#2] jquery.html Cycles:180 Average:30295.62 Median:19773.19 stddev:89633.07 (453.3%) stddev-sans-first:89856.39 14:53:43 INFO - PROCESS | 5126 | Values: 391.3 394.0 403.0 406.6 416.6 13319.9 18541.6 19937.0 20296.5 20322.5 15646.6 16110.9 16165.8 16370.7 16467.4 5721.5 5940.6 5946.4 5949.0 5955.0 5699.9 5850.7 5862.4 5899.4 5902.1 5807.0 5877.6 5880.9 5883.5 5883.5 5608.9 5768.4 5827.1 5862.7 5870.3 5192.0 5198.1 5198.1 5198.5 5201.2 23154.0 23502.4 23934.4 24394.1 24549.4 2117.9 2365.5 2477.4 2478.9 2991.7 13958.5 15179.2 15369.8 15771.9 15778.8 1920.9 1966.3 1997.3 2034.7 2091.7 80535.6 81230.0 82750.0 83160.0 84329.0 10824.3 10844.3 10970.7 11047.7 11289.6 15649.2 15671.0 15686.8 15694.0 15697.3 7467.9 7570.0 7577.8 7775.8 7793.5 6842.3 6983.7 7078.1 7079.3 7158.8 6085.5 6362.0 6569.9 6735.0 6743.6 1939.8 1955.1 1960.6 1996.0 2007.9 872.3 1016.6 1043.2 1098.3 1101.7 19160.0 19501.0 19570.2 19790.0 20332.3 964.1 992.5 1021.2 1034.3 1065.9 11021.3 11507.8 11734.4 11754.4 11784.8 527462.0 533966.0 550415.0 559410.0 560599.0 80219.6 81765.0 82013.0 82722.0 84937.0 911.6 912.8 925.1 925.4 942.7 16543.3 16793.8 17228.7 17620.4 17895.6 39152.4 39664.8 40911.8 41443.0 42288.6 52897.0 53168.7 53283.5 56032.0 56257.4 7923.2 8520.8 8642.0 8664.3 8834.6 9961.8 12884.7 13193.1 13443.5 13729.0 11393.2 11635.6 11964.5 12018.8 12354.9 11381.1 11718.6 11905.5 12144.5 12364.9 6884.9 11545.8 11894.2 11972.5 12248.5 8703.3 8806.5 8874.9 9259.9 9285.6 8480.7 11395.1 11970.2 12005.3 12258.9 14:53:43 INFO - PROCESS | 5126 | 14:53:43 INFO - PROCESS | 5126 | [#3] mootools.html Cycles:180 Average:5738.50 Median:2592.94 stddev:3303.88 (127.4%) stddev-sans-first:3296.24 14:53:43 INFO - PROCESS | 5126 | Values: 1290.4 1355.4 1360.9 1396.2 1750.1 8006.6 8362.5 8410.2 8579.4 8603.4 8723.8 8733.1 8772.6 8793.5 8841.1 2089.3 2394.6 2422.9 2425.1 2426.5 2405.7 2469.4 2487.5 2489.4 2494.8 2379.3 2388.7 2389.0 2399.4 2406.4 2348.8 2421.2 2429.2 2429.8 2430.0 2410.5 2442.7 2446.8 2450.5 2452.4 8895.6 8952.9 8960.7 8967.7 8974.1 4692.6 4825.6 4829.2 4833.1 4836.4 3295.8 3374.9 3554.2 3563.7 3564.9 1178.5 1195.1 1223.1 1243.0 1264.6 12404.6 12432.1 12442.0 12452.0 12528.7 4476.4 4554.8 4710.6 4771.7 4774.6 9414.6 9415.3 9425.9 9426.2 9426.9 5001.3 5006.4 5006.8 5011.9 5012.9 3973.2 4452.6 4689.6 4692.4 4692.9 3763.3 3807.9 3914.9 3942.4 4000.2 1173.6 1200.9 1204.6 1208.5 1215.4 822.7 896.8 934.8 942.4 966.3 5635.5 5850.2 5886.4 5927.6 5928.5 454.4 462.3 468.8 475.3 486.9 3803.3 3805.9 3849.9 3872.1 3917.7 10690.3 10955.4 11097.1 11168.2 11170.7 11052.7 11059.2 11064.6 11077.9 11131.6 8254.5 8272.4 8274.0 8278.8 8317.9 5700.3 5720.3 5827.7 5889.6 5941.2 10108.2 10146.7 10155.6 10184.8 10202.4 9861.7 10188.3 10198.6 10495.8 10517.0 6757.3 7239.9 7319.3 7348.7 7383.6 8423.5 8621.0 8735.4 8757.8 8773.9 7517.5 7661.2 7692.5 7726.1 7875.4 7313.0 7688.1 7745.2 7819.5 7977.0 6767.4 6895.7 6898.7 6920.1 6920.1 5126.5 5185.3 5217.4 5249.8 5392.7 5207.3 5224.2 5270.0 5295.7 5429.8 14:53:43 INFO - PROCESS | 5126 | 14:53:43 INFO - PROCESS | 5126 | [#4] prototype.html Cycles:180 Average:4580.14 Median:5230.91 stddev:1335.76 (25.5%) stddev-sans-first:1300.85 14:53:43 INFO - PROCESS | 5126 | Values: 329.2 332.0 334.0 344.4 349.5 5118.9 5193.1 5211.7 5250.1 5303.4 5117.4 5157.2 5162.8 5166.8 5191.9 4104.9 4108.3 4109.0 4120.9 4150.5 3857.4 3948.9 4089.3 4109.1 4130.1 4076.4 4081.5 4097.2 4098.8 4122.6 4076.3 4089.3 4101.1 4103.4 4137.7 3415.7 3512.9 3567.3 3582.2 3606.4 4986.0 4992.6 4997.9 5017.7 5030.2 4581.8 4594.2 4594.8 4612.8 4655.1 5284.1 5320.7 5349.1 5368.4 5378.7 3918.8 3934.8 3936.6 3936.6 3942.5 5590.3 5623.9 5651.6 5681.5 5685.7 3936.9 3999.8 4053.5 4055.5 4079.4 4114.4 4117.3 4119.4 4122.4 4123.5 4712.4 4724.3 4731.4 4733.2 4737.9 5351.9 5371.2 5393.2 5459.6 5503.7 1396.8 1405.4 1407.4 1414.6 1425.2 890.0 913.6 925.3 934.2 938.9 4633.8 4676.4 4684.2 4710.0 5021.7 5398.1 5433.1 5455.2 5479.1 5546.3 5258.8 5261.6 5288.4 5292.5 5299.4 2823.8 2890.9 2928.5 2945.5 2971.2 5748.9 5755.2 5755.5 5762.8 5780.0 5665.7 5674.9 5675.0 5690.4 5692.0 5515.6 5738.0 5745.1 5782.5 5808.5 5589.6 5603.6 5604.8 5608.1 5619.4 5273.8 5524.9 5526.0 5543.3 5588.0 5722.0 5744.2 5806.3 5833.6 5870.0 4076.8 4079.8 4126.7 4134.4 4135.9 5326.9 5602.7 5638.9 5673.3 5685.9 5413.5 5463.8 5469.7 5477.6 5490.4 5418.5 5438.5 5450.2 5465.0 5467.6 5174.3 5319.8 5382.2 5388.3 5407.2 5455.7 5459.8 5482.4 5483.5 5494.5 5118.6 5171.4 5355.3 5359.2 5372.3 14:53:43 INFO - PROCESS | 5126 | 14:53:43 INFO - PROCESS | 5126 | [#5] yui.html Cycles:180 Average:20262.25 Median:4765.07 stddev:29452.79 (618.1%) stddev-sans-first:29498.59 14:53:43 INFO - PROCESS | 5126 | Values: 646.9 653.4 654.5 710.5 744.8 14348.6 14476.3 15026.2 15047.0 15098.2 13600.5 13693.2 13706.4 13729.4 13759.9 784.9 808.5 811.9 812.2 812.8 667.7 784.8 791.2 802.6 810.5 849.1 853.9 853.9 854.3 854.4 840.2 848.1 850.3 850.7 851.7 502.6 593.7 596.2 605.5 619.4 12881.8 12914.5 12946.6 12954.9 12996.1 13887.5 14448.0 14514.7 14591.6 15002.3 12301.9 12309.6 12362.9 12382.4 12413.1 4469.6 4488.4 4514.8 4540.1 4659.4 85448.1 85798.1 87808.0 88191.0 89121.0 10622.8 11160.2 11364.7 11401.7 11514.6 23419.2 23479.5 23495.3 23508.8 23610.9 8530.3 8649.9 8779.2 8928.5 9009.9 4748.3 4781.8 4787.3 4791.3 4863.2 3372.4 3456.6 3462.4 3482.8 3500.8 509.2 518.3 523.1 551.4 556.5 502.5 536.9 588.4 594.6 599.7 9051.7 9054.5 9194.2 9256.4 9261.6 596.5 599.2 601.7 609.0 609.7 3867.3 4260.8 4264.1 4606.8 4902.0 68151.3 68169.3 68395.7 98955.0 99995.5 105671.0 107905.0 108307.5 108680.0 110721.0 94696.0 95169.0 96239.0 102860.0 104793.5 9355.9 9588.9 9750.2 9808.2 9819.0 44775.8 52558.2 52802.7 52949.0 54438.5 49353.0 49813.8 56701.7 81285.6 82637.6 11307.4 11326.6 11480.5 11533.8 12168.4 13539.2 14101.9 14254.9 14539.9 15149.3 9304.4 13031.9 13398.4 13412.1 13617.9 12167.3 12171.9 12287.3 12397.9 12866.4 12442.7 12575.0 13144.4 13470.1 13473.9 10089.0 10110.0 10486.3 11168.6 11276.4 9848.8 10603.2 10626.8 10690.5 10702.6 14:53:43 INFO - PROCESS | 5126 | -------- Summary: end -------- 14:53:43 INFO - PROCESS | 5126 | 14:53:44 INFO - TEST-INFO | 5126: exit 0 14:53:44 INFO - TEST-OK | dromaeo_css | took 1118681ms 14:53:44 INFO - TEST-START | kraken 14:53:44 INFO - operating with platform_type : linux_ 14:53:44 INFO - Initialising browser for kraken test... 14:53:44 INFO - TEST-INFO | started process 5435 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpogaLev/profile http://localhost:41948/getInfo.html) 14:53:48 INFO - PROCESS | 5435 | __metrics Screen width/height:1600/1200 14:53:48 INFO - PROCESS | 5435 | colorDepth:24 14:53:48 INFO - PROCESS | 5435 | Browser inner width/height: 1024/697 14:53:48 INFO - PROCESS | 5435 | __metrics 14:53:49 INFO - PROCESS | 5435 | 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:53:49 INFO - PROCESS | 5435 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:53:50 INFO - PROCESS | 5435 | console.error: PushService: 14:53:50 INFO - PROCESS | 5435 | stateChangeProcessEnqueue: Error transitioning state 14:53:50 INFO - PROCESS | 5435 | UnknownError 14:53:50 INFO - TEST-INFO | 5435: exit 0 14:53:50 INFO - Browser initialized. 14:53:50 INFO - Running cycle 1/1 for kraken test... 14:53:50 INFO - TEST-INFO | started process 5517 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpogaLev/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:54:02 INFO - PROCESS | 5517 | RSS: Main: 182128640 14:54:02 INFO - PROCESS | 5517 | 14:54:05 INFO - PROCESS | 5517 | Cycle 1(1): loaded http://localhost:41948/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41948/tests/kraken/driver.html?testName=audio-beat-detection) 14:54:06 INFO - PROCESS | 5517 | RSS: Main: 244330496 14:54:06 INFO - PROCESS | 5517 | 14:54:08 INFO - PROCESS | 5517 | Cycle 1(1): loaded http://localhost:41948/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41948/tests/kraken/driver.html?testName=audio-dft) 14:54:09 INFO - PROCESS | 5517 | RSS: Main: 225415168 14:54:09 INFO - PROCESS | 5517 | 14:54:12 INFO - PROCESS | 5517 | Cycle 1(1): loaded http://localhost:41948/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41948/tests/kraken/driver.html?testName=audio-fft) 14:54:13 INFO - PROCESS | 5517 | RSS: Main: 304373760 14:54:13 INFO - PROCESS | 5517 | 14:54:15 INFO - PROCESS | 5517 | Cycle 1(1): loaded http://localhost:41948/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41948/tests/kraken/driver.html?testName=audio-oscillator) 14:54:16 INFO - PROCESS | 5517 | RSS: Main: 214429696 14:54:16 INFO - PROCESS | 5517 | 14:54:18 INFO - PROCESS | 5517 | Cycle 1(1): loaded http://localhost:41948/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41948/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:54:18 INFO - PROCESS | 5517 | RSS: Main: 215945216 14:54:18 INFO - PROCESS | 5517 | 14:54:21 INFO - PROCESS | 5517 | Cycle 1(1): loaded http://localhost:41948/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41948/tests/kraken/driver.html?testName=imaging-darkroom) 14:54:22 INFO - PROCESS | 5517 | RSS: Main: 255950848 14:54:22 INFO - PROCESS | 5517 | 14:54:26 INFO - PROCESS | 5517 | Cycle 1(1): loaded http://localhost:41948/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41948/tests/kraken/driver.html?testName=imaging-desaturate) 14:54:26 INFO - PROCESS | 5517 | RSS: Main: 255234048 14:54:26 INFO - PROCESS | 5517 | 14:54:29 INFO - PROCESS | 5517 | Cycle 1(1): loaded http://localhost:41948/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41948/tests/kraken/driver.html?testName=json-parse-financial) 14:54:30 INFO - PROCESS | 5517 | RSS: Main: 254185472 14:54:30 INFO - PROCESS | 5517 | 14:54:31 INFO - PROCESS | 5517 | Cycle 1(1): loaded http://localhost:41948/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41948/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:54:32 INFO - PROCESS | 5517 | RSS: Main: 217018368 14:54:32 INFO - PROCESS | 5517 | 14:54:34 INFO - PROCESS | 5517 | Cycle 1(1): loaded http://localhost:41948/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41948/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:54:34 INFO - PROCESS | 5517 | RSS: Main: 224776192 14:54:34 INFO - PROCESS | 5517 | 14:54:36 INFO - PROCESS | 5517 | Cycle 1(1): loaded http://localhost:41948/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41948/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:54:37 INFO - PROCESS | 5517 | RSS: Main: 223633408 14:54:37 INFO - PROCESS | 5517 | 14:54:40 INFO - PROCESS | 5517 | Cycle 1(1): loaded http://localhost:41948/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41948/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:54:40 INFO - PROCESS | 5517 | RSS: Main: 219234304 14:54:40 INFO - PROCESS | 5517 | 14:54:43 INFO - PROCESS | 5517 | Cycle 1(1): loaded http://localhost:41948/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41948/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:54:44 INFO - PROCESS | 5517 | RSS: Main: 221351936 14:54:44 INFO - PROCESS | 5517 | 14:54:45 INFO - PROCESS | 5517 | Cycle 1(1): loaded http://localhost:41948/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41948/tests/kraken/driver.html?testName=ai-astar) 14:54:46 INFO - PROCESS | 5517 | RSS: Main: 273416192 14:54:46 INFO - PROCESS | 5517 | 14:54:46 INFO - PROCESS | 5517 | __start_tp_report 14:54:46 INFO - PROCESS | 5517 | _x_x_mozilla_page_load 14:54:46 INFO - PROCESS | 5517 | _x_x_mozilla_page_load_details 14:54:46 INFO - PROCESS | 5517 | |i|pagename|runs| 14:54:46 INFO - PROCESS | 5517 | |0;ai-astar;111;115;127;112;112;113;111;112;112;112 14:54:46 INFO - PROCESS | 5517 | |1;audio-beat-detection;146;123;152;177;120;148;145;125;197;120 14:54:46 INFO - PROCESS | 5517 | |2;audio-dft;161;160;161;159;161;161;160;160;160;160 14:54:46 INFO - PROCESS | 5517 | |3;audio-fft;75;75;76;165;76;76;75;76;177;76 14:54:46 INFO - PROCESS | 5517 | |4;audio-oscillator;84;85;166;86;86;85;151;84;85;140 14:54:46 INFO - PROCESS | 5517 | |5;imaging-gaussian-blur;117;117;117;117;116;117;116;117;117;117 14:54:46 INFO - PROCESS | 5517 | |6;imaging-darkroom;145;145;145;145;145;145;145;145;145;144 14:54:46 INFO - PROCESS | 5517 | |7;imaging-desaturate;96;96;95;95;95;94;95;95;95;95 14:54:46 INFO - PROCESS | 5517 | |8;json-parse-financial;52;52;52;52;51;53;53;52;50;50 14:54:46 INFO - PROCESS | 5517 | |9;json-stringify-tinderbox;60;61;61;60;62;61;61;61;62;61 14:54:46 INFO - PROCESS | 5517 | |10;stanford-crypto-aes;79;78;78;87;87;77;87;78;78;78 14:54:46 INFO - PROCESS | 5517 | |11;stanford-crypto-ccm;127;126;131;125;125;122;124;135;142;126 14:54:46 INFO - PROCESS | 5517 | |12;stanford-crypto-pbkdf2;164;169;166;167;167;162;161;167;164;163 14:54:46 INFO - PROCESS | 5517 | |13;stanford-crypto-sha256-iterative;66;67;66;64;64;68;65;65;64;67 14:54:46 INFO - PROCESS | 5517 | __end_tp_report 14:54:46 INFO - PROCESS | 5517 | __start_cc_report 14:54:46 INFO - PROCESS | 5517 | _x_x_mozilla_cycle_collect,1723 14:54:46 INFO - PROCESS | 5517 | __end_cc_report 14:54:46 INFO - PROCESS | 5517 | __startTimestamp1471989286082__endTimestamp 14:54:46 INFO - PROCESS | 5517 | 14:54:46 INFO - PROCESS | 5517 | ------- Summary: start ------- 14:54:46 INFO - PROCESS | 5517 | Number of tests: 14 14:54:46 INFO - PROCESS | 5517 | 14:54:46 INFO - PROCESS | 5517 | [#0] ai-astar Cycles:10 Average:113.70 Median:112.00 stddev:4.81 (4.3%) stddev-sans-first:5.00 14:54:46 INFO - PROCESS | 5517 | Values: 111.0 115.0 127.0 112.0 112.0 113.0 111.0 112.0 112.0 112.0 14:54:46 INFO - PROCESS | 5517 | 14:54:46 INFO - PROCESS | 5517 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:147.00 stddev:25.65 (17.4%) stddev-sans-first:27.20 14:54:46 INFO - PROCESS | 5517 | Values: 146.0 123.0 152.0 177.0 120.0 148.0 145.0 125.0 197.0 120.0 14:54:46 INFO - PROCESS | 5517 | 14:54:46 INFO - PROCESS | 5517 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:0.67 (0.4%) stddev-sans-first:0.67 14:54:46 INFO - PROCESS | 5517 | Values: 161.0 160.0 161.0 159.0 161.0 161.0 160.0 160.0 160.0 160.0 14:54:46 INFO - PROCESS | 5517 | 14:54:46 INFO - PROCESS | 5517 | [#3] audio-fft Cycles:10 Average:94.70 Median:76.00 stddev:40.32 (53.0%) stddev-sans-first:42.13 14:54:46 INFO - PROCESS | 5517 | Values: 75.0 75.0 76.0 165.0 76.0 76.0 75.0 76.0 177.0 76.0 14:54:46 INFO - PROCESS | 5517 | 14:54:46 INFO - PROCESS | 5517 | [#4] audio-oscillator Cycles:10 Average:105.20 Median:85.00 stddev:33.11 (39.0%) stddev-sans-first:34.22 14:54:46 INFO - PROCESS | 5517 | Values: 84.0 85.0 166.0 86.0 86.0 85.0 151.0 84.0 85.0 140.0 14:54:46 INFO - PROCESS | 5517 | 14:54:46 INFO - PROCESS | 5517 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:54:46 INFO - PROCESS | 5517 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 14:54:46 INFO - PROCESS | 5517 | 14:54:46 INFO - PROCESS | 5517 | [#6] imaging-darkroom Cycles:10 Average:144.90 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 14:54:46 INFO - PROCESS | 5517 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 144.0 14:54:46 INFO - PROCESS | 5517 | 14:54:46 INFO - PROCESS | 5517 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 14:54:46 INFO - PROCESS | 5517 | Values: 96.0 96.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 14:54:46 INFO - PROCESS | 5517 | 14:54:46 INFO - PROCESS | 5517 | [#8] json-parse-financial Cycles:10 Average:51.70 Median:52.00 stddev:1.06 (2.0%) stddev-sans-first:1.12 14:54:46 INFO - PROCESS | 5517 | Values: 52.0 52.0 52.0 52.0 51.0 53.0 53.0 52.0 50.0 50.0 14:54:46 INFO - PROCESS | 5517 | 14:54:46 INFO - PROCESS | 5517 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.67 (1.1%) stddev-sans-first:0.60 14:54:46 INFO - PROCESS | 5517 | Values: 60.0 61.0 61.0 60.0 62.0 61.0 61.0 61.0 62.0 61.0 14:54:46 INFO - PROCESS | 5517 | 14:54:46 INFO - PROCESS | 5517 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:78.50 stddev:4.37 (5.6%) stddev-sans-first:4.59 14:54:46 INFO - PROCESS | 5517 | Values: 79.0 78.0 78.0 87.0 87.0 77.0 87.0 78.0 78.0 78.0 14:54:46 INFO - PROCESS | 5517 | 14:54:46 INFO - PROCESS | 5517 | [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:126.50 stddev:6.07 (4.8%) stddev-sans-first:6.42 14:54:46 INFO - PROCESS | 5517 | Values: 127.0 126.0 131.0 125.0 125.0 122.0 124.0 135.0 142.0 126.0 14:54:46 INFO - PROCESS | 5517 | 14:54:46 INFO - PROCESS | 5517 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.00 Median:166.50 stddev:2.58 (1.6%) stddev-sans-first:2.71 14:54:46 INFO - PROCESS | 5517 | Values: 164.0 169.0 166.0 167.0 167.0 162.0 161.0 167.0 164.0 163.0 14:54:46 INFO - PROCESS | 5517 | 14:54:46 INFO - PROCESS | 5517 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:1.43 (2.2%) stddev-sans-first:1.51 14:54:46 INFO - PROCESS | 5517 | Values: 66.0 67.0 66.0 64.0 64.0 68.0 65.0 65.0 64.0 67.0 14:54:46 INFO - PROCESS | 5517 | -------- Summary: end -------- 14:54:46 INFO - PROCESS | 5517 | 14:54:47 INFO - TEST-INFO | 5517: exit 0 14:54:47 INFO - TEST-OK | kraken | took 62925ms 14:54:47 INFO - SUITE-END | took 1181s 14:54:47 INFO - Completed test suite (00:19:42) 14:54:47 INFO - javascript benchmark 14:54:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2979.150941981535, 2989.402119576085, 2997.2057404787734, 3022.6826183250746, 3060.1431599152247, 5167.534921857032, 5188.974055129724, 5276.445973172815, 5282.471752824716, 5285.127953887609, 5292.364916210051, 5294.047071527124, 5329.094054010818, 5329.653572517784, 5417.810376636819, 4870.683405578644, 4906.4112306523175, 4940.481249468808, 4942.382202224722, 4946.5795407390415, 4868.951310486903, 4882.414110306768, 4903.190973489388, 4909.263610458442, 4960.0823847588135, 4967.602591792648, 5000.774965126578, 5025.572826309768, 5032.7735251913755, 5035.446100928895, 4888.217885138396, 4923.606111511089, 4925.704457732548, 4949.62877784164, 4956.90086198274, 4752.95247047532, 4802.2316429371485, 4808.855734327941, 4812.903741925177, 4849.151398505247, 5186.740662966837, 5223.71269580173, 5250.474952504757, 5251.52736253739, 5257.7896884124975, 5667.121596152603, 5667.433256674341, 5670.858228544278, 5679.460451257124, 5699.2306038684665, 5557.138643510222, 5650.3219613646215, 5710.371859095538, 5713.628614140109, 5796.710164491758, 5326.520613144836, 5338.172583249602, 5344.171653393731, 5351.277577527062, 5359.866003349869, 5883.205767221456, 5890.410958904075, 5891.0, 5893.381194974551, 5895.911561326584, 5503.091989821714, 5555.055640541118, 5594.468525490153, 5594.496495315359, 5689.6586204827845, 5693.0, 5698.17376480408, 5698.487136157766, 5699.487046165865, 5706.029974904276, 5662.178984047372, 5662.2639056922335, 5679.914801277984, 5688.516476099578, 5688.857778555569, 5494.423085576037, 5526.668399895939, 5612.35457922336, 5613.8596535086135, 5648.717564121777, 4392.560743925582, 4398.670099742532, 4434.711743736647, 4449.2658711312915, 4452.643788496913, 3895.8052097395016, 3918.4318273850704, 3934.213157368538, 3941.2511622791576, 3945.8027098645525, 5299.6290259681455, 5432.538234250133, 5453.672779633234, 5495.368032676293, 5509.090999985037, 5742.339630942495, 5811.4479124483105, 5826.941730582725, 5830.62100963436, 5842.561807864342, 5438.972805135949, 5456.0, 5456.536194423518, 5457.126859702428, 5457.208704737791, 4818.566329030404, 4997.85006449807, 5007.098722229961, 5014.573761230264, 5077.847664570068, 5933.406659334119, 5962.0758782387065, 5975.790847320323, 6020.247469066367, 6049.667268300285, 5664.0, 5700.486956173964, 5715.114157305624, 5729.4843464088435, 5739.2252045973255, 5720.456556627114, 5900.350961394157, 5939.0, 5957.0, 5966.701664916824, 5604.131359639263, 5606.635568688022, 5620.803271885465, 5659.151127330933, 5724.742386592697, 5725.770969161187, 5751.654900705804, 5755.597108202385, 5755.625884317506, 5761.395053519488, 5411.756470958738, 5601.691906945157, 5601.971990140023, 5617.662940223436, 5636.577256705681, 5533.446655334596, 5567.777288908398, 5568.359638641608, 5605.915911261416, 5665.773369065356, 5476.2607048049595, 5519.834404967857, 5524.0, 5530.446955304598, 5531.197976293495, 5469.206964989975, 5654.293213348332, 5677.034904066236, 5680.261565996394, 5684.3747187808485, 5310.787568497217, 5440.537554307928, 5468.863278418072, 5471.616986811045, 5552.139418390156], "value": 5271.253243240249, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.1292158389743, 587.2952457051537, 588.9911651325231, 617.1298469158487, 637.5760119520519, 32509.0, 35326.47010294848, 35332.64667353326, 35349.646503534954, 35365.469517957215, 35325.0, 36258.368373423196, 44084.338734919, 45268.77365613176, 45297.7735111324, 8737.432066915662, 8891.73324800257, 8898.955505222497, 8914.777130571723, 8914.777130571723, 8761.123887611251, 8827.602757875911, 8830.381873268874, 8839.16027977341, 8867.68963086292, 8010.319122874563, 8866.778330541723, 10396.532156052957, 10670.253082284244, 10670.51982660782, 10601.84097238542, 10666.893331066745, 10681.359118452918, 10695.197860160519, 10708.0, 10514.264001519896, 10594.099501542378, 10595.470226488645, 10596.41719705416, 10604.04563589273, 41827.1634567307, 42077.0, 42125.57874421247, 42141.36787948183, 42250.78874605638, 2929.6630887448005, 2973.851307434641, 2987.074007057819, 3043.193553708269, 3044.710752478511, 31116.0, 31727.682723172704, 31983.200419989455, 32083.679163208304, 33323.83395079312, 3636.181859081712, 3719.256148770257, 3766.0584853786554, 3782.56500502443, 3847.903802404934, 240774.0, 242487.78756106284, 243174.0, 243306.0, 244123.0, 58867.41132588705, 59243.99999999914, 59331.703341483015, 59341.0, 59443.702781485816, 36051.63948360483, 37034.0, 37091.0, 62796.0, 62986.37013629897, 13373.933130334286, 13508.932455337661, 13512.662183445493, 13515.729685406237, 13516.391762370717, 10010.099091081693, 10060.849087263698, 10095.798084038424, 10186.03232692893, 10201.132903703268, 18445.169967351503, 18461.630767384577, 18473.0, 18523.0, 18617.162227699788, 5736.282964629421, 6828.419584335288, 6860.554063985925, 7136.357727804522, 7292.45306602007, 1020.9183265338755, 1043.2071625564627, 1066.586921850083, 1113.0872684398878, 1154.3131836557236, 29968.95108671186, 30913.381732365677, 31208.531872021937, 31328.686713133033, 31811.840940795148, 1050.5640159333943, 1069.3049517813483, 1101.2676570080966, 1118.9664310070712, 1124.8087825069758, 15895.68208635844, 16863.325466981183, 16905.7464138038, 16951.152442377832, 16951.377802974694, 574717.0, 580180.0, 580529.0, 581729.0, 584581.0, 58612.7069364659, 59271.40728592659, 59275.407245927854, 59325.40674593285, 59336.0, 1215.914885957992, 1281.9743605127844, 1320.0891384944357, 1328.5084518728133, 1328.7608230518406, 29269.0, 31806.84096579502, 33026.33947320992, 33355.666443335256, 33877.66122338844, 50636.74681626568, 51540.48459515357, 51655.22517162171, 51691.0, 51767.482325176265, 480476.0, 487973.0, 490533.0, 490556.1888762276, 492651.0, 38185.80907095447, 38508.22983540258, 38721.80639096787, 43607.78196108999, 44671.55328446674, 35632.28735425329, 48348.51651483581, 48738.0, 48889.511104888494, 52305.21542176794, 40300.0, 41038.38442423306, 41554.168916620896, 42114.1577168461, 43019.35470968, 41591.0, 41910.37134442925, 41942.790286048374, 41974.58025419707, 42354.78822605867, 41716.165676686905, 41851.23338899513, 43403.348949765146, 44463.33305000492, 44623.0, 35287.0, 36872.63127368692, 37386.252274954895, 37878.431823522114, 38517.0, 28046.268895464535, 28499.715002849705, 28504.0, 28608.284792880346, 28717.425651487272], "value": 19749.06071004504, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.2956677979636, 393.97636141831475, 402.9677625789937, 406.55076140864344, 416.6208750037467, 13319.866801331984, 18541.62916741666, 19937.0, 20296.492587685316, 20322.491937701565, 15646.608834779136, 16110.919445402757, 16165.83834161658, 16370.672586548262, 16467.423640172598, 5721.485066344038, 5940.554458415614, 5946.405359464041, 5949.0, 5955.0, 5699.943000569982, 5850.707464626773, 5862.384449632791, 5899.351071382144, 5902.114682797594, 5807.0, 5877.588568800185, 5880.941190588103, 5883.47048765611, 5883.47048765611, 5608.85977850557, 5768.365479797261, 5827.125931110325, 5862.706864656771, 5870.324912635037, 5192.0, 5198.090334191501, 5198.090334191501, 5198.480151984809, 5201.219817027476, 23154.0, 23502.412439689146, 23934.401639959142, 24394.14620488292, 24549.38626534333, 2117.93646190613, 2365.491419344832, 2477.380654836291, 2478.938026549333, 2991.7307442330293, 13958.511452099128, 15179.241037948059, 15369.846301536953, 15771.921140394224, 15778.76331855023, 1920.932767353136, 1966.3117908731972, 1997.2809788476136, 2034.6947957806299, 2091.7280753501946, 80535.59732201361, 81229.9999999994, 82750.0, 83160.0, 84329.0, 10824.296420732628, 10844.258730737884, 10970.725731856768, 11047.72380690473, 11289.60486382989, 15649.217539122998, 15671.0, 15686.843131568767, 15694.0, 15697.293621787047, 7467.850642987219, 7570.0, 7577.772666820004, 7775.844483110306, 7793.493422927491, 6842.315768423118, 6983.720651173896, 7078.071670222973, 7079.2920707929825, 7158.785236442915, 6085.482733967574, 6361.968190159019, 6569.9343006569325, 6735.0, 6743.561668491532, 1939.8448124150316, 1955.1495099631707, 1960.578475627747, 1995.9501012474805, 2007.8755896697603, 872.341382256405, 1016.6340117557673, 1043.1811028342715, 1098.2696506823033, 1101.658485869383, 19160.0, 19501.0, 19570.21719131219, 19790.0, 20332.288369906983, 964.1370972979284, 992.4987881120132, 1021.1677482851452, 1034.343192073039, 1065.8934106589434, 11021.338719676845, 11507.76984460306, 11734.354610496333, 11754.35351055683, 11784.76430471403, 527462.0, 533966.0, 550415.0, 559410.0, 560599.0, 80219.59890200512, 81765.0, 82013.0, 82722.0, 84937.0, 911.6353458616474, 912.8402529557434, 925.1349987761464, 925.3522534226069, 942.7454587261539, 16543.25555349988, 16793.832061679226, 17228.655426891644, 17620.383286584907, 17895.642087158445, 39152.412713809885, 39664.80167599259, 40911.7954410226, 41443.0, 42288.577114228465, 52897.0, 53168.734156328974, 53283.46716532785, 56032.0, 56257.43742562686, 7923.247291507298, 8520.786980325542, 8642.0, 8664.306855451423, 8834.646614135363, 9961.750956226153, 12884.742305154032, 13193.142445740996, 13443.529476468277, 13729.0, 11393.202475826612, 11635.592754253561, 11964.521419143137, 12018.819717704417, 12354.938225308815, 11381.146414019147, 11718.589849355232, 11905.464254108412, 12144.453499592717, 12364.938175309066, 6884.8967265490055, 11545.826812597987, 11894.226875253082, 11972.521099155936, 12248.510059597873, 8703.303735701254, 8806.471611703319, 8874.911250887408, 9259.907400926175, 9285.582148803454, 8480.660773568989, 11395.127208498183, 11970.162088653711, 12005.279683219034, 12258.877411225774], "value": 9327.594673079873, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1290.406413049997, 1355.4036224061413, 1360.9183448993067, 1396.225095072235, 1750.107445202947, 8006.55963921984, 8362.540060296682, 8410.201030902062, 8579.44233624814, 8603.354748393864, 8723.781905452366, 8733.083026282244, 8772.561371931393, 8793.472391656489, 8841.115888411156, 2089.300084471704, 2394.580948334039, 2422.9394265143337, 2425.1027119965547, 2426.502566973766, 2405.675233843426, 2469.394998225437, 2487.465194983078, 2489.3900994256433, 2494.787943024845, 2379.2505360811374, 2388.653645221442, 2388.9641655375094, 2399.3521749127726, 2406.362313986795, 2348.7768661977084, 2421.1889017179265, 2429.2105065853666, 2429.829911906176, 2429.9514009719705, 2410.4696966667307, 2442.7312995570474, 2446.7675570820743, 2450.4608986023045, 2452.4359397338535, 8895.644174233023, 8952.8657070144, 8960.731178064669, 8967.686130985385, 8974.102589741038, 4692.6245900327895, 4825.589824864891, 4829.1790395632825, 4833.10587541306, 4836.395450568679, 3295.7857739246874, 3374.9325013499592, 3554.1647712787476, 3563.6614521620404, 3564.946525802115, 1178.4755783676267, 1195.0678470792795, 1223.1254652923114, 1242.9875701243052, 1264.5890085722085, 12404.56584019564, 12432.067594930417, 12442.0, 12452.0, 12528.74942501154, 4476.35092911526, 4554.772261386917, 4710.576048155683, 4771.66598338113, 4774.641901857305, 9414.576344064533, 9415.340926135243, 9425.90574094264, 9426.245900327956, 9426.905730942603, 5001.274815151855, 5006.424261209934, 5006.849794506171, 5011.949880501221, 5012.899742005139, 3973.205358928226, 4452.621527170162, 4689.648276379286, 4692.41344831896, 4692.929606055912, 3763.34141525232, 3807.904802379963, 3914.8629797956933, 3942.3692209246383, 4000.219957108336, 1173.5716463490935, 1200.8558972923306, 1204.644629834201, 1208.4984731336572, 1215.3619349841404, 822.658596682382, 896.8071864549154, 934.7756538430864, 942.3686130292721, 966.2559828931684, 5635.492805647511, 5850.23946886902, 5886.411358864165, 5927.555433342516, 5928.4960778334325, 454.3548161610521, 462.2702939144358, 468.8405941979743, 475.30842623982716, 486.8612445453029, 3803.3344164771056, 3805.8858234253016, 3849.922021833891, 3872.1094148345474, 3917.666998305119, 10690.251682382313, 10955.397453139994, 11097.1122310215, 11168.162387820947, 11170.664880053611, 11052.668419947415, 11059.170562207706, 11064.557417703363, 11077.944610277058, 11131.610393636183, 8254.463459875209, 8272.37957153216, 8274.0, 8278.793030174294, 8317.916820831835, 5700.346899399128, 5720.342160651412, 5827.7179020615395, 5889.5582831286965, 5941.168236446987, 10108.191344692259, 10146.746331341776, 10155.593776248867, 10184.847227291744, 10202.438865862152, 9861.704148875546, 10188.337758045704, 10198.643047493302, 10495.842562361418, 10517.0, 6757.3242675734, 7239.927600723925, 7319.34125928669, 7348.706051758084, 7383.630818459163, 8423.4945903246, 8621.0, 8735.43219690718, 8757.824843503222, 8773.868391974253, 7517.548947063194, 7661.195574464601, 7692.499987500794, 7726.111497177896, 7875.448718589644, 7313.0, 7688.077430708351, 7745.22547745221, 7819.452638315263, 7976.960115199619, 6767.35710107539, 6895.724171033103, 6898.724051037902, 6920.100386949664, 6920.134983127109, 5126.487351264844, 5185.299984502044, 5217.399999000164, 5249.763760630704, 5392.676439413648, 5207.3230480037355, 5224.216367544898, 5270.0, 5295.7087360195555, 5429.782808687608], "value": 4517.345300839162, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.1901921273667, 331.9883804066857, 333.9682730140636, 344.38871003967955, 349.51243015992685, 5118.9488105118935, 5193.143770925985, 5211.7133557654315, 5250.107481728106, 5303.4431384704585, 5117.437081920985, 5157.174852023677, 5162.845114646567, 5166.844994650157, 5191.896162076756, 4104.897377565562, 4108.342665173573, 4109.0, 4120.896977575555, 4150.547308442036, 3857.3635350167187, 3948.9210215795665, 4089.325261331877, 4109.116539943911, 4130.13267213884, 4076.449679293302, 4081.530623978251, 4097.242010228102, 4098.7950602469755, 4122.649574786146, 4076.30702780528, 4089.26393249215, 4101.118259574191, 4103.363978583295, 4137.668986481074, 3415.7267418606452, 3512.8594856205723, 3567.250877315741, 3582.22982058856, 3606.4049431843714, 4986.0, 4992.600591952635, 4997.875053123665, 5017.724025178613, 5030.195168772979, 4581.770911454414, 4594.196015697273, 4594.793234304464, 4612.76936153191, 4655.114678555191, 5284.128118860383, 5320.654157479751, 5349.117395629716, 5368.35579730431, 5378.731063446851, 3918.8432462701458, 3934.8426062957446, 3936.563154448634, 3936.566977632458, 3942.4874766280486, 5590.301212348457, 5623.9437605623825, 5651.5761317900915, 5681.460261275172, 5685.744141513642, 3936.8622098226424, 3999.7800120993625, 4053.5338436079637, 4055.4525139105845, 4079.449274347925, 4114.403411505375, 4117.3206420940205, 4119.361498967664, 4122.42286079949, 4123.484564429446, 4712.363830882856, 4724.291356296514, 4731.361266229083, 4733.195356789354, 4737.881552961204, 5351.86620334487, 5371.248025276464, 5393.2449457076045, 5459.563234941195, 5503.7066289422755, 1396.818413606245, 1405.4448492845472, 1407.3526177958254, 1414.561485939362, 1425.1520345394474, 889.9555022248861, 913.5934509143367, 925.3106435705442, 934.2292608597799, 938.9436883506056, 4633.837815676435, 4676.415448068991, 4684.227102528044, 4709.976450117796, 5021.6735912165595, 5398.1362981923485, 5433.103537916279, 5455.208994695747, 5479.123340265618, 5546.27898373217, 5258.8159414420315, 5261.553682338074, 5288.365396152486, 5292.497212764782, 5299.417064122943, 2823.759980401689, 2890.869910854017, 2928.531434970437, 2945.4683564546317, 2971.1680729395803, 5748.856278593069, 5755.215883076176, 5755.453231942959, 5762.798302059407, 5780.0, 5665.6968897153065, 5674.943250567524, 5674.9501342251815, 5690.4025077367105, 5691.971540142273, 5515.641483303652, 5737.99585072619, 5745.052066408995, 5782.479576838021, 5808.5062769665055, 5589.580781441489, 5603.635763675348, 5604.8318550443555, 5608.10270356741, 5619.353774316006, 5273.815416460406, 5524.889502209853, 5526.005319042611, 5543.334799824047, 5588.0, 5721.971390143022, 5744.195812586157, 5806.303243610793, 5833.649981001154, 5869.970650146722, 4076.7553946763287, 4079.755214687128, 4126.66986641062, 4134.441850350285, 4135.875923722293, 5326.866828329323, 5602.663840169603, 5638.943610564006, 5673.290838645169, 5685.857853553694, 5413.512783849473, 5463.754131064191, 5469.699166545878, 5477.643953143033, 5490.423505532021, 5418.512333889968, 5438.510534051954, 5450.209719590716, 5464.98897703926, 5467.617266791286, 5174.301469301596, 5319.840404787863, 5382.219578161066, 5388.299521062237, 5407.242985981887, 5455.690634247831, 5459.836204913859, 5482.437505310967, 5483.479069488392, 5494.532964698045, 5118.590512759045, 5171.405288391883, 5355.25026496283, 5359.222912677717, 5372.301600791872], "value": 4157.450265997404, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [646.8706258748251, 653.3727621483375, 654.4894981914106, 710.545251039335, 744.8212429017037, 14348.64128396788, 14476.276186190687, 15026.17356045417, 15047.02194357366, 15098.245087745623, 13600.523981660644, 13693.17840929545, 13706.383212755425, 13729.382177801997, 13759.93120034401, 784.8626490364192, 808.5189312359137, 811.9106898241189, 812.2202685421972, 812.8130529978108, 667.6594936582354, 784.8194915169514, 791.1811275330006, 802.5866678660494, 810.5217921426357, 849.0957130655862, 853.8804567360575, 853.9402241843073, 854.2738672128672, 854.3805740837905, 840.1640367834044, 848.088305072047, 850.3027517435705, 850.6724910909313, 851.6550796927254, 502.5878779400856, 593.7268856326095, 596.2219303808528, 605.4823126227101, 619.3837132053591, 12881.806772898413, 12914.483420663162, 12946.611601651966, 12954.935225323907, 12996.090273680846, 13887.513937012156, 14448.0, 14514.70970580593, 14591.635209119751, 15002.324895379734, 12301.876981230163, 12309.56916507918, 12362.876371236262, 12382.380880956007, 12413.131080824345, 4469.597736203725, 4488.41650585425, 4514.751688657123, 4540.091981603659, 4659.404186237599, 85448.14551854464, 85798.14201858027, 87808.0, 88191.0, 89121.0, 10622.840657390145, 11160.16298777595, 11364.715882103013, 11401.657950261506, 11514.596989105341, 23419.180328688755, 23479.530409391715, 23495.295141145794, 23508.764912351, 23610.88194559016, 8530.317574594017, 8649.91350086491, 8779.165979231962, 8928.464292142493, 9009.873765779277, 4748.335233067373, 4781.808727650925, 4787.257975013878, 4791.329213910055, 4863.224922903115, 3372.3929692655556, 3456.6197718250974, 3462.4113900636953, 3482.7736197147105, 3500.789952602852, 509.19292920720335, 518.3365292425701, 523.0584947095214, 551.401729123905, 556.5325126893348, 502.49248259257683, 536.948989845964, 588.352811906899, 594.6194435561245, 599.6821684507219, 9051.683191088281, 9054.456732596065, 9194.218491428304, 9256.352055356061, 9261.583228754722, 596.4572239262251, 599.2120361724319, 601.7382438639206, 608.9786857459968, 609.7347653770536, 3867.323218436762, 4260.808263628082, 4264.147170565837, 4606.7673752209375, 4901.975490122598, 68151.3184868155, 68169.31830681629, 68395.65802170958, 98955.0, 99995.50002250087, 105671.0, 107905.0, 108307.45846270719, 108680.0, 110721.0, 94696.0, 95169.0, 96239.0, 102860.0, 104793.47603261935, 9355.906440935503, 9588.856167157637, 9750.21998240125, 9808.16630586408, 9819.0, 44775.77612111918, 52558.21162682639, 52802.73598632136, 52949.0, 54438.45561544334, 49353.0, 49813.750931245115, 56701.716491417275, 81285.59357203176, 82637.58681206555, 11307.434628268718, 11326.603568875049, 11480.540778368771, 11533.82699259495, 12168.391580420766, 13539.187648740713, 14101.929490352482, 14254.857451425767, 14539.85460145385, 15149.318280677617, 9304.395214311047, 13031.934840325737, 13398.397072131582, 13412.12821166621, 13617.931910340782, 12167.33079680626, 12171.878281217074, 12287.324197168884, 12397.93801030989, 12866.356682165668, 12442.688932776753, 12575.0, 13144.40850161726, 13470.124441911245, 13473.932630336785, 10089.0, 10110.0, 10486.265961382935, 11168.553257869595, 11276.379799111128, 9848.803023939337, 10603.151747860307, 10626.8405973912, 10690.465476726287, 10702.571897124339], "value": 7254.919653536307, "unit": "score"}], "name": "dromaeo_css", "value": 7138.438428875403, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 115.0, 127.0, 112.0, 112.0, 113.0, 111.0, 112.0, 112.0, 112.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 123.0, 152.0, 177.0, 120.0, 148.0, 145.0, 125.0, 197.0, 120.0], "value": 145.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 159.0, 161.0, 161.0, 160.0, 160.0, 160.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 165.0, 76.0, 76.0, 75.0, 76.0, 177.0, 76.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 166.0, 86.0, 86.0, 85.0, 151.0, 84.0, 85.0, 140.0], "value": 105.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 144.0], "value": 144.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 52.0, 51.0, 53.0, 53.0, 52.0, 50.0, 50.0], "value": 51.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 60.0, 62.0, 61.0, 61.0, 61.0, 62.0, 61.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 78.0, 87.0, 87.0, 77.0, 87.0, 78.0, 78.0, 78.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 126.0, 131.0, 125.0, 125.0, 122.0, 124.0, 135.0, 142.0, 126.0], "value": 128.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 169.0, 166.0, 167.0, 167.0, 162.0, 161.0, 167.0, 164.0, 163.0], "value": 165.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 64.0, 64.0, 68.0, 65.0, 65.0, 64.0, 67.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1528.3, "alertThreshold": 2.0}]} 14:54:47 INFO - Return code: 0 14:54:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:54:47 INFO - # TBPL SUCCESS # 14:54:47 INFO - Running post-action listener: _resource_record_post_action 14:54:47 INFO - [mozharness: 2016-08-23 21:54:47.891708Z] Finished run-tests step (success) 14:54:47 INFO - Running post-run listener: _resource_record_post_run 14:54:47 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 692224; Write bytes: 408076288; Read time: 444; Write time: 295416 14:54:47 INFO - TinderboxPrint: CPU usage
13.3% 14:54:47 INFO - TinderboxPrint: I/O read bytes / time
692,224 / 444 14:54:47 INFO - TinderboxPrint: I/O write bytes / time
408,076,288 / 295,416 14:54:47 INFO - TinderboxPrint: CPU idle
8,296.7 (86.7%) 14:54:47 INFO - TinderboxPrint: CPU user
1,201.4 (12.6%) 14:54:47 INFO - TinderboxPrint: Swap in / out
0 / 0 14:54:47 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 120217600; Read time: 0; Write time: 91148 14:54:47 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 692224; Write bytes: 287858688; Read time: 444; Write time: 204268 14:54:48 INFO - Running post-run listener: _upload_blobber_files 14:54:48 INFO - Blob upload gear active. 14:54:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:54:48 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:54:48 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:54:48 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:54:48 INFO - (blobuploader) - INFO - Open directory for files ... 14:54:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:54:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:54:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:54:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:54:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:54:50 INFO - (blobuploader) - INFO - Done attempting. 14:54:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:54:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:54:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:54:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:54:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:54:53 INFO - (blobuploader) - INFO - Done attempting. 14:54:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:54:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:54:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:54:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:54:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:54:54 INFO - (blobuploader) - INFO - Done attempting. 14:54:54 INFO - (blobuploader) - INFO - Iteration through files over. 14:54:54 INFO - Return code: 0 14:54:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:54:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:54:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1c714550fb7bbb41d270d81c490477279565f6a106e38b8501154f01cd62a68b0f292342af367b4d96faa2e09ebc02fa866e20809cc46d14a9c3849e0f510615", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6b64154660d30c68fe8a909ee92aa96db35ef97bc462eb3a8cacab06a710084dee92f465dd9e20c3477f8f2c1ba832cf08e2c14b3c90ecd5504772078600cd82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f6f893eea34520a836f5f8cabc7096c1858da42f9d106b5495b8bf6b2d13b16173875a4f3f480ca8c2766413b3b38e100933a8532187c86898bf126a76612604"} 14:54:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:54:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:54:54 INFO - Contents: 14:54:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1c714550fb7bbb41d270d81c490477279565f6a106e38b8501154f01cd62a68b0f292342af367b4d96faa2e09ebc02fa866e20809cc46d14a9c3849e0f510615", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6b64154660d30c68fe8a909ee92aa96db35ef97bc462eb3a8cacab06a710084dee92f465dd9e20c3477f8f2c1ba832cf08e2c14b3c90ecd5504772078600cd82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f6f893eea34520a836f5f8cabc7096c1858da42f9d106b5495b8bf6b2d13b16173875a4f3f480ca8c2766413b3b38e100933a8532187c86898bf126a76612604"} 14:54:54 INFO - Running post-run listener: copy_logs_to_upload_dir 14:54:54 INFO - Copying logs to upload dir... 14:54:54 INFO - mkdir: /builds/slave/test/build/upload/logs 14:54:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.784463 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-08-23 14:54:54.290560) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 14:54:54.294653) ========= 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=4300f881736b422476174874000001bc-1471988049.319340-2108220558 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/1c714550fb7bbb41d270d81c490477279565f6a106e38b8501154f01cd62a68b0f292342af367b4d96faa2e09ebc02fa866e20809cc46d14a9c3849e0f510615", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6b64154660d30c68fe8a909ee92aa96db35ef97bc462eb3a8cacab06a710084dee92f465dd9e20c3477f8f2c1ba832cf08e2c14b3c90ecd5504772078600cd82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f6f893eea34520a836f5f8cabc7096c1858da42f9d106b5495b8bf6b2d13b16173875a4f3f480ca8c2766413b3b38e100933a8532187c86898bf126a76612604"} 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.011259 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/1c714550fb7bbb41d270d81c490477279565f6a106e38b8501154f01cd62a68b0f292342af367b4d96faa2e09ebc02fa866e20809cc46d14a9c3849e0f510615", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6b64154660d30c68fe8a909ee92aa96db35ef97bc462eb3a8cacab06a710084dee92f465dd9e20c3477f8f2c1ba832cf08e2c14b3c90ecd5504772078600cd82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f6f893eea34520a836f5f8cabc7096c1858da42f9d106b5495b8bf6b2d13b16173875a4f3f480ca8c2766413b3b38e100933a8532187c86898bf126a76612604"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 14:54:54.322626) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 14:54:54.323158) ========= 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=4300f881736b422476174874000001bc-1471988049.319340-2108220558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004373 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 14:54:54.404565) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 14:54:54.404939) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 14:54:54.405350) ========= ========= Total master_lag: 0.17 =========