builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-051 starttime: 1470842537.41 results: success (0) buildid: 20160810053005 builduid: 0d5ea53d7be44cf583f369e5083ca05a revision: 2f24daceada71e15c03b5f90765264c720ed035a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 08:22:17.413557) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 08:22:17.414010) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 08:22:17.414300) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 08:22:17.428852) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 08:22:17.429126) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1470842536.966785-1805859118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-10 08:22:17-- 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% 33.1M=0s 2016-08-10 08:22:17 (33.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133031 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 08:22:17.576254) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 08:22:17.576562) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1470842536.966785-1805859118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020325 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 08:22:17.626303) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 08:22:17.626645) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2f24daceada71e15c03b5f90765264c720ed035a --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 2f24daceada71e15c03b5f90765264c720ed035a --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=5ac5dba3e01a12f1ff77ab15000001b1-1470842536.966785-1805859118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-10 08:22:17,969 truncating revision to first 12 chars 2016-08-10 08:22:17,969 Setting DEBUG logging. 2016-08-10 08:22:17,969 attempt 1/10 2016-08-10 08:22:17,969 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2f24daceada7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-10 08:22:18,271 unpacking tar archive at: fx-team-2f24daceada7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.644855 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 08:22:18.285418) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 08:22:18.285739) ========= script_repo_revision: 2f24daceada71e15c03b5f90765264c720ed035a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 08:22:18.286119) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 08:22:18.286395) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 08:22:18.295061) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-08-10 08:22:18.295379) ========= /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=5ac5dba3e01a12f1ff77ab15000001b1-1470842536.966785-1805859118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:22:18 INFO - MultiFileLogger online at 20160810 08:22:18 in /builds/slave/test 08:22:18 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 08:22:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:22:18 INFO - {'append_to_log': False, 08:22:18 INFO - 'base_work_dir': '/builds/slave/test', 08:22:18 INFO - 'blob_upload_branch': 'Fx-Team', 08:22:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:22:18 INFO - 'branch': 'Fx-Team', 08:22:18 INFO - 'buildbot_json_path': 'buildprops.json', 08:22:18 INFO - 'config_files': ('talos/linux_config.py',), 08:22:18 INFO - 'default_actions': ('clobber', 08:22:18 INFO - 'read-buildbot-config', 08:22:18 INFO - 'download-and-extract', 08:22:18 INFO - 'populate-webroot', 08:22:18 INFO - 'create-virtualenv', 08:22:18 INFO - 'install', 08:22:18 INFO - 'run-tests'), 08:22:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:22:18 INFO - 'download_minidump_stackwalk': True, 08:22:18 INFO - 'download_symbols': 'ondemand', 08:22:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:22:18 INFO - 'tooltool.py': '/tools/tooltool.py', 08:22:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:22:18 INFO - '/tools/misc-python/virtualenv.py')}, 08:22:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:22:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:22:18 INFO - 'installer_path': 'installer.exe', 08:22:18 INFO - 'log_level': 'info', 08:22:18 INFO - 'log_name': 'talos', 08:22:18 INFO - 'log_to_console': True, 08:22:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:22:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:22:18 INFO - 'opt_config_files': (), 08:22:18 INFO - 'pip_index': False, 08:22:18 INFO - 'sps_profile': False, 08:22:18 INFO - 'sps_profile_interval': 0, 08:22:18 INFO - 'suite': 'dromaeojs', 08:22:18 INFO - 'system_bits': '32', 08:22:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:22:18 INFO - 'title': 'talos-linux64-ix-051', 08:22:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:22:18 INFO - 'use_talos_json': True, 08:22:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:22:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:22:18 INFO - 'work_dir': 'build'} 08:22:18 INFO - [mozharness: 2016-08-10 15:22:18.725568Z] Running clobber step. 08:22:18 INFO - Running pre-action listener: _resource_record_pre_action 08:22:18 INFO - Running main action method: clobber 08:22:18 INFO - rmtree: /builds/slave/test/build 08:22:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:22:19 INFO - Running post-action listener: _resource_record_post_action 08:22:19 INFO - [mozharness: 2016-08-10 15:22:19.194750Z] Finished clobber step (success) 08:22:19 INFO - [mozharness: 2016-08-10 15:22:19.194852Z] Running read-buildbot-config step. 08:22:19 INFO - Running pre-action listener: _resource_record_pre_action 08:22:19 INFO - Running main action method: read_buildbot_config 08:22:19 INFO - Using buildbot properties: 08:22:19 INFO - { 08:22:19 INFO - "project": "", 08:22:19 INFO - "product": "firefox", 08:22:19 INFO - "script_repo_revision": "production", 08:22:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:22:19 INFO - "repository": "", 08:22:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:22:19 INFO - "buildid": "20160810053005", 08:22:19 INFO - "pgo_build": "True", 08:22:19 INFO - "basedir": "/builds/slave/test", 08:22:19 INFO - "buildnumber": 969, 08:22:19 INFO - "slavename": "talos-linux64-ix-051", 08:22:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:22:19 INFO - "platform": "ubuntu64_hw", 08:22:19 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:22:19 INFO - "branch": "fx-team", 08:22:19 INFO - "repo_path": "integration/fx-team", 08:22:19 INFO - "revision": "2f24daceada71e15c03b5f90765264c720ed035a", 08:22:19 INFO - "stage_platform": "linux64-pgo", 08:22:19 INFO - "builduid": "0d5ea53d7be44cf583f369e5083ca05a", 08:22:19 INFO - "slavebuilddir": "test" 08:22:19 INFO - } 08:22:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/FUTGxNqCQtKlN2KsnAPyTQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 08:22:19 INFO - Running post-action listener: _resource_record_post_action 08:22:19 INFO - [mozharness: 2016-08-10 15:22:19.197313Z] Finished read-buildbot-config step (success) 08:22:19 INFO - [mozharness: 2016-08-10 15:22:19.197401Z] Running download-and-extract step. 08:22:19 INFO - Running pre-action listener: _resource_record_pre_action 08:22:19 INFO - Running main action method: download_and_extract 08:22:19 INFO - mkdir: /builds/slave/test/build/tests 08:22:19 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')]} 08:22:19 INFO - trying https://queue.taskcluster.net/v1/task/FUTGxNqCQtKlN2KsnAPyTQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:22:19 INFO - Downloading https://queue.taskcluster.net/v1/task/FUTGxNqCQtKlN2KsnAPyTQ/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 08:22:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FUTGxNqCQtKlN2KsnAPyTQ/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 08:22:19 INFO - Downloaded 1361 bytes. 08:22:19 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:22:19 INFO - Using the following test package requirements: 08:22:19 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:22:19 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:22:19 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:22:19 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:19 INFO - u'jsshell-linux-x86_64.zip'], 08:22:19 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:22:19 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:22:19 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:22:19 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:22:19 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:22:19 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:22:19 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:22:19 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')]} 08:22:19 INFO - trying https://queue.taskcluster.net/v1/task/FUTGxNqCQtKlN2KsnAPyTQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:22:19 INFO - Downloading https://queue.taskcluster.net/v1/task/FUTGxNqCQtKlN2KsnAPyTQ/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 08:22:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FUTGxNqCQtKlN2KsnAPyTQ/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 08:22:20 INFO - Downloaded 21831225 bytes. 08:22:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:22:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:22:21 INFO - Return code: 0 08:22:21 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 08:22:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:21 INFO - trying https://queue.taskcluster.net/v1/task/FUTGxNqCQtKlN2KsnAPyTQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:22:21 INFO - Downloading https://queue.taskcluster.net/v1/task/FUTGxNqCQtKlN2KsnAPyTQ/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 08:22:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FUTGxNqCQtKlN2KsnAPyTQ/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 08:22:22 INFO - Downloaded 21831225 bytes. 08:22:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:22:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:22:24 INFO - Return code: 0 08:22: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')]} 08:22:24 INFO - trying https://queue.taskcluster.net/v1/task/FUTGxNqCQtKlN2KsnAPyTQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:22:24 INFO - Downloading https://queue.taskcluster.net/v1/task/FUTGxNqCQtKlN2KsnAPyTQ/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 08:22:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FUTGxNqCQtKlN2KsnAPyTQ/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 08:22:24 INFO - Downloaded 14413723 bytes. 08:22:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:22:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:22:25 INFO - Return code: 0 08:22:25 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')]} 08:22:25 INFO - trying https://queue.taskcluster.net/v1/task/FUTGxNqCQtKlN2KsnAPyTQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:22:25 INFO - Downloading https://queue.taskcluster.net/v1/task/FUTGxNqCQtKlN2KsnAPyTQ/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 08:22:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FUTGxNqCQtKlN2KsnAPyTQ/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 08:22:26 INFO - Downloaded 59315436 bytes. 08:22:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FUTGxNqCQtKlN2KsnAPyTQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:22:26 INFO - mkdir: /builds/slave/test/properties 08:22:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:22:26 INFO - Writing to file /builds/slave/test/properties/build_url 08:22:26 INFO - Contents: 08:22:26 INFO - build_url:https://queue.taskcluster.net/v1/task/FUTGxNqCQtKlN2KsnAPyTQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:22:27 INFO - Running post-action listener: _resource_record_post_action 08:22:27 INFO - Running post-action listener: set_extra_try_arguments 08:22:27 INFO - [mozharness: 2016-08-10 15:22:27.173518Z] Finished download-and-extract step (success) 08:22:27 INFO - [mozharness: 2016-08-10 15:22:27.173754Z] Running populate-webroot step. 08:22:27 INFO - Running pre-action listener: _resource_record_pre_action 08:22:27 INFO - Running main action method: populate_webroot 08:22:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:22:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:22:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:22:27 INFO - '--tppagecycles', 08:22:27 INFO - '7'], 08:22:27 INFO - 'tests': ['tsvgm']}}, 08:22:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:22:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:22:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:22:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:22:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:22:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:22:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:27 INFO - 'talos_options': ['--disable-e10s'], 08:22:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:22:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:22:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:27 INFO - 'talos_options': ['--disable-e10s'], 08:22:27 INFO - 'tests': ['damp', 'tps']}, 08:22:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:27 INFO - 'tests': ['damp', 'tps']}, 08:22:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:22:27 INFO - 'tests': ['dromaeo_dom']}, 08:22:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:22:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:22:27 INFO - 'tests': ['basic_compositor_video']}, 08:22:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:22:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:22:27 INFO - 'tests': ['a11yr', 08:22:27 INFO - 'ts_paint', 08:22:27 INFO - 'tpaint', 08:22:27 INFO - 'sessionrestore', 08:22:27 INFO - 'sessionrestore_no_auto_restore', 08:22:27 INFO - 'tabpaint']}, 08:22:27 INFO - 'other-e10s': {'tests': ['a11yr', 08:22:27 INFO - 'ts_paint', 08:22:27 INFO - 'tpaint', 08:22:27 INFO - 'sessionrestore', 08:22:27 INFO - 'sessionrestore_no_auto_restore', 08:22:27 INFO - 'tabpaint']}, 08:22:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:22:27 INFO - 'ts_paint', 08:22:27 INFO - 'tpaint', 08:22:27 INFO - 'sessionrestore', 08:22:27 INFO - 'sessionrestore_no_auto_restore', 08:22:27 INFO - 'tabpaint']}, 08:22:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:22:27 INFO - 'ts_paint', 08:22:27 INFO - 'tpaint', 08:22:27 INFO - 'sessionrestore', 08:22:27 INFO - 'sessionrestore_no_auto_restore', 08:22:27 INFO - 'tabpaint']}, 08:22:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:22:27 INFO - 'tests': ['a11yr', 08:22:27 INFO - 'ts_paint', 08:22:27 INFO - 'tpaint', 08:22:27 INFO - 'sessionrestore', 08:22:27 INFO - 'sessionrestore_no_auto_restore', 08:22:27 INFO - 'tabpaint']}, 08:22:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:22:27 INFO - 'tests': ['a11yr', 08:22:27 INFO - 'ts_paint', 08:22:27 INFO - 'tpaint', 08:22:27 INFO - 'sessionrestore', 08:22:27 INFO - 'sessionrestore_no_auto_restore', 08:22:27 INFO - 'tabpaint']}, 08:22:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:22:27 INFO - 'tests': ['tsvgx', 08:22:27 INFO - 'tsvgr_opacity', 08:22:27 INFO - 'tart', 08:22:27 INFO - 'tscrollx', 08:22:27 INFO - 'cart']}, 08:22:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:22:27 INFO - 'tsvgr_opacity', 08:22:27 INFO - 'tart', 08:22:27 INFO - 'tscrollx', 08:22:27 INFO - 'cart']}, 08:22:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:27 INFO - 'talos_options': ['--disable-e10s'], 08:22:27 INFO - 'tests': ['tp5o']}, 08:22:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:27 INFO - 'tests': ['tp5o']}, 08:22:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:27 INFO - 'talos_options': ['--disable-e10s', 08:22:27 INFO - '--xperf_path', 08:22:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:22:27 INFO - 'tests': ['tp5n']}, 08:22:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:27 INFO - 'talos_options': ['--xperf_path', 08:22:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:22:27 INFO - 'tests': ['tp5n']}}, 08:22:27 INFO - 'talos.zip': {'path': '', 08:22:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:22:27 INFO - Running post-action listener: _resource_record_post_action 08:22:27 INFO - [mozharness: 2016-08-10 15:22:27.193740Z] Finished populate-webroot step (success) 08:22:27 INFO - [mozharness: 2016-08-10 15:22:27.193832Z] Running create-virtualenv step. 08:22:27 INFO - Running pre-action listener: _resource_record_pre_action 08:22:27 INFO - Running main action method: create_virtualenv 08:22:27 INFO - Creating virtualenv /builds/slave/test/build/venv 08:22:27 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 08:22:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:22:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:22:27 INFO - Using real prefix '/usr' 08:22:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:22:27 INFO - Installing distribute.............................................................................................................................................................................................done. 08:22:29 INFO - Installing pip.................done. 08:22:29 INFO - Return code: 0 08:22:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:22: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')]} 08:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22: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')]} 08:22:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22: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 0x237b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263a3b0>, '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 0x263b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263b740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1470842536.966785-1805859118', '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 08:22: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 08:22: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 08:22:29 INFO - Using env: {'DISPLAY': ':0', 08:22:29 INFO - 'HOME': '/home/cltbld', 08:22:29 INFO - 'LANG': 'en_US.UTF-8', 08:22:29 INFO - 'LANGUAGE': 'en_US:en', 08:22:29 INFO - 'LOGNAME': 'cltbld', 08:22:29 INFO - 'MAIL': '/var/mail/cltbld', 08:22:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:29 INFO - 'MOZ_NO_REMOTE': '1', 08:22:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:29 INFO - 'NO_EM_RESTART': '1', 08:22:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:29 INFO - 'PWD': '/builds/slave/test', 08:22:29 INFO - 'SHELL': '/bin/bash', 08:22:29 INFO - 'SHLVL': '1', 08:22:29 INFO - 'TERM': 'linux', 08:22:29 INFO - 'TMOUT': '86400', 08:22:29 INFO - 'USER': 'cltbld', 08:22:29 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1470842536.966785-1805859118', 08:22:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:29 INFO - '_': '/tools/buildbot/bin/python'} 08:22:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:30 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 08:22:30 INFO - Cleaning up... 08:22:30 INFO - Return code: 0 08:22:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:22:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:30 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 0x237b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263a3b0>, '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 0x263b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263b740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1470842536.966785-1805859118', '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 08:22:30 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 08:22:30 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 08:22:30 INFO - Using env: {'DISPLAY': ':0', 08:22:30 INFO - 'HOME': '/home/cltbld', 08:22:30 INFO - 'LANG': 'en_US.UTF-8', 08:22:30 INFO - 'LANGUAGE': 'en_US:en', 08:22:30 INFO - 'LOGNAME': 'cltbld', 08:22:30 INFO - 'MAIL': '/var/mail/cltbld', 08:22:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:30 INFO - 'MOZ_NO_REMOTE': '1', 08:22:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:30 INFO - 'NO_EM_RESTART': '1', 08:22:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:30 INFO - 'PWD': '/builds/slave/test', 08:22:30 INFO - 'SHELL': '/bin/bash', 08:22:30 INFO - 'SHLVL': '1', 08:22:30 INFO - 'TERM': 'linux', 08:22:30 INFO - 'TMOUT': '86400', 08:22:30 INFO - 'USER': 'cltbld', 08:22:30 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1470842536.966785-1805859118', 08:22:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:30 INFO - '_': '/tools/buildbot/bin/python'} 08:22:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:30 INFO - Downloading/unpacking psutil>=3.1.1 08:22:30 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 08:22:30 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 08:22:30 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 08:22:30 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 08:22:30 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 08:22:30 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 08:22:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:22:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:22:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:22:32 INFO - Installing collected packages: psutil 08:22:32 INFO - Running setup.py install for psutil 08:22:32 INFO - building 'psutil._psutil_linux' extension 08:22:32 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 08:22:32 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 08:22:32 INFO - building 'psutil._psutil_posix' extension 08:22:32 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 08:22:32 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 08:22:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:22:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:22:32 INFO - Successfully installed psutil 08:22:32 INFO - Cleaning up... 08:22:32 INFO - Return code: 0 08:22:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:22: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')]} 08:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22: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')]} 08:22:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22: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 0x237b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263a3b0>, '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 0x263b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263b740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1470842536.966785-1805859118', '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 08:22: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 08:22: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 08:22:32 INFO - Using env: {'DISPLAY': ':0', 08:22:32 INFO - 'HOME': '/home/cltbld', 08:22:32 INFO - 'LANG': 'en_US.UTF-8', 08:22:32 INFO - 'LANGUAGE': 'en_US:en', 08:22:32 INFO - 'LOGNAME': 'cltbld', 08:22:32 INFO - 'MAIL': '/var/mail/cltbld', 08:22:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:32 INFO - 'MOZ_NO_REMOTE': '1', 08:22:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:32 INFO - 'NO_EM_RESTART': '1', 08:22:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:32 INFO - 'PWD': '/builds/slave/test', 08:22:32 INFO - 'SHELL': '/bin/bash', 08:22:32 INFO - 'SHLVL': '1', 08:22:32 INFO - 'TERM': 'linux', 08:22:32 INFO - 'TMOUT': '86400', 08:22:32 INFO - 'USER': 'cltbld', 08:22:32 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1470842536.966785-1805859118', 08:22:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:32 INFO - '_': '/tools/buildbot/bin/python'} 08:22:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:22:33 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 08:22:33 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 08:22:33 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 08:22:33 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 08:22:33 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 08:22:33 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 08:22:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:22:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:22:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:22:34 INFO - Installing collected packages: mozsystemmonitor 08:22:34 INFO - Running setup.py install for mozsystemmonitor 08:22:35 INFO - Successfully installed mozsystemmonitor 08:22:35 INFO - Cleaning up... 08:22:35 INFO - Return code: 0 08:22:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:22:35 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')]} 08:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:35 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')]} 08:22:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:35 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 0x237b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263a3b0>, '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 0x263b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263b740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1470842536.966785-1805859118', '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 08:22:35 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 08:22:35 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 08:22:35 INFO - Using env: {'DISPLAY': ':0', 08:22:35 INFO - 'HOME': '/home/cltbld', 08:22:35 INFO - 'LANG': 'en_US.UTF-8', 08:22:35 INFO - 'LANGUAGE': 'en_US:en', 08:22:35 INFO - 'LOGNAME': 'cltbld', 08:22:35 INFO - 'MAIL': '/var/mail/cltbld', 08:22:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:35 INFO - 'MOZ_NO_REMOTE': '1', 08:22:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:35 INFO - 'NO_EM_RESTART': '1', 08:22:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:35 INFO - 'PWD': '/builds/slave/test', 08:22:35 INFO - 'SHELL': '/bin/bash', 08:22:35 INFO - 'SHLVL': '1', 08:22:35 INFO - 'TERM': 'linux', 08:22:35 INFO - 'TMOUT': '86400', 08:22:35 INFO - 'USER': 'cltbld', 08:22:35 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1470842536.966785-1805859118', 08:22:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:35 INFO - '_': '/tools/buildbot/bin/python'} 08:22:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:35 INFO - Downloading/unpacking jsonschema==2.5.1 08:22:35 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 08:22:35 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 08:22:35 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 08:22:35 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 08:22:35 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 08:22:35 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 08:22:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:22:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:22: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 08:22: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 08:22: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 08:22: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 08:22: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 08:22: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 08:22:37 INFO - Downloading functools32-3.2.3-2.tar.gz 08:22:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:22:37 INFO - warning: no files found matching '*.txt' 08:22:37 INFO - no previously-included directories found matching 'build' 08:22:37 INFO - no previously-included directories found matching 'dist' 08:22:37 INFO - no previously-included directories found matching '.git*' 08:22:37 INFO - Installing collected packages: jsonschema, functools32 08:22:37 INFO - Running setup.py install for functools32 08:22:37 INFO - warning: no files found matching '*.txt' 08:22:37 INFO - no previously-included directories found matching 'build' 08:22:37 INFO - no previously-included directories found matching 'dist' 08:22:37 INFO - no previously-included directories found matching '.git*' 08:22:37 INFO - Successfully installed jsonschema functools32 08:22:37 INFO - Cleaning up... 08:22:37 INFO - Return code: 0 08:22:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:22: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')]} 08:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22: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')]} 08:22:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22: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 0x237b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263a3b0>, '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 0x263b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263b740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1470842536.966785-1805859118', '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 08:22: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 08:22: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 08:22:37 INFO - Using env: {'DISPLAY': ':0', 08:22:37 INFO - 'HOME': '/home/cltbld', 08:22:37 INFO - 'LANG': 'en_US.UTF-8', 08:22:37 INFO - 'LANGUAGE': 'en_US:en', 08:22:37 INFO - 'LOGNAME': 'cltbld', 08:22:37 INFO - 'MAIL': '/var/mail/cltbld', 08:22:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:37 INFO - 'MOZ_NO_REMOTE': '1', 08:22:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:37 INFO - 'NO_EM_RESTART': '1', 08:22:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:37 INFO - 'PWD': '/builds/slave/test', 08:22:37 INFO - 'SHELL': '/bin/bash', 08:22:37 INFO - 'SHLVL': '1', 08:22:37 INFO - 'TERM': 'linux', 08:22:37 INFO - 'TMOUT': '86400', 08:22:37 INFO - 'USER': 'cltbld', 08:22:37 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1470842536.966785-1805859118', 08:22:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:37 INFO - '_': '/tools/buildbot/bin/python'} 08:22:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:22:37 INFO - Cleaning up... 08:22:37 INFO - Return code: 0 08:22:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:22: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')]} 08:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22: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')]} 08:22:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22: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 0x237b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263a3b0>, '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 0x263b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263b740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1470842536.966785-1805859118', '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 08:22: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 08:22: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 08:22:37 INFO - Using env: {'DISPLAY': ':0', 08:22:37 INFO - 'HOME': '/home/cltbld', 08:22:37 INFO - 'LANG': 'en_US.UTF-8', 08:22:37 INFO - 'LANGUAGE': 'en_US:en', 08:22:37 INFO - 'LOGNAME': 'cltbld', 08:22:37 INFO - 'MAIL': '/var/mail/cltbld', 08:22:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:37 INFO - 'MOZ_NO_REMOTE': '1', 08:22:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:37 INFO - 'NO_EM_RESTART': '1', 08:22:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:37 INFO - 'PWD': '/builds/slave/test', 08:22:37 INFO - 'SHELL': '/bin/bash', 08:22:37 INFO - 'SHLVL': '1', 08:22:37 INFO - 'TERM': 'linux', 08:22:37 INFO - 'TMOUT': '86400', 08:22:37 INFO - 'USER': 'cltbld', 08:22:37 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1470842536.966785-1805859118', 08:22:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:37 INFO - '_': '/tools/buildbot/bin/python'} 08:22:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:38 INFO - Downloading/unpacking blobuploader==1.2.4 08:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:39 INFO - Downloading blobuploader-1.2.4.tar.gz 08:22:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:22:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:22:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:40 INFO - Downloading docopt-0.6.1.tar.gz 08:22:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:22:40 INFO - Installing collected packages: blobuploader, requests, docopt 08:22:40 INFO - Running setup.py install for blobuploader 08:22:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:22:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:22:40 INFO - Running setup.py install for requests 08:22:41 INFO - Running setup.py install for docopt 08:22:41 INFO - Successfully installed blobuploader requests docopt 08:22:41 INFO - Cleaning up... 08:22:41 INFO - Return code: 0 08:22:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:41 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 0x237b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263a3b0>, '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 0x263b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263b740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1470842536.966785-1805859118', '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 08:22:41 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 08:22:41 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 08:22:41 INFO - Using env: {'DISPLAY': ':0', 08:22:41 INFO - 'HOME': '/home/cltbld', 08:22:41 INFO - 'LANG': 'en_US.UTF-8', 08:22:41 INFO - 'LANGUAGE': 'en_US:en', 08:22:41 INFO - 'LOGNAME': 'cltbld', 08:22:41 INFO - 'MAIL': '/var/mail/cltbld', 08:22:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:41 INFO - 'MOZ_NO_REMOTE': '1', 08:22:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:41 INFO - 'NO_EM_RESTART': '1', 08:22:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:41 INFO - 'PWD': '/builds/slave/test', 08:22:41 INFO - 'SHELL': '/bin/bash', 08:22:41 INFO - 'SHLVL': '1', 08:22:41 INFO - 'TERM': 'linux', 08:22:41 INFO - 'TMOUT': '86400', 08:22:41 INFO - 'USER': 'cltbld', 08:22:41 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1470842536.966785-1805859118', 08:22:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:41 INFO - '_': '/tools/buildbot/bin/python'} 08:22:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:22:41 INFO - Running setup.py (path:/tmp/pip-b9Wwt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:22:41 INFO - Running setup.py (path:/tmp/pip-KyMuWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:22:41 INFO - Running setup.py (path:/tmp/pip-EGzqYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:22:41 INFO - Running setup.py (path:/tmp/pip-XEgwNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:22:41 INFO - Running setup.py (path:/tmp/pip-h67OSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:22:41 INFO - Running setup.py (path:/tmp/pip-gVMuEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:22:41 INFO - Running setup.py (path:/tmp/pip-O2qu6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:22:42 INFO - Running setup.py (path:/tmp/pip-umjEvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:22:42 INFO - Running setup.py (path:/tmp/pip-jwM7uM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:22:42 INFO - Running setup.py (path:/tmp/pip-5UGbpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:22:42 INFO - Running setup.py (path:/tmp/pip-GMJUVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:22:42 INFO - Running setup.py (path:/tmp/pip-9rkiKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:22:42 INFO - Running setup.py (path:/tmp/pip-YyJngK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:22:42 INFO - Running setup.py (path:/tmp/pip-wVL8j1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:42 INFO - Running setup.py (path:/tmp/pip-Ntvbfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:22:42 INFO - Running setup.py (path:/tmp/pip-i2DlxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:22:42 INFO - Running setup.py (path:/tmp/pip-q94A5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:22:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:22:42 INFO - Running setup.py install for manifestparser 08:22:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:22:42 INFO - Running setup.py install for mozcrash 08:22:42 INFO - Running setup.py install for mozdebug 08:22:43 INFO - Running setup.py install for mozdevice 08:22:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:22:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:22:43 INFO - Running setup.py install for mozfile 08:22:43 INFO - Running setup.py install for mozhttpd 08:22:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:22:43 INFO - Running setup.py install for mozinfo 08:22:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:22:43 INFO - Running setup.py install for mozInstall 08:22:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:22:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:22:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:22:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:22:43 INFO - Running setup.py install for mozleak 08:22:43 INFO - Running setup.py install for mozlog 08:22:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:22:43 INFO - Running setup.py install for moznetwork 08:22:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:22:43 INFO - Running setup.py install for mozprocess 08:22:44 INFO - Running setup.py install for mozprofile 08:22:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:22:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:22:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:22:44 INFO - Running setup.py install for mozrunner 08:22:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:22:44 INFO - Running setup.py install for mozscreenshot 08:22:44 INFO - Running setup.py install for moztest 08:22:44 INFO - Running setup.py install for mozversion 08:22:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:22:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:22:44 INFO - Cleaning up... 08:22:44 INFO - Return code: 0 08:22:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:22:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:44 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 0x237b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263a3b0>, '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 0x263b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263b740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1470842536.966785-1805859118', '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 08:22:44 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 08:22:44 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 08:22:44 INFO - Using env: {'DISPLAY': ':0', 08:22:44 INFO - 'HOME': '/home/cltbld', 08:22:44 INFO - 'LANG': 'en_US.UTF-8', 08:22:44 INFO - 'LANGUAGE': 'en_US:en', 08:22:44 INFO - 'LOGNAME': 'cltbld', 08:22:44 INFO - 'MAIL': '/var/mail/cltbld', 08:22:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:44 INFO - 'MOZ_NO_REMOTE': '1', 08:22:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:44 INFO - 'NO_EM_RESTART': '1', 08:22:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:44 INFO - 'PWD': '/builds/slave/test', 08:22:44 INFO - 'SHELL': '/bin/bash', 08:22:44 INFO - 'SHLVL': '1', 08:22:44 INFO - 'TERM': 'linux', 08:22:44 INFO - 'TMOUT': '86400', 08:22:44 INFO - 'USER': 'cltbld', 08:22:44 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1470842536.966785-1805859118', 08:22:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:44 INFO - '_': '/tools/buildbot/bin/python'} 08:22:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:22:44 INFO - Running setup.py (path:/tmp/pip-2RRY9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:22: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)) 08:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:22:44 INFO - Running setup.py (path:/tmp/pip-LdL08W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:22: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)) 08:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:22:44 INFO - Running setup.py (path:/tmp/pip-302PSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:22:45 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)) 08:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:22:45 INFO - Running setup.py (path:/tmp/pip-RSl6ld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:22:45 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)) 08:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:22:45 INFO - Running setup.py (path:/tmp/pip-Az9lt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:22:45 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)) 08:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:22:45 INFO - Running setup.py (path:/tmp/pip-FKCyjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:22:45 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)) 08:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:22:45 INFO - Running setup.py (path:/tmp/pip-EsKdWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:22:45 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)) 08:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:22:45 INFO - Running setup.py (path:/tmp/pip-9IjCTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:22:45 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)) 08:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:22:45 INFO - Running setup.py (path:/tmp/pip-NprPK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:22:45 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)) 08:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:22:45 INFO - Running setup.py (path:/tmp/pip-kkCwoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:22:45 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)) 08:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:22:45 INFO - Running setup.py (path:/tmp/pip-pmze6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:22:45 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)) 08:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:22:45 INFO - Running setup.py (path:/tmp/pip-jI9gPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:22:45 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)) 08:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:22:45 INFO - Running setup.py (path:/tmp/pip-ZyFZd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:22: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)) 08:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:22:45 INFO - Running setup.py (path:/tmp/pip-CFpsVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:22: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)) 08:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:45 INFO - Running setup.py (path:/tmp/pip-KjhIi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:22: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)) 08:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:22:45 INFO - Running setup.py (path:/tmp/pip-OOqzmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:22: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)) 08:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:22:45 INFO - Running setup.py (path:/tmp/pip-vWpf56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:22:46 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)) 08:22:46 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)) 08:22:46 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)) 08:22:46 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)) 08:22:46 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)) 08:22:46 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)) 08:22:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:22:46 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 08:22:46 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 08:22:46 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 08:22:46 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 08:22:46 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 08:22:46 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 08:22:47 INFO - Downloading blessings-1.6.tar.gz 08:22:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:22:48 INFO - Installing collected packages: blessings 08:22:48 INFO - Running setup.py install for blessings 08:22:48 INFO - Successfully installed blessings 08:22:48 INFO - Cleaning up... 08:22:48 INFO - Return code: 0 08:22:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:22:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:22:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:22:48 INFO - Reading from file tmpfile_stdout 08:22:48 INFO - Current package versions: 08:22:48 INFO - argparse == 1.2.1 08:22:48 INFO - blessings == 1.6 08:22:48 INFO - blobuploader == 1.2.4 08:22:48 INFO - docopt == 0.6.1 08:22:48 INFO - functools32 == 3.2.3-2 08:22:48 INFO - jsonschema == 2.5.1 08:22:48 INFO - manifestparser == 1.1 08:22:48 INFO - mozInstall == 1.12 08:22:48 INFO - mozcrash == 0.17 08:22:48 INFO - mozdebug == 0.1 08:22:48 INFO - mozdevice == 0.48 08:22:48 INFO - mozfile == 1.2 08:22:48 INFO - mozhttpd == 0.7 08:22:48 INFO - mozinfo == 0.9 08:22:48 INFO - mozleak == 0.1 08:22:48 INFO - mozlog == 3.3 08:22:48 INFO - moznetwork == 0.27 08:22:48 INFO - mozprocess == 0.23 08:22:48 INFO - mozprofile == 0.28 08:22:48 INFO - mozrunner == 6.12 08:22:48 INFO - mozscreenshot == 0.1 08:22:48 INFO - mozsystemmonitor == 0.3 08:22:48 INFO - moztest == 0.7 08:22:48 INFO - mozversion == 1.4 08:22:48 INFO - psutil == 3.1.1 08:22:48 INFO - requests == 1.2.3 08:22:48 INFO - wsgiref == 0.1.2 08:22:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:22:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:48 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 0x237b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263a3b0>, '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 0x263b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263b740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1470842536.966785-1805859118', '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 08:22:48 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 08:22:48 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 08:22:48 INFO - Using env: {'DISPLAY': ':0', 08:22:48 INFO - 'HOME': '/home/cltbld', 08:22:48 INFO - 'LANG': 'en_US.UTF-8', 08:22:48 INFO - 'LANGUAGE': 'en_US:en', 08:22:48 INFO - 'LOGNAME': 'cltbld', 08:22:48 INFO - 'MAIL': '/var/mail/cltbld', 08:22:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:48 INFO - 'MOZ_NO_REMOTE': '1', 08:22:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:48 INFO - 'NO_EM_RESTART': '1', 08:22:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:48 INFO - 'PWD': '/builds/slave/test', 08:22:48 INFO - 'SHELL': '/bin/bash', 08:22:48 INFO - 'SHLVL': '1', 08:22:48 INFO - 'TERM': 'linux', 08:22:48 INFO - 'TMOUT': '86400', 08:22:48 INFO - 'USER': 'cltbld', 08:22:48 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1470842536.966785-1805859118', 08:22:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:48 INFO - '_': '/tools/buildbot/bin/python'} 08:22:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:48 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)) 08:22:48 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)) 08:22:48 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)) 08:22:48 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)) 08:22:48 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)) 08:22:48 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)) 08:22:48 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)) 08:22:48 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)) 08:22:48 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)) 08:22:48 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)) 08:22:48 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)) 08:22:48 INFO - Cleaning up... 08:22:48 INFO - Return code: 0 08:22:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:22:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:48 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 0x237b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263a3b0>, '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 0x263b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263b740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1470842536.966785-1805859118', '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 08:22:48 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 08:22:48 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 08:22:48 INFO - Using env: {'DISPLAY': ':0', 08:22:48 INFO - 'HOME': '/home/cltbld', 08:22:48 INFO - 'LANG': 'en_US.UTF-8', 08:22:48 INFO - 'LANGUAGE': 'en_US:en', 08:22:48 INFO - 'LOGNAME': 'cltbld', 08:22:48 INFO - 'MAIL': '/var/mail/cltbld', 08:22:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:48 INFO - 'MOZ_NO_REMOTE': '1', 08:22:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:48 INFO - 'NO_EM_RESTART': '1', 08:22:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:48 INFO - 'PWD': '/builds/slave/test', 08:22:48 INFO - 'SHELL': '/bin/bash', 08:22:48 INFO - 'SHLVL': '1', 08:22:48 INFO - 'TERM': 'linux', 08:22:48 INFO - 'TMOUT': '86400', 08:22:48 INFO - 'USER': 'cltbld', 08:22:48 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1470842536.966785-1805859118', 08:22:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:48 INFO - '_': '/tools/buildbot/bin/python'} 08:22:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:22:48 INFO - Cleaning up... 08:22:48 INFO - Return code: 0 08:22:48 INFO - Running post-action listener: _resource_record_post_action 08:22:48 INFO - Running post-action listener: _start_resource_monitoring 08:22:48 INFO - Starting resource monitoring. 08:22:48 INFO - [mozharness: 2016-08-10 15:22:48.883132Z] Finished create-virtualenv step (success) 08:22:48 INFO - [mozharness: 2016-08-10 15:22:48.883613Z] Running install step. 08:22:48 INFO - Running pre-action listener: _resource_record_pre_action 08:22:48 INFO - Running main action method: install 08:22:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:22:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:22:49 INFO - Reading from file tmpfile_stdout 08:22:49 INFO - Detecting whether we're running mozinstall >=1.0... 08:22:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:22:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:22:49 INFO - Reading from file tmpfile_stdout 08:22:49 INFO - Output received: 08:22:49 INFO - Usage: mozinstall [options] installer 08:22:49 INFO - Options: 08:22:49 INFO - -h, --help show this help message and exit 08:22:49 INFO - -d DEST, --destination=DEST 08:22:49 INFO - Directory to install application into. [default: 08:22:49 INFO - "/builds/slave/test"] 08:22:49 INFO - --app=APP Application being installed. [default: firefox] 08:22:49 INFO - mkdir: /builds/slave/test/build/application 08:22:49 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'] 08:22:49 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 08:23:06 INFO - Reading from file tmpfile_stdout 08:23:06 INFO - Output received: 08:23:06 INFO - /builds/slave/test/build/application/firefox/firefox 08:23:06 INFO - Running post-action listener: _resource_record_post_action 08:23:06 INFO - [mozharness: 2016-08-10 15:23:06.087646Z] Finished install step (success) 08:23:06 INFO - [mozharness: 2016-08-10 15:23:06.087894Z] Running run-tests step. 08:23:06 INFO - Running pre-action listener: _resource_record_pre_action 08:23:06 INFO - Running main action method: run_tests 08:23:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:23:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:23:06 INFO - Python 2.7.3 08:23:06 INFO - Return code: 0 08:23:06 INFO - grabbing minidump binary from tooltool 08:23:06 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')]} 08:23:06 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 0x263a3b0>, '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 0x263b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263b740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:23:06 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 08:23:06 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 08:23:06 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 08:23:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:23:06 INFO - Return code: 0 08:23:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:23:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:23:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:23:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:23:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:23:06 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/FUTGxNqCQtKlN2KsnAPyTQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 08:23:06 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/FUTGxNqCQtKlN2KsnAPyTQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 08:23:06 INFO - Using env: {'DISPLAY': ':0', 08:23:06 INFO - 'HOME': '/home/cltbld', 08:23:06 INFO - 'LANG': 'en_US.UTF-8', 08:23:06 INFO - 'LANGUAGE': 'en_US:en', 08:23:06 INFO - 'LOGNAME': 'cltbld', 08:23:06 INFO - 'MAIL': '/var/mail/cltbld', 08:23:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:23:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:23:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:06 INFO - 'MOZ_NO_REMOTE': '1', 08:23:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:23:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:06 INFO - 'NO_EM_RESTART': '1', 08:23:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:06 INFO - 'PWD': '/builds/slave/test', 08:23:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:23:06 INFO - 'SHELL': '/bin/bash', 08:23:06 INFO - 'SHLVL': '1', 08:23:06 INFO - 'TERM': 'linux', 08:23:06 INFO - 'TMOUT': '86400', 08:23:06 INFO - 'USER': 'cltbld', 08:23:06 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1470842536.966785-1805859118', 08:23:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:06 INFO - '_': '/tools/buildbot/bin/python'} 08:23:06 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/FUTGxNqCQtKlN2KsnAPyTQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 08:23:06 INFO - mozversion application_buildid: 20160810053005 08:23:06 INFO - mozversion application_changeset: 2f24daceada71e15c03b5f90765264c720ed035a 08:23:06 INFO - mozversion application_display_name: Nightly 08:23:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:23:06 INFO - mozversion application_name: Firefox 08:23:06 INFO - mozversion application_remotingname: firefox 08:23:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:23:06 INFO - mozversion application_vendor: Mozilla 08:23:06 INFO - mozversion application_version: 51.0a1 08:23:06 INFO - mozversion platform_buildid: 20160810053005 08:23:06 INFO - mozversion platform_changeset: 2f24daceada71e15c03b5f90765264c720ed035a 08:23:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:23:06 INFO - mozversion platform_version: 51.0a1 08:23:06 INFO - using testdate: 1470842586 08:23:06 INFO - actual date: 1470842586 08:23:06 INFO - starting webserver on 'localhost:54021' 08:23:06 INFO - SUITE-START | Running 2 tests 08:23:06 INFO - TEST-START | dromaeo_css 08:23:06 INFO - operating with platform_type : linux_ 08:23:06 INFO - Initialising browser for dromaeo_css test... 08:23:06 INFO - TEST-INFO | started process 20172 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGzlG7F/profile http://localhost:54021/getInfo.html) 08:23:10 INFO - PROCESS | 20172 | __metrics Screen width/height:1600/1200 08:23:10 INFO - PROCESS | 20172 | colorDepth:24 08:23:10 INFO - PROCESS | 20172 | Browser inner width/height: 1024/697 08:23:10 INFO - PROCESS | 20172 | __metrics 08:23:11 INFO - PROCESS | 20172 | 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" 08:23:11 INFO - PROCESS | 20172 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:23:12 INFO - TEST-INFO | 20172: exit 0 08:23:12 INFO - Browser initialized. 08:23:12 INFO - Running cycle 1/1 for dromaeo_css test... 08:23:12 INFO - TEST-INFO | started process 20254 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGzlG7F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:23:23 INFO - PROCESS | 20254 | RSS: Main: 155815936 08:23:23 INFO - PROCESS | 20254 | 08:24:14 INFO - PROCESS | 20254 | 1470842654677 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] 08:26:25 INFO - PROCESS | 20254 | Cycle 1(1): loaded http://localhost:54021/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54021/tests/dromaeo/cssquery-ext.html) 08:26:26 INFO - PROCESS | 20254 | RSS: Main: 264310784 08:26:26 INFO - PROCESS | 20254 | 08:29:28 INFO - PROCESS | 20254 | Cycle 1(1): loaded http://localhost:54021/tests/dromaeo/cssquery-ext.html (next: http://localhost:54021/tests/dromaeo/cssquery-jquery.html) 08:29:29 INFO - PROCESS | 20254 | RSS: Main: 250646528 08:29:29 INFO - PROCESS | 20254 | 08:32:31 INFO - PROCESS | 20254 | Cycle 1(1): loaded http://localhost:54021/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54021/tests/dromaeo/cssquery-mootools.html) 08:32:31 INFO - PROCESS | 20254 | RSS: Main: 226058240 08:32:31 INFO - PROCESS | 20254 | 08:35:33 INFO - PROCESS | 20254 | Cycle 1(1): loaded http://localhost:54021/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54021/tests/dromaeo/cssquery-prototype.html) 08:35:34 INFO - PROCESS | 20254 | RSS: Main: 236040192 08:35:34 INFO - PROCESS | 20254 | 08:38:36 INFO - PROCESS | 20254 | Cycle 1(1): loaded http://localhost:54021/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54021/tests/dromaeo/cssquery-yui.html) 08:38:37 INFO - PROCESS | 20254 | RSS: Main: 186572800 08:38:37 INFO - PROCESS | 20254 | 08:41:40 INFO - PROCESS | 20254 | Cycle 1(1): loaded http://localhost:54021/tests/dromaeo/cssquery-yui.html (next: http://localhost:54021/tests/dromaeo/cssquery-dojo.html) 08:41:40 INFO - PROCESS | 20254 | RSS: Main: 274296832 08:41:40 INFO - PROCESS | 20254 | 08:41:40 INFO - PROCESS | 20254 | __start_tp_report 08:41:40 INFO - PROCESS | 20254 | _x_x_mozilla_page_load 08:41:40 INFO - PROCESS | 20254 | _x_x_mozilla_page_load_details 08:41:40 INFO - PROCESS | 20254 | |i|pagename|runs| 08:41:40 INFO - PROCESS | 20254 | |0;dojo.html;3075.400296942096;3082.5530298106773;3114.190310519265;3144.3868445653106;3161.6364118126407;5249.028929648018;5315.760790764415;5438.401775804663;5522.0888553388695;5561.499465048139;5459.153831156167;5518.6688798672;5544.750486228119;5567.860803479915;5590.692511911843;4899;4940.654154209206;5008.323876276692;5008.474110218429;5165.354330708661;5082.2376643503585;5114.820981265657;5142.794288228466;5146.485351464861;5149.047426226141;4779.498152693969;4796.784144713496;4914.066327397783;4985.152524070917;5009.499050094998;4883.316335713003;4897.926531102036;4901.901961960741;4964.67729597575;5057.2666963290485;4904.901901961941;4928.272907481298;4931.408231012301;4972.328735620681;4990.201567749143;5247.029299579552;5343.465653434664;5394.8921021579745;5446.700431476267;5503.229547863302;5869.207656966298;5871.031279838821;5913.881722365529;5918.674472903988;5926.881462370771;5966.552508561832;5970.402959704038;5970.402959704038;5974.312954010301;5977.432143946318;5281.049411106;5403.378611459732;5427.782888684487;5437.700926449004;5525.281713377275;6021;6027.21646185993;6074.574779765462;6078.544109191828;6085.391460853879;5774.682392468455;5778.971105144447;5823.330317013598;5832.62087964281;5833;5647.604667673306;5674.517665998354;5723.713814309268;5738.5982981191755;5923.08192230205;5760.135979603093;5765.4522820332;5808.128780682931;5808.128780682931;5811.593188476766;5714.628549144292;5718.342390625131;5768.134779782982;5773.913391299134;5776.104703770922;4345.891352716144;4429.645628349725;4444.400005999149;4459.955400445954;4486.327050942385;4000.439938408625;4024.6981476389387;4053.5135783706146;4067.084905896209;4087.4890638670167;5575.832725018256;5576.804811831647;5587.05020146576;5590.748416321194;5657.2079908811975;5611.102223644198;5836.212111364996;5984.431479009487;6002.279726432856;6008.309044459856;5525.11598144295;5581.972090139523;5582.162675598693;5621.100623900238;5624;5108;5114.616403769732;5116.079105760999;5116.692998420107;5156.845294641167;5864.853378665567;6017.969910150597;6193.752249910043;6205.162303089115;6209.565330426917;5844.532437405082;5873.5594830388745;5924.140999555127;5970.283565972111;5976.372480889618;6120.693965301806;6122.265328160649;6125.663088530174;6127.509799215963;6132.693365331805;5533.446655334435;5664.546836253172;5726.570507212059;5783.971080144741;5790;5798.246227990334;5800.01399762033;5838.065909454467;5881.852953676193;5889.734961926809;5762.30852297727;5762.30852297727;5767.596268261182;5771.394003629558;5772.336181339199;5529.834104976857;5663.66018038919;5762.933857236425;5764.884702305846;5769.94230057694;5618.7190640467;5696.9715151425635;5706.543476521952;5750.30996280449;5751.1085781703905;5799.5070419014855;5814.04068328738;5849.093390524476;5849.976254155421;5859.794907178399;5404.378496472956;5508.531774799187;5666.914996274977;5668.121441176624;5670.914936276042 08:41:40 INFO - PROCESS | 20254 | |1;ext.html;581.215359264992;588.2470437839567;591.9141724449955;602.0457574744031;623.6569886562389;42615.78692106539;43992.3401148983;44090;44190;48135.51864481354;45617.54382456175;45845.54154458454;46033.07933841321;46113;46126.30810537836;9048.41185322952;9190.632374705005;9198.908010919871;9200.631974721004;9203.493807840567;9058.275337972946;9146.359754817133;9153.771155721093;9155.72532824013;9156;9209;9244.722658320261;9253.6298548058;9256.907430925705;9281.907180928172;9152;9173.128552787475;9203.033681463417;9209.079092090804;9214.354995150308;9081.683155942417;9166.358354915159;9174.220191283748;9178.4034037788;9181.173694367539;42797;42940.14119717619;43111.78444107791;43137.35293970593;43237.13525729468;3404.1829960809473;3588.3182195383056;3831.4252862070634;3899.610038996106;4141.937870931938;32856.178595535064;32867.67132328694;33165.336693266;33208.16979575506;35050.123746906276;4057.8579749708915;4148.605882441193;4172.290710579209;4174.519930208005;4319.481662200525;359088;361189;361750;361994;362136;59834;59915;59966;60273.397266027656;60326;63208.683956579924;63214.68392658007;63406;63535.68232158902;63637.36362636407;16511.917440412722;16727.080010599533;16735.163241837858;16743.66512669764;16756.748648770277;12363.814542781865;12427.75144497105;12439.689007774878;12448.377581120907;12450.626481205578;16051.518454446385;17442.65114697699;17588.504977076835;17716.645667086585;17849.10754462272;6429.935700643027;6436.967815160894;6440.259370172396;6656.201255849329;6883.862322753517;951.2342564235719;1016.8271393863062;1025.958961641541;1044.5508431374583;1048.570086264628;31959.520607190912;32127.23499758633;32218.106563891528;32667.67332326694;32864.835675821465;1042.8748550174028;1054.0671505717341;1105.4583254205381;1111.5331560744507;1166.2128063557066;16435.09606971604;17001.40495082691;17074.57313567146;17089.401870934456;17090.829091709173;545997;547219;548418;548463;549174;59370;59592;59636.403635963085;59712.70143649341;59718;1202.4709127983658;1252.7056141806668;1317.433503593464;1339.5914246155016;1377.0498356134235;28616.141515753727;31651.36697265996;31761.523577146825;32181;32816;50957.490425095275;51279.230811538604;51404.22893656523;51465.7426712864;51507.22739158841;406314;407525;408368;408687;409051;43010.784946075066;43534;43940.56059439493;44220.55779442164;44246.336304954806;48126.75936620295;48642.75678621584;48765.51234487752;48872;50171.24743128783;41027.58972410238;41104;41636.58363416448;42090.57909420989;43512.34731478967;42169.578304216564;42281.365779513944;42589.787051064544;42650.360244596974;42842;41004.38493422541;41933.79033104815;42229.5777042238;42857.35713964231;42984.140317194106;34956.30087398187;37482.62517374791;37559.81220093882;37586.43620345752;38564;28491.28771780722;28515.144545663665;28521.572176416954;28612.856935715186;28666.85666571654 08:41:40 INFO - PROCESS | 20254 | |2;jquery.html;358.21372088266236;384.8768394113884;393.7361967481787;394.7098882321494;411.1694377357737;14632.122072675633;16716.33134674613;19240.3265885694;19842.603147937032;19861.900690496564;18847.24611015561;18895.716564251547;18938.053097345113;18993.33523326684;19141.808581914178;4095.7337773044655;5647.689377084259;5835.533157347423;5837.357890632027;5841.678707671076;6219.409156130183;6483.254425741029;6541.378569035958;6665.966670166642;6669.766558170465;6331.873362532747;6483.15718956535;6520.152380190569;6618.404343609074;6626.469882409396;6350.301466838644;6476.4818814494965;6520;6534.60792352458;6546.410823025903;5746.166805813134;5798.594098413113;5805.3323867755325;5808.680522571257;5809;19007.334743284056;20528.486787830276;23500.647490287658;23551.528969420688;23811;2169.1973969631335;2402.699662542182;2566.9860405140053;2772.9306767330777;2962.244627619943;5928.555358348141;5960.701964901781;6035.818925432244;8456.450330728483;10192.235582331356;1906.761654793151;1916.7508223930938;1942.5430926804897;1943.9514012149668;1973.940781776549;81703;82097;83381.99999999939;85113.57443212807;85176.57411712964;10972.147241717052;11062.446877656084;11076.778464430667;11083.612073577386;11363.488643011084;15613.063216207063;15642.45251416195;15670.921645391929;15680.05919644802;15704.136272505122;8010.559419231999;8235.670573177125;8297.294729948022;8346.123657016047;8377.078521362646;7805.531668099932;7862.33170180541;7872.274250958993;8092.83814323722;8142.633581488847;4695.413073365829;4755.405574303212;4764.309175169581;4891.755412229374;4910.803567857246;1936.244864502845;2019.384087853219;2042.5404284035974;2061.8969051547365;2074;908.4912449028565;962.4658314635444;1012.767063575367;1043.3114144664485;1092.6175838456477;19412.611747764964;19445;19657.311994080137;19671.704924426143;20069.79930200679;958.2094771813282;1007.0835539658875;1013.5489707080426;1027.9383237005804;1038.714353552764;10355.741106472398;10908.61819836302;11051.447427628586;11070.335779853234;11086.16853735973;497250;525020;529070;531429;532846;49175.50824491781;49840.501594984315;96485;99322;101009.49495252476;927.9118483744033;979.9461029643295;1008.193445243802;1009.7576581620358;1010.2726037253166;16172.272247748644;16492.34030638761;17266.22301996388;17302.826971730123;17328.653426931643;34488.655113449546;37829.05427364338;40859.38710919398;41282.587174127875;42666;58000.12999805091;58586;58796.4120358791;60474;60902.69548652229;5516.558675306046;8084.393670474856;8217;8289.502629842229;8383.916160838558;9426.293028023063;12226.388680565758;12740.362981850685;12957.870421295667;13281.867181328063;11105.777884442105;11154.442277885912;11280.605178818701;11385.544578216779;11599.6520104397;11048.226624136234;11422.94288528552;11482.253653512495;11623.186376953532;12023.27860328383;10929.836052459379;11170.27393219438;11325.546978120783;11395.948729228818;11654.067674586182;8139.593020348841;8172.305354044973;8179.67281308741;8197.344212463107;8439.789005274917;9242.953785231031;9830.606775728891;10399.532021059222;10801.405922674014;10894.50974706156 08:41:40 INFO - PROCESS | 20254 | |3;mootools.html;1425.2873563218388;1483;1568.4040064775384;1711.7432385142235;1760.181515595248;8688.435251708635;9484.288678349118;9484.715458536246;9487.241020718344;9494.28792840537;7258.782236532912;8808.867866982;9076.31927605429;9097.135772101656;9218.262538996882;2296.196331284054;2323.6514522821626;2327.3832434404812;2327.615943369342;2327.813774898004;2257.8645281283093;2277.954440911181;2301.470661747799;2306.907723691059;2316.791488766011;2371.087131454394;2387.928362149138;2392.808575313971;2395.9041638334447;2399.8320117591775;2322.454223257533;2337.6610391493223;2343.7656234376595;2344.0623750499767;2371.3004663624274;2330.242671131889;2337.8480398774027;2340.3797993531557;2341.1571834139695;2342.7774361435636;9194.81610367789;9380.390274632127;9391;9393.107654772786;9398.154166125081;5004.974975125101;5037.395512538482;5120.15517439622;5131.820386286462;5157.8452646420665;3392.796432214075;3490.5462289902403;3571.624979377154;3576.0165954362496;3583.8566457341676;1098.280626189847;1105.1269497097283;1140.5836869542557;1145.3872178384524;1147.0536807134147;13218.471261149543;13259.86740132596;13284.070115091947;13294.401751921187;13310.800337994939;4492.842750503717;4635.351050852883;4751.95248047522;4753.928691069636;4762.618990480753;10959.178061645249;10990.670279891616;10995.725106872233;10997.450127493754;10999.945000274947;5273.419923808378;5279.023380674587;5279.736013199325;5284.048871203144;5285.68285902847;3984.880453586397;4761.333413322138;4846.442659094178;4847.175980083394;4880.023995200974;4115.947450544178;4133.958660413357;4170.040081161849;4243.511996120424;4244.915101697949;1261.703499677575;1265.8987281017496;1279.2260682287083;1280.6734282757836;1293.424426130363;880.903100658927;926.8007378413539;946.8485042393185;998.236349192868;1051.942143182117;5810.244668193108;6239.251289845248;6364.236291645032;6440.6135631862235;6621.172353455818;458.5620732200807;463.0854063225103;469.9882502937454;478.9568938795525;484.41627838454576;4138.420621113047;4288.849890253826;4300;4312.805923733439;4351.303791393425;11467.369294688871;11719.472623731952;11748.765024699458;11830.231034982871;11855.822162667568;11703.356315402734;11719.414029298501;11727.4136293185;11731.237469564621;11735.882641173479;8026.678932842621;8406.117357677478;8418.747437576883;8589.828203435896;8672.8699069514;6222.502199824094;6264.780732674334;6307.740371026028;6314.715837787218;6322;10298.691039268833;10591.788164236827;10634.30876993024;10637.308574942605;10676.519556619816;10603.575856965943;10615.31000484966;10790.244682872124;10792.56829726802;10844.728881777703;6594.934050659432;7854.72508462201;8023.558704271088;8032.959835200787;8163.918360816316;8866.468011919305;8994.505302208441;9061.54692265371;9073.047330030251;9092.09079092112;7757.1467138615835;7759.068911730628;7893.407994400558;8024.598770061591;8082.110967793656;7737.613119344122;7794.064712234568;7837.804054898673;7959.442839001214;8136.918630813616;7189.173245076883;7313.707451702086;7324.132346251672;7324.340809327186;7327.670254838652;5453.8091166810555;5459.535939445032;5508.091164957737;5510.173473978935;5593.188987596857;5381.327334083239;5402.702851343214;5412.621116521806;5418.864528386822;5547 08:41:40 INFO - PROCESS | 20254 | |4;prototype.html;286.7820456453095;296.04377859513784;325.5556165833637;325.6564324637508;331.772735676062;5300.284461597683;5361.142217245247;5374.247605335257;5377.381601115872;5398.649087809299;5063.797448102081;5163.941392014637;5185.792568297273;5240.68555886647;5352.437994010622;4074.164796216776;4087.9591204088024;4150.875473735793;4212.220739163249;4239.9576004240025;4173.227952828721;4197.895052623693;4199.202151591203;4209.515905670841;4212.978935105336;4069.9796501017454;4141.881691943174;4158.355454904495;4167.124903770212;4186.39297301891;4156.9192010077295;4175.645070169039;4179.644730197937;4183.937240941388;4184.970289409634;3703.925801551113;3724.348239058181;3730.6269373062746;3734.925301493955;3735.234276973214;4972.254161875711;5144.922826157611;5260.9736951315;5264.341957255343;5306.416294207634;4759.976200118977;4773.305476555807;4790.712557246541;4804.159272127364;4812.639052071108;5492.368377636583;5503.394626591072;5507.228987941691;5554.666719996772;5557.499825015728;3930.9017274568077;4070.5115386153557;4079.2045551117544;4090.3046482098116;4105.5894410559;5725.169850371714;5729.197912292282;5762.88474230513;5796.97101514494;5815.912761308584;4188.28799104153;4193.685473589493;4194.769287689206;4204.243236217449;4207.242696314693;3928.2929072767174;4246.490421149482;4256.723312984646;4256.9574304257185;4267.8292868284925;4691.132140554008;4734.73958932262;4750.14497390473;4771.5228477152;4803.423589169322;5641.210230567724;5641.392203222144;5654.6889921054735;5669.206311116447;5680.517156041783;1389.81932348794;1391.3599744117819;1397.706481638847;1404.0873432269107;1406.2546850169426;903.1690844423147;930.3580529434669;932.3333816321363;935.6678379175431;935.9578818953163;4756.906960937176;4776.44460213784;4789.144738485553;4805;4889.364382630235;4771.594414474739;5034.270030845507;5086.313347698014;5086.745662716849;5105.795768169306;4725.480197178307;4750.714957102585;4758.643101767381;4781.569658730731;4786.210275304606;2673.6364454128534;2687.897961835638;2689.287338855205;2690.8250963687296;2697.716739742338;5049.469805670426;5201.7919283229;5206.349206349207;5235.240890070919;5319.28189694394;5169.578365949394;5170.784865556591;5176;5216.417873152738;5250.3962044364625;5216.765245563959;5218.556422704037;5224.346956630421;5263.973525162633;5317.229001794718;4650.697704649187;4994.625403094855;5007.24891266313;5037.876516559756;5081.23781432788;4986.276989836526;5047.7476126192805;5051.621128415457;5054.7978080876355;5055.620828437808;5007.774650140679;5215.6529561696625;5222.97388513055;5246.68832791802;5255.185446255837;3690.6493883081066;3691.9630803692694;3700.37093694078;3726.5280214314653;3734.2531493700826;5056;5496.120620700669;5504.899020195897;5677.530274330679;5698.886022279614;5599.412061733459;5608.327000759935;5612.522935550524;5617.269754931833;5626.2967129108865;5428.945710543002;5548.69482178484;5568.470995255444;5608.214849921096;5614.2701448811395;5437.157240627709;5473.726313684379;5483.945160548344;5503.284573005483;5516.869041846332;5580.609357345109;5588.441155884379;5600;5610.326760788732;5615.326160860723;5301.23132145829;5468.726563671721;5470.577649810998;5505.146702261156;5505.834824955257 08:41:40 INFO - PROCESS | 20254 | |5;yui.html;715.7995761186867;748.1732685382649;757.8938948547201;795.1094773853285;834.7036801935311;15840.683186336266;17331.740023899634;17397.47807565775;17427.302907883703;17436.825631743694;15441;15528.5341439757;15543.533693989199;15552;15556.45552405666;654.7610122305348;774.9922500775004;795.3478147918709;801.4149670740363;806.6491076381764;804.6821505505322;805.923437273458;815.6900377856406;819.5697258939045;820.0323618130603;877.5612193903048;877.7454538183919;881.7619242804438;882.6248844241172;882.7616543533242;692.4183685703982;871.6339137562239;871.8735783311416;872.4416373520952;873.2315562305163;607.9057746049369;623.8378021714387;624.3444383397415;629.6788637794712;629.7292164369319;15327.233638318039;15396.23018849053;15980.360785568564;15985.52043438687;15998.360065597362;13935.303234838217;14239.857601423957;14582.854171458255;14808;14956;12291.819602790547;12468.75062498754;12618;12757.74484510314;13148.864642285287;4474.239379305526;4490.955090449086;4497.168023915586;4519.118771839492;4763;86041;86188;86624;86702.56648716779;90824;10624.840627390595;10925.289856159325;11031.558737650565;11083.168762342857;11099.667009989551;21157.25949591788;21192;21193.682094768592;21211.15155393767;21228.893855530623;8597.5701214939;8766.21104100634;9194.678186263449;9295.395799273025;9301.581428835718;4691.319758635047;4858.319835223072;4943.110240156734;4963.45402005779;5087.8982420351385;3241.546183534307;3299.818509981926;3323.1858194742445;3335.2995870866903;3335.4496508075895;557.275541795664;568.1534513574744;582.9737661805144;593.1784478497312;594.1829983772313;541.4991133201772;565.9009673307155;603.6559161278117;606.8118883146238;612.5773216480703;9210.95394523023;9569.330146889652;9594;9678.27412944032;10039.69880903574;571.7627184718378;596.8806238752267;638.1385130074456;663.8349696283088;724.7064938699835;4431.889202769957;4607.654425918069;4612.884677883079;4904.092742842586;5309.33633295838;117762;125501;128258.35870820587;129368;129837.35081324533;85826;88556;110827.44586277017;112313.43843280895;113425;85338.14661853426;87801.56099219463;88353;88375.55812220898;91445.99999999868;9265.814683706154;9631.566579503798;9686.225101991964;9719.85420218683;9882.209423246266;49520.50479495303;51047;51775.74112129415;51952.22071668853;52394.73802630963;73024.63487682528;74777.62611186909;76147.61926190334;76852;78099;13148.60554183376;13180.736385272432;13281.734365312834;13403.396847141707;13801.51694690681;14005.159690418608;14190.361433735301;14537.491187808377;14706.264686765833;15494.922525387301;13869.861301386856;14346.426142954166;14371;14543.92728036353;14860.369189946832;13078.607641770763;13286.734265314833;13354.131981421177;13715;14127.576172714835;13596.184228946295;13707.383167757276;13775.173489590657;13811.378487967864;15236.847631523542;11364.431778411212;11371.772564548828;11395.715107122389;11501.942490287494;11805.645830625095;9448.527573621153;9944.204463642747;10301.587936482756;10438.425886576311;10451.529681164518 08:41:40 INFO - PROCESS | 20254 | __end_tp_report 08:41:40 INFO - PROCESS | 20254 | __start_cc_report 08:41:40 INFO - PROCESS | 20254 | _x_x_mozilla_cycle_collect,1009 08:41:40 INFO - PROCESS | 20254 | __end_cc_report 08:41:40 INFO - PROCESS | 20254 | __startTimestamp1470843700669__endTimestamp 08:41:40 INFO - PROCESS | 20254 | 08:41:40 INFO - PROCESS | 20254 | ------- Summary: start ------- 08:41:40 INFO - PROCESS | 20254 | Number of tests: 6 08:41:40 INFO - PROCESS | 20254 | 08:41:40 INFO - PROCESS | 20254 | [#0] dojo.html Cycles:165 Average:5447.06 Median:5663.66 stddev:630.70 (11.1%) stddev-sans-first:604.57 08:41:40 INFO - PROCESS | 20254 | Values: 3075.4 3082.6 3114.2 3144.4 3161.6 5249.0 5315.8 5438.4 5522.1 5561.5 5459.2 5518.7 5544.8 5567.9 5590.7 4899.0 4940.7 5008.3 5008.5 5165.4 5082.2 5114.8 5142.8 5146.5 5149.0 4779.5 4796.8 4914.1 4985.2 5009.5 4883.3 4897.9 4901.9 4964.7 5057.3 4904.9 4928.3 4931.4 4972.3 4990.2 5247.0 5343.5 5394.9 5446.7 5503.2 5869.2 5871.0 5913.9 5918.7 5926.9 5966.6 5970.4 5970.4 5974.3 5977.4 5281.0 5403.4 5427.8 5437.7 5525.3 6021.0 6027.2 6074.6 6078.5 6085.4 5774.7 5779.0 5823.3 5832.6 5833.0 5647.6 5674.5 5723.7 5738.6 5923.1 5760.1 5765.5 5808.1 5808.1 5811.6 5714.6 5718.3 5768.1 5773.9 5776.1 4345.9 4429.6 4444.4 4460.0 4486.3 4000.4 4024.7 4053.5 4067.1 4087.5 5575.8 5576.8 5587.1 5590.7 5657.2 5611.1 5836.2 5984.4 6002.3 6008.3 5525.1 5582.0 5582.2 5621.1 5624.0 5108.0 5114.6 5116.1 5116.7 5156.8 5864.9 6018.0 6193.8 6205.2 6209.6 5844.5 5873.6 5924.1 5970.3 5976.4 6120.7 6122.3 6125.7 6127.5 6132.7 5533.4 5664.5 5726.6 5784.0 5790.0 5798.2 5800.0 5838.1 5881.9 5889.7 5762.3 5762.3 5767.6 5771.4 5772.3 5529.8 5663.7 5762.9 5764.9 5769.9 5618.7 5697.0 5706.5 5750.3 5751.1 5799.5 5814.0 5849.1 5850.0 5859.8 5404.4 5508.5 5666.9 5668.1 5670.9 08:41:40 INFO - PROCESS | 20254 | 08:41:40 INFO - PROCESS | 20254 | [#1] ext.html Cycles:180 Average:60976.63 Median:42819.50 stddev:118125.66 (275.9%) stddev-sans-first:118370.00 08:41:40 INFO - PROCESS | 20254 | Values: 581.2 588.2 591.9 602.0 623.7 42615.8 43992.3 44090.0 44190.0 48135.5 45617.5 45845.5 46033.1 46113.0 46126.3 9048.4 9190.6 9198.9 9200.6 9203.5 9058.3 9146.4 9153.8 9155.7 9156.0 9209.0 9244.7 9253.6 9256.9 9281.9 9152.0 9173.1 9203.0 9209.1 9214.4 9081.7 9166.4 9174.2 9178.4 9181.2 42797.0 42940.1 43111.8 43137.4 43237.1 3404.2 3588.3 3831.4 3899.6 4141.9 32856.2 32867.7 33165.3 33208.2 35050.1 4057.9 4148.6 4172.3 4174.5 4319.5 359088.0 361189.0 361750.0 361994.0 362136.0 59834.0 59915.0 59966.0 60273.4 60326.0 63208.7 63214.7 63406.0 63535.7 63637.4 16511.9 16727.1 16735.2 16743.7 16756.7 12363.8 12427.8 12439.7 12448.4 12450.6 16051.5 17442.7 17588.5 17716.6 17849.1 6429.9 6437.0 6440.3 6656.2 6883.9 951.2 1016.8 1026.0 1044.6 1048.6 31959.5 32127.2 32218.1 32667.7 32864.8 1042.9 1054.1 1105.5 1111.5 1166.2 16435.1 17001.4 17074.6 17089.4 17090.8 545997.0 547219.0 548418.0 548463.0 549174.0 59370.0 59592.0 59636.4 59712.7 59718.0 1202.5 1252.7 1317.4 1339.6 1377.0 28616.1 31651.4 31761.5 32181.0 32816.0 50957.5 51279.2 51404.2 51465.7 51507.2 406314.0 407525.0 408368.0 408687.0 409051.0 43010.8 43534.0 43940.6 44220.6 44246.3 48126.8 48642.8 48765.5 48872.0 50171.2 41027.6 41104.0 41636.6 42090.6 43512.3 42169.6 42281.4 42589.8 42650.4 42842.0 41004.4 41933.8 42229.6 42857.4 42984.1 34956.3 37482.6 37559.8 37586.4 38564.0 28491.3 28515.1 28521.6 28612.9 28666.9 08:41:40 INFO - PROCESS | 20254 | 08:41:40 INFO - PROCESS | 20254 | [#2] jquery.html Cycles:180 Average:29425.44 Median:19093.63 stddev:86053.90 (450.7%) stddev-sans-first:86267.63 08:41:40 INFO - PROCESS | 20254 | Values: 358.2 384.9 393.7 394.7 411.2 14632.1 16716.3 19240.3 19842.6 19861.9 18847.2 18895.7 18938.1 18993.3 19141.8 4095.7 5647.7 5835.5 5837.4 5841.7 6219.4 6483.3 6541.4 6666.0 6669.8 6331.9 6483.2 6520.2 6618.4 6626.5 6350.3 6476.5 6520.0 6534.6 6546.4 5746.2 5798.6 5805.3 5808.7 5809.0 19007.3 20528.5 23500.6 23551.5 23811.0 2169.2 2402.7 2567.0 2772.9 2962.2 5928.6 5960.7 6035.8 8456.5 10192.2 1906.8 1916.8 1942.5 1944.0 1973.9 81703.0 82097.0 83382.0 85113.6 85176.6 10972.1 11062.4 11076.8 11083.6 11363.5 15613.1 15642.5 15670.9 15680.1 15704.1 8010.6 8235.7 8297.3 8346.1 8377.1 7805.5 7862.3 7872.3 8092.8 8142.6 4695.4 4755.4 4764.3 4891.8 4910.8 1936.2 2019.4 2042.5 2061.9 2074.0 908.5 962.5 1012.8 1043.3 1092.6 19412.6 19445.0 19657.3 19671.7 20069.8 958.2 1007.1 1013.5 1027.9 1038.7 10355.7 10908.6 11051.4 11070.3 11086.2 497250.0 525020.0 529070.0 531429.0 532846.0 49175.5 49840.5 96485.0 99322.0 101009.5 927.9 979.9 1008.2 1009.8 1010.3 16172.3 16492.3 17266.2 17302.8 17328.7 34488.7 37829.1 40859.4 41282.6 42666.0 58000.1 58586.0 58796.4 60474.0 60902.7 5516.6 8084.4 8217.0 8289.5 8383.9 9426.3 12226.4 12740.4 12957.9 13281.9 11105.8 11154.4 11280.6 11385.5 11599.7 11048.2 11422.9 11482.3 11623.2 12023.3 10929.8 11170.3 11325.5 11395.9 11654.1 8139.6 8172.3 8179.7 8197.3 8439.8 9243.0 9830.6 10399.5 10801.4 10894.5 08:41:40 INFO - PROCESS | 20254 | 08:41:40 INFO - PROCESS | 20254 | [#3] mootools.html Cycles:180 Average:6026.96 Median:2552.67 stddev:3548.91 (139.0%) stddev-sans-first:3542.02 08:41:40 INFO - PROCESS | 20254 | Values: 1425.3 1483.0 1568.4 1711.7 1760.2 8688.4 9484.3 9484.7 9487.2 9494.3 7258.8 8808.9 9076.3 9097.1 9218.3 2296.2 2323.7 2327.4 2327.6 2327.8 2257.9 2278.0 2301.5 2306.9 2316.8 2371.1 2387.9 2392.8 2395.9 2399.8 2322.5 2337.7 2343.8 2344.1 2371.3 2330.2 2337.8 2340.4 2341.2 2342.8 9194.8 9380.4 9391.0 9393.1 9398.2 5005.0 5037.4 5120.2 5131.8 5157.8 3392.8 3490.5 3571.6 3576.0 3583.9 1098.3 1105.1 1140.6 1145.4 1147.1 13218.5 13259.9 13284.1 13294.4 13310.8 4492.8 4635.4 4752.0 4753.9 4762.6 10959.2 10990.7 10995.7 10997.5 10999.9 5273.4 5279.0 5279.7 5284.0 5285.7 3984.9 4761.3 4846.4 4847.2 4880.0 4115.9 4134.0 4170.0 4243.5 4244.9 1261.7 1265.9 1279.2 1280.7 1293.4 880.9 926.8 946.8 998.2 1051.9 5810.2 6239.3 6364.2 6440.6 6621.2 458.6 463.1 470.0 479.0 484.4 4138.4 4288.8 4300.0 4312.8 4351.3 11467.4 11719.5 11748.8 11830.2 11855.8 11703.4 11719.4 11727.4 11731.2 11735.9 8026.7 8406.1 8418.7 8589.8 8672.9 6222.5 6264.8 6307.7 6314.7 6322.0 10298.7 10591.8 10634.3 10637.3 10676.5 10603.6 10615.3 10790.2 10792.6 10844.7 6594.9 7854.7 8023.6 8033.0 8163.9 8866.5 8994.5 9061.5 9073.0 9092.1 7757.1 7759.1 7893.4 8024.6 8082.1 7737.6 7794.1 7837.8 7959.4 8136.9 7189.2 7313.7 7324.1 7324.3 7327.7 5453.8 5459.5 5508.1 5510.2 5593.2 5381.3 5402.7 5412.6 5418.9 5547.0 08:41:40 INFO - PROCESS | 20254 | 08:41:40 INFO - PROCESS | 20254 | [#4] prototype.html Cycles:180 Average:4519.80 Median:5050.55 stddev:1301.11 (25.8%) stddev-sans-first:1265.37 08:41:40 INFO - PROCESS | 20254 | Values: 286.8 296.0 325.6 325.7 331.8 5300.3 5361.1 5374.2 5377.4 5398.6 5063.8 5163.9 5185.8 5240.7 5352.4 4074.2 4088.0 4150.9 4212.2 4240.0 4173.2 4197.9 4199.2 4209.5 4213.0 4070.0 4141.9 4158.4 4167.1 4186.4 4156.9 4175.6 4179.6 4183.9 4185.0 3703.9 3724.3 3730.6 3734.9 3735.2 4972.3 5144.9 5261.0 5264.3 5306.4 4760.0 4773.3 4790.7 4804.2 4812.6 5492.4 5503.4 5507.2 5554.7 5557.5 3930.9 4070.5 4079.2 4090.3 4105.6 5725.2 5729.2 5762.9 5797.0 5815.9 4188.3 4193.7 4194.8 4204.2 4207.2 3928.3 4246.5 4256.7 4257.0 4267.8 4691.1 4734.7 4750.1 4771.5 4803.4 5641.2 5641.4 5654.7 5669.2 5680.5 1389.8 1391.4 1397.7 1404.1 1406.3 903.2 930.4 932.3 935.7 936.0 4756.9 4776.4 4789.1 4805.0 4889.4 4771.6 5034.3 5086.3 5086.7 5105.8 4725.5 4750.7 4758.6 4781.6 4786.2 2673.6 2687.9 2689.3 2690.8 2697.7 5049.5 5201.8 5206.3 5235.2 5319.3 5169.6 5170.8 5176.0 5216.4 5250.4 5216.8 5218.6 5224.3 5264.0 5317.2 4650.7 4994.6 5007.2 5037.9 5081.2 4986.3 5047.7 5051.6 5054.8 5055.6 5007.8 5215.7 5223.0 5246.7 5255.2 3690.6 3692.0 3700.4 3726.5 3734.3 5056.0 5496.1 5504.9 5677.5 5698.9 5599.4 5608.3 5612.5 5617.3 5626.3 5428.9 5548.7 5568.5 5608.2 5614.3 5437.2 5473.7 5483.9 5503.3 5516.9 5580.6 5588.4 5600.0 5610.3 5615.3 5301.2 5468.7 5470.6 5505.1 5505.8 08:41:40 INFO - PROCESS | 20254 | 08:41:40 INFO - PROCESS | 20254 | [#5] yui.html Cycles:180 Average:21735.04 Median:4810.66 stddev:31974.88 (664.7%) stddev-sans-first:32025.62 08:41:40 INFO - PROCESS | 20254 | Values: 715.8 748.2 757.9 795.1 834.7 15840.7 17331.7 17397.5 17427.3 17436.8 15441.0 15528.5 15543.5 15552.0 15556.5 654.8 775.0 795.3 801.4 806.6 804.7 805.9 815.7 819.6 820.0 877.6 877.7 881.8 882.6 882.8 692.4 871.6 871.9 872.4 873.2 607.9 623.8 624.3 629.7 629.7 15327.2 15396.2 15980.4 15985.5 15998.4 13935.3 14239.9 14582.9 14808.0 14956.0 12291.8 12468.8 12618.0 12757.7 13148.9 4474.2 4491.0 4497.2 4519.1 4763.0 86041.0 86188.0 86624.0 86702.6 90824.0 10624.8 10925.3 11031.6 11083.2 11099.7 21157.3 21192.0 21193.7 21211.2 21228.9 8597.6 8766.2 9194.7 9295.4 9301.6 4691.3 4858.3 4943.1 4963.5 5087.9 3241.5 3299.8 3323.2 3335.3 3335.4 557.3 568.2 583.0 593.2 594.2 541.5 565.9 603.7 606.8 612.6 9211.0 9569.3 9594.0 9678.3 10039.7 571.8 596.9 638.1 663.8 724.7 4431.9 4607.7 4612.9 4904.1 5309.3 117762.0 125501.0 128258.4 129368.0 129837.4 85826.0 88556.0 110827.4 112313.4 113425.0 85338.1 87801.6 88353.0 88375.6 91446.0 9265.8 9631.6 9686.2 9719.9 9882.2 49520.5 51047.0 51775.7 51952.2 52394.7 73024.6 74777.6 76147.6 76852.0 78099.0 13148.6 13180.7 13281.7 13403.4 13801.5 14005.2 14190.4 14537.5 14706.3 15494.9 13869.9 14346.4 14371.0 14543.9 14860.4 13078.6 13286.7 13354.1 13715.0 14127.6 13596.2 13707.4 13775.2 13811.4 15236.8 11364.4 11371.8 11395.7 11501.9 11805.6 9448.5 9944.2 10301.6 10438.4 10451.5 08:41:40 INFO - PROCESS | 20254 | -------- Summary: end -------- 08:41:40 INFO - PROCESS | 20254 | 08:41:41 INFO - TEST-INFO | 20254: exit 0 08:41:41 INFO - TEST-OK | dromaeo_css | took 1115175ms 08:41:41 INFO - TEST-START | kraken 08:41:41 INFO - operating with platform_type : linux_ 08:41:41 INFO - Initialising browser for kraken test... 08:41:41 INFO - TEST-INFO | started process 20448 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSrLre6/profile http://localhost:54021/getInfo.html) 08:41:45 INFO - PROCESS | 20448 | __metrics Screen width/height:1600/1200 08:41:45 INFO - PROCESS | 20448 | colorDepth:24 08:41:45 INFO - PROCESS | 20448 | Browser inner width/height: 1024/697 08:41:45 INFO - PROCESS | 20448 | __metrics 08:41:46 INFO - PROCESS | 20448 | 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" 08:41:46 INFO - PROCESS | 20448 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:41:46 INFO - PROCESS | 20448 | console.error: PushService: 08:41:46 INFO - PROCESS | 20448 | stateChangeProcessEnqueue: Error transitioning state 08:41:46 INFO - PROCESS | 20448 | UnknownError 08:41:47 INFO - TEST-INFO | 20448: exit 0 08:41:47 INFO - Browser initialized. 08:41:47 INFO - Running cycle 1/1 for kraken test... 08:41:47 INFO - TEST-INFO | started process 20531 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSrLre6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:41:59 INFO - PROCESS | 20531 | RSS: Main: 155987968 08:41:59 INFO - PROCESS | 20531 | 08:42:01 INFO - PROCESS | 20531 | Cycle 1(1): loaded http://localhost:54021/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54021/tests/kraken/driver.html?testName=audio-beat-detection) 08:42:02 INFO - PROCESS | 20531 | RSS: Main: 211877888 08:42:02 INFO - PROCESS | 20531 | 08:42:05 INFO - PROCESS | 20531 | Cycle 1(1): loaded http://localhost:54021/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54021/tests/kraken/driver.html?testName=audio-dft) 08:42:05 INFO - PROCESS | 20531 | RSS: Main: 187404288 08:42:05 INFO - PROCESS | 20531 | 08:42:08 INFO - PROCESS | 20531 | Cycle 1(1): loaded http://localhost:54021/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54021/tests/kraken/driver.html?testName=audio-fft) 08:42:09 INFO - PROCESS | 20531 | RSS: Main: 268951552 08:42:09 INFO - PROCESS | 20531 | 08:42:11 INFO - PROCESS | 20531 | Cycle 1(1): loaded http://localhost:54021/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54021/tests/kraken/driver.html?testName=audio-oscillator) 08:42:12 INFO - PROCESS | 20531 | RSS: Main: 178237440 08:42:12 INFO - PROCESS | 20531 | 08:42:14 INFO - PROCESS | 20531 | Cycle 1(1): loaded http://localhost:54021/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54021/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:42:14 INFO - PROCESS | 20531 | RSS: Main: 183214080 08:42:14 INFO - PROCESS | 20531 | 08:42:17 INFO - PROCESS | 20531 | Cycle 1(1): loaded http://localhost:54021/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54021/tests/kraken/driver.html?testName=imaging-darkroom) 08:42:18 INFO - PROCESS | 20531 | RSS: Main: 218054656 08:42:18 INFO - PROCESS | 20531 | 08:42:21 INFO - PROCESS | 20531 | Cycle 1(1): loaded http://localhost:54021/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54021/tests/kraken/driver.html?testName=imaging-desaturate) 08:42:22 INFO - PROCESS | 20531 | RSS: Main: 218312704 08:42:22 INFO - PROCESS | 20531 | 08:42:25 INFO - PROCESS | 20531 | Cycle 1(1): loaded http://localhost:54021/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54021/tests/kraken/driver.html?testName=json-parse-financial) 08:42:25 INFO - PROCESS | 20531 | RSS: Main: 218664960 08:42:25 INFO - PROCESS | 20531 | 08:42:27 INFO - PROCESS | 20531 | Cycle 1(1): loaded http://localhost:54021/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54021/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:42:27 INFO - PROCESS | 20531 | RSS: Main: 182726656 08:42:27 INFO - PROCESS | 20531 | 08:42:29 INFO - PROCESS | 20531 | Cycle 1(1): loaded http://localhost:54021/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54021/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:42:30 INFO - PROCESS | 20531 | RSS: Main: 187867136 08:42:30 INFO - PROCESS | 20531 | 08:42:32 INFO - PROCESS | 20531 | Cycle 1(1): loaded http://localhost:54021/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54021/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:42:32 INFO - PROCESS | 20531 | RSS: Main: 193347584 08:42:32 INFO - PROCESS | 20531 | 08:42:35 INFO - PROCESS | 20531 | Cycle 1(1): loaded http://localhost:54021/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54021/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:42:35 INFO - PROCESS | 20531 | RSS: Main: 188219392 08:42:35 INFO - PROCESS | 20531 | 08:42:38 INFO - PROCESS | 20531 | Cycle 1(1): loaded http://localhost:54021/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54021/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:42:39 INFO - PROCESS | 20531 | RSS: Main: 191410176 08:42:39 INFO - PROCESS | 20531 | 08:42:40 INFO - PROCESS | 20531 | Cycle 1(1): loaded http://localhost:54021/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54021/tests/kraken/driver.html?testName=ai-astar) 08:42:41 INFO - PROCESS | 20531 | RSS: Main: 242806784 08:42:41 INFO - PROCESS | 20531 | 08:42:41 INFO - PROCESS | 20531 | __start_tp_report 08:42:41 INFO - PROCESS | 20531 | _x_x_mozilla_page_load 08:42:41 INFO - PROCESS | 20531 | _x_x_mozilla_page_load_details 08:42:41 INFO - PROCESS | 20531 | |i|pagename|runs| 08:42:41 INFO - PROCESS | 20531 | |0;ai-astar;103;112;111;111;113;113;113;111;111;112 08:42:41 INFO - PROCESS | 20531 | |1;audio-beat-detection;147;120;120;182;120;125;139;120;159;116 08:42:41 INFO - PROCESS | 20531 | |2;audio-dft;161;160;162;162;161;160;163;168;162;161 08:42:41 INFO - PROCESS | 20531 | |3;audio-fft;76;74;76;115;76;77;74;75;106;75 08:42:41 INFO - PROCESS | 20531 | |4;audio-oscillator;83;82;136;84;85;84;123;83;83;128 08:42:41 INFO - PROCESS | 20531 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 08:42:41 INFO - PROCESS | 20531 | |6;imaging-darkroom;147;146;146;146;145;146;146;145;145;145 08:42:41 INFO - PROCESS | 20531 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 08:42:41 INFO - PROCESS | 20531 | |8;json-parse-financial;53;50;52;51;52;51;53;50;51;50 08:42:41 INFO - PROCESS | 20531 | |9;json-stringify-tinderbox;61;60;60;60;60;60;60;61;61;60 08:42:41 INFO - PROCESS | 20531 | |10;stanford-crypto-aes;76;76;76;75;76;76;75;76;76;75 08:42:41 INFO - PROCESS | 20531 | |11;stanford-crypto-ccm;133;128;129;134;130;130;121;120;138;130 08:42:41 INFO - PROCESS | 20531 | |12;stanford-crypto-pbkdf2;158;159;158;162;161;156;162;159;159;160 08:42:41 INFO - PROCESS | 20531 | |13;stanford-crypto-sha256-iterative;63;63;63;64;62;63;62;61;65;62 08:42:41 INFO - PROCESS | 20531 | __end_tp_report 08:42:41 INFO - PROCESS | 20531 | __start_cc_report 08:42:41 INFO - PROCESS | 20531 | _x_x_mozilla_cycle_collect,1670 08:42:41 INFO - PROCESS | 20531 | __end_cc_report 08:42:41 INFO - PROCESS | 20531 | __startTimestamp1470843761211__endTimestamp 08:42:41 INFO - PROCESS | 20531 | 08:42:41 INFO - PROCESS | 20531 | ------- Summary: start ------- 08:42:41 INFO - PROCESS | 20531 | Number of tests: 14 08:42:41 INFO - PROCESS | 20531 | 08:42:41 INFO - PROCESS | 20531 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:2.94 (2.6%) stddev-sans-first:0.93 08:42:41 INFO - PROCESS | 20531 | Values: 103.0 112.0 111.0 111.0 113.0 113.0 113.0 111.0 111.0 112.0 08:42:41 INFO - PROCESS | 20531 | 08:42:41 INFO - PROCESS | 20531 | [#1] audio-beat-detection Cycles:10 Average:134.80 Median:132.00 stddev:21.87 (16.6%) stddev-sans-first:22.75 08:42:41 INFO - PROCESS | 20531 | Values: 147.0 120.0 120.0 182.0 120.0 125.0 139.0 120.0 159.0 116.0 08:42:41 INFO - PROCESS | 20531 | 08:42:41 INFO - PROCESS | 20531 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:2.31 (1.4%) stddev-sans-first:2.42 08:42:41 INFO - PROCESS | 20531 | Values: 161.0 160.0 162.0 162.0 161.0 160.0 163.0 168.0 162.0 161.0 08:42:41 INFO - PROCESS | 20531 | 08:42:41 INFO - PROCESS | 20531 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.50 stddev:14.99 (19.9%) stddev-sans-first:15.72 08:42:41 INFO - PROCESS | 20531 | Values: 76.0 74.0 76.0 115.0 76.0 77.0 74.0 75.0 106.0 75.0 08:42:41 INFO - PROCESS | 20531 | 08:42:41 INFO - PROCESS | 20531 | [#4] audio-oscillator Cycles:10 Average:97.10 Median:83.00 stddev:22.24 (26.8%) stddev-sans-first:23.00 08:42:41 INFO - PROCESS | 20531 | Values: 83.0 82.0 136.0 84.0 85.0 84.0 123.0 83.0 83.0 128.0 08:42:41 INFO - PROCESS | 20531 | 08:42:41 INFO - PROCESS | 20531 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 08:42:41 INFO - PROCESS | 20531 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 08:42:41 INFO - PROCESS | 20531 | 08:42:41 INFO - PROCESS | 20531 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.53 08:42:41 INFO - PROCESS | 20531 | Values: 147.0 146.0 146.0 146.0 145.0 146.0 146.0 145.0 145.0 145.0 08:42:41 INFO - PROCESS | 20531 | 08:42:41 INFO - PROCESS | 20531 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 08:42:41 INFO - PROCESS | 20531 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 08:42:41 INFO - PROCESS | 20531 | 08:42:41 INFO - PROCESS | 20531 | [#8] json-parse-financial Cycles:10 Average:51.30 Median:51.50 stddev:1.16 (2.3%) stddev-sans-first:1.05 08:42:41 INFO - PROCESS | 20531 | Values: 53.0 50.0 52.0 51.0 52.0 51.0 53.0 50.0 51.0 50.0 08:42:41 INFO - PROCESS | 20531 | 08:42:41 INFO - PROCESS | 20531 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 08:42:41 INFO - PROCESS | 20531 | Values: 61.0 60.0 60.0 60.0 60.0 60.0 60.0 61.0 61.0 60.0 08:42:41 INFO - PROCESS | 20531 | 08:42:41 INFO - PROCESS | 20531 | [#10] stanford-crypto-aes Cycles:10 Average:75.70 Median:76.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 08:42:41 INFO - PROCESS | 20531 | Values: 76.0 76.0 76.0 75.0 76.0 76.0 75.0 76.0 76.0 75.0 08:42:41 INFO - PROCESS | 20531 | 08:42:41 INFO - PROCESS | 20531 | [#11] stanford-crypto-ccm Cycles:10 Average:129.30 Median:130.00 stddev:5.48 (4.2%) stddev-sans-first:5.64 08:42:41 INFO - PROCESS | 20531 | Values: 133.0 128.0 129.0 134.0 130.0 130.0 121.0 120.0 138.0 130.0 08:42:41 INFO - PROCESS | 20531 | 08:42:41 INFO - PROCESS | 20531 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.40 Median:159.50 stddev:1.90 (1.2%) stddev-sans-first:1.94 08:42:41 INFO - PROCESS | 20531 | Values: 158.0 159.0 158.0 162.0 161.0 156.0 162.0 159.0 159.0 160.0 08:42:41 INFO - PROCESS | 20531 | 08:42:41 INFO - PROCESS | 20531 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:1.14 (1.8%) stddev-sans-first:1.20 08:42:41 INFO - PROCESS | 20531 | Values: 63.0 63.0 63.0 64.0 62.0 63.0 62.0 61.0 65.0 62.0 08:42:41 INFO - PROCESS | 20531 | -------- Summary: end -------- 08:42:41 INFO - PROCESS | 20531 | 08:42:42 INFO - TEST-INFO | 20531: exit 0 08:42:42 INFO - TEST-OK | kraken | took 60671ms 08:42:42 INFO - SUITE-END | took 1175s 08:42:42 INFO - Completed test suite (00:19:36) 08:42:42 INFO - javascript benchmark 08:42:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3075.400296942096, 3082.5530298106773, 3114.190310519265, 3144.3868445653106, 3161.6364118126407, 5249.028929648018, 5315.760790764415, 5438.401775804663, 5522.0888553388695, 5561.499465048139, 5459.153831156167, 5518.6688798672, 5544.750486228119, 5567.860803479915, 5590.692511911843, 4899.0, 4940.654154209206, 5008.323876276692, 5008.474110218429, 5165.354330708661, 5082.2376643503585, 5114.820981265657, 5142.794288228466, 5146.485351464861, 5149.047426226141, 4779.498152693969, 4796.784144713496, 4914.066327397783, 4985.152524070917, 5009.499050094998, 4883.316335713003, 4897.926531102036, 4901.901961960741, 4964.67729597575, 5057.2666963290485, 4904.901901961941, 4928.272907481298, 4931.408231012301, 4972.328735620681, 4990.201567749143, 5247.029299579552, 5343.465653434664, 5394.8921021579745, 5446.700431476267, 5503.229547863302, 5869.207656966298, 5871.031279838821, 5913.881722365529, 5918.674472903988, 5926.881462370771, 5966.552508561832, 5970.402959704038, 5970.402959704038, 5974.312954010301, 5977.432143946318, 5281.049411106, 5403.378611459732, 5427.782888684487, 5437.700926449004, 5525.281713377275, 6021.0, 6027.21646185993, 6074.574779765462, 6078.544109191828, 6085.391460853879, 5774.682392468455, 5778.971105144447, 5823.330317013598, 5832.62087964281, 5833.0, 5647.604667673306, 5674.517665998354, 5723.713814309268, 5738.5982981191755, 5923.08192230205, 5760.135979603093, 5765.4522820332, 5808.128780682931, 5808.128780682931, 5811.593188476766, 5714.628549144292, 5718.342390625131, 5768.134779782982, 5773.913391299134, 5776.104703770922, 4345.891352716144, 4429.645628349725, 4444.400005999149, 4459.955400445954, 4486.327050942385, 4000.439938408625, 4024.6981476389387, 4053.5135783706146, 4067.084905896209, 4087.4890638670167, 5575.832725018256, 5576.804811831647, 5587.05020146576, 5590.748416321194, 5657.2079908811975, 5611.102223644198, 5836.212111364996, 5984.431479009487, 6002.279726432856, 6008.309044459856, 5525.11598144295, 5581.972090139523, 5582.162675598693, 5621.100623900238, 5624.0, 5108.0, 5114.616403769732, 5116.079105760999, 5116.692998420107, 5156.845294641167, 5864.853378665567, 6017.969910150597, 6193.752249910043, 6205.162303089115, 6209.565330426917, 5844.532437405082, 5873.5594830388745, 5924.140999555127, 5970.283565972111, 5976.372480889618, 6120.693965301806, 6122.265328160649, 6125.663088530174, 6127.509799215963, 6132.693365331805, 5533.446655334435, 5664.546836253172, 5726.570507212059, 5783.971080144741, 5790.0, 5798.246227990334, 5800.01399762033, 5838.065909454467, 5881.852953676193, 5889.734961926809, 5762.30852297727, 5762.30852297727, 5767.596268261182, 5771.394003629558, 5772.336181339199, 5529.834104976857, 5663.66018038919, 5762.933857236425, 5764.884702305846, 5769.94230057694, 5618.7190640467, 5696.9715151425635, 5706.543476521952, 5750.30996280449, 5751.1085781703905, 5799.5070419014855, 5814.04068328738, 5849.093390524476, 5849.976254155421, 5859.794907178399, 5404.378496472956, 5508.531774799187, 5666.914996274977, 5668.121441176624, 5670.914936276042], "value": 5403.650338402827, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.215359264992, 588.2470437839567, 591.9141724449955, 602.0457574744031, 623.6569886562389, 42615.78692106539, 43992.3401148983, 44090.0, 44190.0, 48135.51864481354, 45617.54382456175, 45845.54154458454, 46033.07933841321, 46113.0, 46126.30810537836, 9048.41185322952, 9190.632374705005, 9198.908010919871, 9200.631974721004, 9203.493807840567, 9058.275337972946, 9146.359754817133, 9153.771155721093, 9155.72532824013, 9156.0, 9209.0, 9244.722658320261, 9253.6298548058, 9256.907430925705, 9281.907180928172, 9152.0, 9173.128552787475, 9203.033681463417, 9209.079092090804, 9214.354995150308, 9081.683155942417, 9166.358354915159, 9174.220191283748, 9178.4034037788, 9181.173694367539, 42797.0, 42940.14119717619, 43111.78444107791, 43137.35293970593, 43237.13525729468, 3404.1829960809473, 3588.3182195383056, 3831.4252862070634, 3899.610038996106, 4141.937870931938, 32856.178595535064, 32867.67132328694, 33165.336693266, 33208.16979575506, 35050.123746906276, 4057.8579749708915, 4148.605882441193, 4172.290710579209, 4174.519930208005, 4319.481662200525, 359088.0, 361189.0, 361750.0, 361994.0, 362136.0, 59834.0, 59915.0, 59966.0, 60273.397266027656, 60326.0, 63208.683956579924, 63214.68392658007, 63406.0, 63535.68232158902, 63637.36362636407, 16511.917440412722, 16727.080010599533, 16735.163241837858, 16743.66512669764, 16756.748648770277, 12363.814542781865, 12427.75144497105, 12439.689007774878, 12448.377581120907, 12450.626481205578, 16051.518454446385, 17442.65114697699, 17588.504977076835, 17716.645667086585, 17849.10754462272, 6429.935700643027, 6436.967815160894, 6440.259370172396, 6656.201255849329, 6883.862322753517, 951.2342564235719, 1016.8271393863062, 1025.958961641541, 1044.5508431374583, 1048.570086264628, 31959.520607190912, 32127.23499758633, 32218.106563891528, 32667.67332326694, 32864.835675821465, 1042.8748550174028, 1054.0671505717341, 1105.4583254205381, 1111.5331560744507, 1166.2128063557066, 16435.09606971604, 17001.40495082691, 17074.57313567146, 17089.401870934456, 17090.829091709173, 545997.0, 547219.0, 548418.0, 548463.0, 549174.0, 59370.0, 59592.0, 59636.403635963085, 59712.70143649341, 59718.0, 1202.4709127983658, 1252.7056141806668, 1317.433503593464, 1339.5914246155016, 1377.0498356134235, 28616.141515753727, 31651.36697265996, 31761.523577146825, 32181.0, 32816.0, 50957.490425095275, 51279.230811538604, 51404.22893656523, 51465.7426712864, 51507.22739158841, 406314.0, 407525.0, 408368.0, 408687.0, 409051.0, 43010.784946075066, 43534.0, 43940.56059439493, 44220.55779442164, 44246.336304954806, 48126.75936620295, 48642.75678621584, 48765.51234487752, 48872.0, 50171.24743128783, 41027.58972410238, 41104.0, 41636.58363416448, 42090.57909420989, 43512.34731478967, 42169.578304216564, 42281.365779513944, 42589.787051064544, 42650.360244596974, 42842.0, 41004.38493422541, 41933.79033104815, 42229.5777042238, 42857.35713964231, 42984.140317194106, 34956.30087398187, 37482.62517374791, 37559.81220093882, 37586.43620345752, 38564.0, 28491.28771780722, 28515.144545663665, 28521.572176416954, 28612.856935715186, 28666.85666571654], "value": 20516.503441767512, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.21372088266236, 384.8768394113884, 393.7361967481787, 394.7098882321494, 411.1694377357737, 14632.122072675633, 16716.33134674613, 19240.3265885694, 19842.603147937032, 19861.900690496564, 18847.24611015561, 18895.716564251547, 18938.053097345113, 18993.33523326684, 19141.808581914178, 4095.7337773044655, 5647.689377084259, 5835.533157347423, 5837.357890632027, 5841.678707671076, 6219.409156130183, 6483.254425741029, 6541.378569035958, 6665.966670166642, 6669.766558170465, 6331.873362532747, 6483.15718956535, 6520.152380190569, 6618.404343609074, 6626.469882409396, 6350.301466838644, 6476.4818814494965, 6520.0, 6534.60792352458, 6546.410823025903, 5746.166805813134, 5798.594098413113, 5805.3323867755325, 5808.680522571257, 5809.0, 19007.334743284056, 20528.486787830276, 23500.647490287658, 23551.528969420688, 23811.0, 2169.1973969631335, 2402.699662542182, 2566.9860405140053, 2772.9306767330777, 2962.244627619943, 5928.555358348141, 5960.701964901781, 6035.818925432244, 8456.450330728483, 10192.235582331356, 1906.761654793151, 1916.7508223930938, 1942.5430926804897, 1943.9514012149668, 1973.940781776549, 81703.0, 82097.0, 83381.99999999939, 85113.57443212807, 85176.57411712964, 10972.147241717052, 11062.446877656084, 11076.778464430667, 11083.612073577386, 11363.488643011084, 15613.063216207063, 15642.45251416195, 15670.921645391929, 15680.05919644802, 15704.136272505122, 8010.559419231999, 8235.670573177125, 8297.294729948022, 8346.123657016047, 8377.078521362646, 7805.531668099932, 7862.33170180541, 7872.274250958993, 8092.83814323722, 8142.633581488847, 4695.413073365829, 4755.405574303212, 4764.309175169581, 4891.755412229374, 4910.803567857246, 1936.244864502845, 2019.384087853219, 2042.5404284035974, 2061.8969051547365, 2074.0, 908.4912449028565, 962.4658314635444, 1012.767063575367, 1043.3114144664485, 1092.6175838456477, 19412.611747764964, 19445.0, 19657.311994080137, 19671.704924426143, 20069.79930200679, 958.2094771813282, 1007.0835539658875, 1013.5489707080426, 1027.9383237005804, 1038.714353552764, 10355.741106472398, 10908.61819836302, 11051.447427628586, 11070.335779853234, 11086.16853735973, 497250.0, 525020.0, 529070.0, 531429.0, 532846.0, 49175.50824491781, 49840.501594984315, 96485.0, 99322.0, 101009.49495252476, 927.9118483744033, 979.9461029643295, 1008.193445243802, 1009.7576581620358, 1010.2726037253166, 16172.272247748644, 16492.34030638761, 17266.22301996388, 17302.826971730123, 17328.653426931643, 34488.655113449546, 37829.05427364338, 40859.38710919398, 41282.587174127875, 42666.0, 58000.12999805091, 58586.0, 58796.4120358791, 60474.0, 60902.69548652229, 5516.558675306046, 8084.393670474856, 8217.0, 8289.502629842229, 8383.916160838558, 9426.293028023063, 12226.388680565758, 12740.362981850685, 12957.870421295667, 13281.867181328063, 11105.777884442105, 11154.442277885912, 11280.605178818701, 11385.544578216779, 11599.6520104397, 11048.226624136234, 11422.94288528552, 11482.253653512495, 11623.186376953532, 12023.27860328383, 10929.836052459379, 11170.27393219438, 11325.546978120783, 11395.948729228818, 11654.067674586182, 8139.593020348841, 8172.305354044973, 8179.67281308741, 8197.344212463107, 8439.789005274917, 9242.953785231031, 9830.606775728891, 10399.532021059222, 10801.405922674014, 10894.50974706156], "value": 9113.122562243825, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1425.2873563218388, 1483.0, 1568.4040064775384, 1711.7432385142235, 1760.181515595248, 8688.435251708635, 9484.288678349118, 9484.715458536246, 9487.241020718344, 9494.28792840537, 7258.782236532912, 8808.867866982, 9076.31927605429, 9097.135772101656, 9218.262538996882, 2296.196331284054, 2323.6514522821626, 2327.3832434404812, 2327.615943369342, 2327.813774898004, 2257.8645281283093, 2277.954440911181, 2301.470661747799, 2306.907723691059, 2316.791488766011, 2371.087131454394, 2387.928362149138, 2392.808575313971, 2395.9041638334447, 2399.8320117591775, 2322.454223257533, 2337.6610391493223, 2343.7656234376595, 2344.0623750499767, 2371.3004663624274, 2330.242671131889, 2337.8480398774027, 2340.3797993531557, 2341.1571834139695, 2342.7774361435636, 9194.81610367789, 9380.390274632127, 9391.0, 9393.107654772786, 9398.154166125081, 5004.974975125101, 5037.395512538482, 5120.15517439622, 5131.820386286462, 5157.8452646420665, 3392.796432214075, 3490.5462289902403, 3571.624979377154, 3576.0165954362496, 3583.8566457341676, 1098.280626189847, 1105.1269497097283, 1140.5836869542557, 1145.3872178384524, 1147.0536807134147, 13218.471261149543, 13259.86740132596, 13284.070115091947, 13294.401751921187, 13310.800337994939, 4492.842750503717, 4635.351050852883, 4751.95248047522, 4753.928691069636, 4762.618990480753, 10959.178061645249, 10990.670279891616, 10995.725106872233, 10997.450127493754, 10999.945000274947, 5273.419923808378, 5279.023380674587, 5279.736013199325, 5284.048871203144, 5285.68285902847, 3984.880453586397, 4761.333413322138, 4846.442659094178, 4847.175980083394, 4880.023995200974, 4115.947450544178, 4133.958660413357, 4170.040081161849, 4243.511996120424, 4244.915101697949, 1261.703499677575, 1265.8987281017496, 1279.2260682287083, 1280.6734282757836, 1293.424426130363, 880.903100658927, 926.8007378413539, 946.8485042393185, 998.236349192868, 1051.942143182117, 5810.244668193108, 6239.251289845248, 6364.236291645032, 6440.6135631862235, 6621.172353455818, 458.5620732200807, 463.0854063225103, 469.9882502937454, 478.9568938795525, 484.41627838454576, 4138.420621113047, 4288.849890253826, 4300.0, 4312.805923733439, 4351.303791393425, 11467.369294688871, 11719.472623731952, 11748.765024699458, 11830.231034982871, 11855.822162667568, 11703.356315402734, 11719.414029298501, 11727.4136293185, 11731.237469564621, 11735.882641173479, 8026.678932842621, 8406.117357677478, 8418.747437576883, 8589.828203435896, 8672.8699069514, 6222.502199824094, 6264.780732674334, 6307.740371026028, 6314.715837787218, 6322.0, 10298.691039268833, 10591.788164236827, 10634.30876993024, 10637.308574942605, 10676.519556619816, 10603.575856965943, 10615.31000484966, 10790.244682872124, 10792.56829726802, 10844.728881777703, 6594.934050659432, 7854.72508462201, 8023.558704271088, 8032.959835200787, 8163.918360816316, 8866.468011919305, 8994.505302208441, 9061.54692265371, 9073.047330030251, 9092.09079092112, 7757.1467138615835, 7759.068911730628, 7893.407994400558, 8024.598770061591, 8082.110967793656, 7737.613119344122, 7794.064712234568, 7837.804054898673, 7959.442839001214, 8136.918630813616, 7189.173245076883, 7313.707451702086, 7324.132346251672, 7324.340809327186, 7327.670254838652, 5453.8091166810555, 5459.535939445032, 5508.091164957737, 5510.173473978935, 5593.188987596857, 5381.327334083239, 5402.702851343214, 5412.621116521806, 5418.864528386822, 5547.0], "value": 4690.584619634056, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.7820456453095, 296.04377859513784, 325.5556165833637, 325.6564324637508, 331.772735676062, 5300.284461597683, 5361.142217245247, 5374.247605335257, 5377.381601115872, 5398.649087809299, 5063.797448102081, 5163.941392014637, 5185.792568297273, 5240.68555886647, 5352.437994010622, 4074.164796216776, 4087.9591204088024, 4150.875473735793, 4212.220739163249, 4239.9576004240025, 4173.227952828721, 4197.895052623693, 4199.202151591203, 4209.515905670841, 4212.978935105336, 4069.9796501017454, 4141.881691943174, 4158.355454904495, 4167.124903770212, 4186.39297301891, 4156.9192010077295, 4175.645070169039, 4179.644730197937, 4183.937240941388, 4184.970289409634, 3703.925801551113, 3724.348239058181, 3730.6269373062746, 3734.925301493955, 3735.234276973214, 4972.254161875711, 5144.922826157611, 5260.9736951315, 5264.341957255343, 5306.416294207634, 4759.976200118977, 4773.305476555807, 4790.712557246541, 4804.159272127364, 4812.639052071108, 5492.368377636583, 5503.394626591072, 5507.228987941691, 5554.666719996772, 5557.499825015728, 3930.9017274568077, 4070.5115386153557, 4079.2045551117544, 4090.3046482098116, 4105.5894410559, 5725.169850371714, 5729.197912292282, 5762.88474230513, 5796.97101514494, 5815.912761308584, 4188.28799104153, 4193.685473589493, 4194.769287689206, 4204.243236217449, 4207.242696314693, 3928.2929072767174, 4246.490421149482, 4256.723312984646, 4256.9574304257185, 4267.8292868284925, 4691.132140554008, 4734.73958932262, 4750.14497390473, 4771.5228477152, 4803.423589169322, 5641.210230567724, 5641.392203222144, 5654.6889921054735, 5669.206311116447, 5680.517156041783, 1389.81932348794, 1391.3599744117819, 1397.706481638847, 1404.0873432269107, 1406.2546850169426, 903.1690844423147, 930.3580529434669, 932.3333816321363, 935.6678379175431, 935.9578818953163, 4756.906960937176, 4776.44460213784, 4789.144738485553, 4805.0, 4889.364382630235, 4771.594414474739, 5034.270030845507, 5086.313347698014, 5086.745662716849, 5105.795768169306, 4725.480197178307, 4750.714957102585, 4758.643101767381, 4781.569658730731, 4786.210275304606, 2673.6364454128534, 2687.897961835638, 2689.287338855205, 2690.8250963687296, 2697.716739742338, 5049.469805670426, 5201.7919283229, 5206.349206349207, 5235.240890070919, 5319.28189694394, 5169.578365949394, 5170.784865556591, 5176.0, 5216.417873152738, 5250.3962044364625, 5216.765245563959, 5218.556422704037, 5224.346956630421, 5263.973525162633, 5317.229001794718, 4650.697704649187, 4994.625403094855, 5007.24891266313, 5037.876516559756, 5081.23781432788, 4986.276989836526, 5047.7476126192805, 5051.621128415457, 5054.7978080876355, 5055.620828437808, 5007.774650140679, 5215.6529561696625, 5222.97388513055, 5246.68832791802, 5255.185446255837, 3690.6493883081066, 3691.9630803692694, 3700.37093694078, 3726.5280214314653, 3734.2531493700826, 5056.0, 5496.120620700669, 5504.899020195897, 5677.530274330679, 5698.886022279614, 5599.412061733459, 5608.327000759935, 5612.522935550524, 5617.269754931833, 5626.2967129108865, 5428.945710543002, 5548.69482178484, 5568.470995255444, 5608.214849921096, 5614.2701448811395, 5437.157240627709, 5473.726313684379, 5483.945160548344, 5503.284573005483, 5516.869041846332, 5580.609357345109, 5588.441155884379, 5600.0, 5610.326760788732, 5615.326160860723, 5301.23132145829, 5468.726563671721, 5470.577649810998, 5505.146702261156, 5505.834824955257], "value": 4101.714090019937, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.7995761186867, 748.1732685382649, 757.8938948547201, 795.1094773853285, 834.7036801935311, 15840.683186336266, 17331.740023899634, 17397.47807565775, 17427.302907883703, 17436.825631743694, 15441.0, 15528.5341439757, 15543.533693989199, 15552.0, 15556.45552405666, 654.7610122305348, 774.9922500775004, 795.3478147918709, 801.4149670740363, 806.6491076381764, 804.6821505505322, 805.923437273458, 815.6900377856406, 819.5697258939045, 820.0323618130603, 877.5612193903048, 877.7454538183919, 881.7619242804438, 882.6248844241172, 882.7616543533242, 692.4183685703982, 871.6339137562239, 871.8735783311416, 872.4416373520952, 873.2315562305163, 607.9057746049369, 623.8378021714387, 624.3444383397415, 629.6788637794712, 629.7292164369319, 15327.233638318039, 15396.23018849053, 15980.360785568564, 15985.52043438687, 15998.360065597362, 13935.303234838217, 14239.857601423957, 14582.854171458255, 14808.0, 14956.0, 12291.819602790547, 12468.75062498754, 12618.0, 12757.74484510314, 13148.864642285287, 4474.239379305526, 4490.955090449086, 4497.168023915586, 4519.118771839492, 4763.0, 86041.0, 86188.0, 86624.0, 86702.56648716779, 90824.0, 10624.840627390595, 10925.289856159325, 11031.558737650565, 11083.168762342857, 11099.667009989551, 21157.25949591788, 21192.0, 21193.682094768592, 21211.15155393767, 21228.893855530623, 8597.5701214939, 8766.21104100634, 9194.678186263449, 9295.395799273025, 9301.581428835718, 4691.319758635047, 4858.319835223072, 4943.110240156734, 4963.45402005779, 5087.8982420351385, 3241.546183534307, 3299.818509981926, 3323.1858194742445, 3335.2995870866903, 3335.4496508075895, 557.275541795664, 568.1534513574744, 582.9737661805144, 593.1784478497312, 594.1829983772313, 541.4991133201772, 565.9009673307155, 603.6559161278117, 606.8118883146238, 612.5773216480703, 9210.95394523023, 9569.330146889652, 9594.0, 9678.27412944032, 10039.69880903574, 571.7627184718378, 596.8806238752267, 638.1385130074456, 663.8349696283088, 724.7064938699835, 4431.889202769957, 4607.654425918069, 4612.884677883079, 4904.092742842586, 5309.33633295838, 117762.0, 125501.0, 128258.35870820587, 129368.0, 129837.35081324533, 85826.0, 88556.0, 110827.44586277017, 112313.43843280895, 113425.0, 85338.14661853426, 87801.56099219463, 88353.0, 88375.55812220898, 91445.99999999868, 9265.814683706154, 9631.566579503798, 9686.225101991964, 9719.85420218683, 9882.209423246266, 49520.50479495303, 51047.0, 51775.74112129415, 51952.22071668853, 52394.73802630963, 73024.63487682528, 74777.62611186909, 76147.61926190334, 76852.0, 78099.0, 13148.60554183376, 13180.736385272432, 13281.734365312834, 13403.396847141707, 13801.51694690681, 14005.159690418608, 14190.361433735301, 14537.491187808377, 14706.264686765833, 15494.922525387301, 13869.861301386856, 14346.426142954166, 14371.0, 14543.92728036353, 14860.369189946832, 13078.607641770763, 13286.734265314833, 13354.131981421177, 13715.0, 14127.576172714835, 13596.184228946295, 13707.383167757276, 13775.173489590657, 13811.378487967864, 15236.847631523542, 11364.431778411212, 11371.772564548828, 11395.715107122389, 11501.942490287494, 11805.645830625095, 9448.527573621153, 9944.204463642747, 10301.587936482756, 10438.425886576311, 10451.529681164518], "value": 7635.498463359446, "unit": "score"}], "name": "dromaeo_css", "value": 7276.4965707237425, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 111.0, 111.0, 113.0, 113.0, 113.0, 111.0, 111.0, 112.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 120.0, 120.0, 182.0, 120.0, 125.0, 139.0, 120.0, 159.0, 116.0], "value": 134.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 162.0, 161.0, 160.0, 163.0, 168.0, 162.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 115.0, 76.0, 77.0, 74.0, 75.0, 106.0, 75.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 136.0, 84.0, 85.0, 84.0, 123.0, 83.0, 83.0, 128.0], "value": 97.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 50.0, 52.0, 51.0, 52.0, 51.0, 53.0, 50.0, 51.0, 50.0], "value": 51.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 61.0, 61.0, 60.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 75.0, 76.0, 76.0, 75.0, 76.0, 76.0, 75.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 128.0, 129.0, 134.0, 130.0, 130.0, 121.0, 120.0, 138.0, 130.0], "value": 129.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 159.0, 158.0, 162.0, 161.0, 156.0, 162.0, 159.0, 159.0, 160.0], "value": 159.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 64.0, 62.0, 63.0, 62.0, 61.0, 65.0, 62.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1483.8, "alertThreshold": 2.0}]} 08:42:42 INFO - Return code: 0 08:42:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:42:42 INFO - # TBPL SUCCESS # 08:42:42 INFO - Running post-action listener: _resource_record_post_action 08:42:42 INFO - [mozharness: 2016-08-10 15:42:42.532333Z] Finished run-tests step (success) 08:42:42 INFO - Running post-run listener: _resource_record_post_run 08:42:42 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 545112064; Read time: 4; Write time: 421180 08:42:42 INFO - TinderboxPrint: CPU usage
13.1% 08:42:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 08:42:42 INFO - TinderboxPrint: I/O write bytes / time
545,112,064 / 421,180 08:42:42 INFO - TinderboxPrint: CPU idle
8,274.3 (86.9%) 08:42:42 INFO - TinderboxPrint: CPU user
1,202.9 (12.6%) 08:42:42 INFO - TinderboxPrint: Swap in / out
0 / 0 08:42:42 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 257732608; Read time: 0; Write time: 246344 08:42:42 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 286900224; Read time: 0; Write time: 174788 08:42:43 INFO - Running post-run listener: _upload_blobber_files 08:42:43 INFO - Blob upload gear active. 08:42:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:42:43 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 08:42:43 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'] 08:42:43 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 08:42:43 INFO - (blobuploader) - INFO - Open directory for files ... 08:42:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:42:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:42:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:42:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:42:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:42:44 INFO - (blobuploader) - INFO - Done attempting. 08:42:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:42:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:42:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:42:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:42:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:42:45 INFO - (blobuploader) - INFO - Done attempting. 08:42:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:42:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:42:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:42:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:42:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:42:50 INFO - (blobuploader) - INFO - Done attempting. 08:42:50 INFO - (blobuploader) - INFO - Iteration through files over. 08:42:50 INFO - Return code: 0 08:42:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:42:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:42:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c784f0f9a09ff503f1b26fc20a247526b38ed5effe50d04841e4f1b8b6d59e27e0da927ab3a161c58a697aac743a5b87fe92779cb843c27f2c56849f7f53e82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fa5a7824603d7e42c1a0b786769475e612bd3930e30b41d26909afbcc7669ca8bdce5ea87a3c813fa190307b4d5655cd73a383e58181672926a77159156e3f57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/89647689110027b2acac605776fc895a630520dec4eda1fd6fa9fbce879f6de6e7400f481175b7c4c03313412b66da475fb40e6f72ba4d201d427fdf5a70672c"} 08:42:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:42:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:42:50 INFO - Contents: 08:42:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c784f0f9a09ff503f1b26fc20a247526b38ed5effe50d04841e4f1b8b6d59e27e0da927ab3a161c58a697aac743a5b87fe92779cb843c27f2c56849f7f53e82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fa5a7824603d7e42c1a0b786769475e612bd3930e30b41d26909afbcc7669ca8bdce5ea87a3c813fa190307b4d5655cd73a383e58181672926a77159156e3f57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/89647689110027b2acac605776fc895a630520dec4eda1fd6fa9fbce879f6de6e7400f481175b7c4c03313412b66da475fb40e6f72ba4d201d427fdf5a70672c"} 08:42:50 INFO - Running post-run listener: copy_logs_to_upload_dir 08:42:50 INFO - Copying logs to upload dir... 08:42:50 INFO - mkdir: /builds/slave/test/build/upload/logs 08:42:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.158230 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-08-10 08:42:50.478498) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 08:42:50.481567) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1470842536.966785-1805859118 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/6c784f0f9a09ff503f1b26fc20a247526b38ed5effe50d04841e4f1b8b6d59e27e0da927ab3a161c58a697aac743a5b87fe92779cb843c27f2c56849f7f53e82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fa5a7824603d7e42c1a0b786769475e612bd3930e30b41d26909afbcc7669ca8bdce5ea87a3c813fa190307b4d5655cd73a383e58181672926a77159156e3f57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/89647689110027b2acac605776fc895a630520dec4eda1fd6fa9fbce879f6de6e7400f481175b7c4c03313412b66da475fb40e6f72ba4d201d427fdf5a70672c"} build_url:https://queue.taskcluster.net/v1/task/FUTGxNqCQtKlN2KsnAPyTQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011255 build_url: 'https://queue.taskcluster.net/v1/task/FUTGxNqCQtKlN2KsnAPyTQ/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/6c784f0f9a09ff503f1b26fc20a247526b38ed5effe50d04841e4f1b8b6d59e27e0da927ab3a161c58a697aac743a5b87fe92779cb843c27f2c56849f7f53e82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fa5a7824603d7e42c1a0b786769475e612bd3930e30b41d26909afbcc7669ca8bdce5ea87a3c813fa190307b4d5655cd73a383e58181672926a77159156e3f57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/89647689110027b2acac605776fc895a630520dec4eda1fd6fa9fbce879f6de6e7400f481175b7c4c03313412b66da475fb40e6f72ba4d201d427fdf5a70672c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 08:42:50.512610) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 08:42:50.512935) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1470842536.966785-1805859118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 08:42:50.599009) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 08:42:50.599342) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 08:42:50.599670) ========= ========= Total master_lag: 0.18 =========