builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-064 starttime: 1469114160.17 results: success (0) buildid: 20160721053033 builduid: 5e064fda2b6645a79cfd45b6d8d7995e revision: d8a5ea157504793ff2bb2b5161103154a31f08e3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 08:16:00.173042) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 08:16:00.173782) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 08:16:00.174352) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 08:16:00.202800) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 08:16:00.203086) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1469114092.661925-1380067104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-21 08:16:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 36.6M=0s 2016-07-21 08:16:00 (36.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095178 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 08:16:00.315481) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 08:16:00.316033) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1469114092.661925-1380067104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018435 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 08:16:00.371120) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 08:16:00.371840) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d8a5ea157504793ff2bb2b5161103154a31f08e3 --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 d8a5ea157504793ff2bb2b5161103154a31f08e3 --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=a12cd81e0ef515edd9e0d800000001bb-1469114092.661925-1380067104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-21 08:16:00,674 truncating revision to first 12 chars 2016-07-21 08:16:00,675 Setting DEBUG logging. 2016-07-21 08:16:00,675 attempt 1/10 2016-07-21 08:16:00,675 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d8a5ea157504?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-21 08:16:01,114 unpacking tar archive at: fx-team-d8a5ea157504/testing/mozharness/ program finished with exit code 0 elapsedTime=0.802634 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 08:16:01.196041) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 08:16:01.196414) ========= script_repo_revision: d8a5ea157504793ff2bb2b5161103154a31f08e3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 08:16:01.196813) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 08:16:01.197110) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 08:16:01.211493) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-07-21 08:16:01.212156) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=a12cd81e0ef515edd9e0d800000001bb-1469114092.661925-1380067104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:16:01 INFO - MultiFileLogger online at 20160721 08:16:01 in /builds/slave/test 08:16:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:16:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:16:01 INFO - {'append_to_log': False, 08:16:01 INFO - 'base_work_dir': '/builds/slave/test', 08:16:01 INFO - 'blob_upload_branch': 'Fx-Team', 08:16:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:16:01 INFO - 'branch': 'Fx-Team', 08:16:01 INFO - 'buildbot_json_path': 'buildprops.json', 08:16:01 INFO - 'config_files': ('talos/linux_config.py',), 08:16:01 INFO - 'default_actions': ('clobber', 08:16:01 INFO - 'read-buildbot-config', 08:16:01 INFO - 'download-and-extract', 08:16:01 INFO - 'populate-webroot', 08:16:01 INFO - 'create-virtualenv', 08:16:01 INFO - 'install', 08:16:01 INFO - 'run-tests'), 08:16:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:16:01 INFO - 'download_minidump_stackwalk': True, 08:16:01 INFO - 'download_symbols': 'ondemand', 08:16:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:16:01 INFO - 'tooltool.py': '/tools/tooltool.py', 08:16:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:16:01 INFO - '/tools/misc-python/virtualenv.py')}, 08:16:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:16:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:16:01 INFO - 'installer_path': 'installer.exe', 08:16:01 INFO - 'log_level': 'info', 08:16:01 INFO - 'log_name': 'talos', 08:16:01 INFO - 'log_to_console': True, 08:16:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:16:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:16:01 INFO - 'opt_config_files': (), 08:16:01 INFO - 'pip_index': False, 08:16:01 INFO - 'sps_profile': False, 08:16:01 INFO - 'sps_profile_interval': 0, 08:16:01 INFO - 'suite': 'dromaeojs-e10s', 08:16:01 INFO - 'system_bits': '32', 08:16:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:16:01 INFO - 'title': 'talos-linux64-ix-064', 08:16:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:16:01 INFO - 'use_talos_json': True, 08:16:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:16:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:16:01 INFO - 'work_dir': 'build'} 08:16:01 INFO - [mozharness: 2016-07-21 15:16:01.602443Z] Running clobber step. 08:16:01 INFO - Running pre-action listener: _resource_record_pre_action 08:16:01 INFO - Running main action method: clobber 08:16:01 INFO - rmtree: /builds/slave/test/build 08:16:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:16:02 INFO - Running post-action listener: _resource_record_post_action 08:16:02 INFO - [mozharness: 2016-07-21 15:16:02.085347Z] Finished clobber step (success) 08:16:02 INFO - [mozharness: 2016-07-21 15:16:02.085448Z] Running read-buildbot-config step. 08:16:02 INFO - Running pre-action listener: _resource_record_pre_action 08:16:02 INFO - Running main action method: read_buildbot_config 08:16:02 INFO - Using buildbot properties: 08:16:02 INFO - { 08:16:02 INFO - "project": "", 08:16:02 INFO - "product": "firefox", 08:16:02 INFO - "script_repo_revision": "production", 08:16:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:16:02 INFO - "repository": "", 08:16:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:16:02 INFO - "buildid": "20160721053033", 08:16:02 INFO - "pgo_build": "True", 08:16:02 INFO - "basedir": "/builds/slave/test", 08:16:02 INFO - "buildnumber": 595, 08:16:02 INFO - "slavename": "talos-linux64-ix-064", 08:16:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:16:02 INFO - "platform": "ubuntu64_hw", 08:16:02 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:16:02 INFO - "branch": "fx-team", 08:16:02 INFO - "repo_path": "integration/fx-team", 08:16:02 INFO - "revision": "d8a5ea157504793ff2bb2b5161103154a31f08e3", 08:16:02 INFO - "stage_platform": "linux64-pgo", 08:16:02 INFO - "builduid": "5e064fda2b6645a79cfd45b6d8d7995e", 08:16:02 INFO - "slavebuilddir": "test" 08:16:02 INFO - } 08:16:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:16:02 INFO - Running post-action listener: _resource_record_post_action 08:16:02 INFO - [mozharness: 2016-07-21 15:16:02.087892Z] Finished read-buildbot-config step (success) 08:16:02 INFO - [mozharness: 2016-07-21 15:16:02.087980Z] Running download-and-extract step. 08:16:02 INFO - Running pre-action listener: _resource_record_pre_action 08:16:02 INFO - Running main action method: download_and_extract 08:16:02 INFO - mkdir: /builds/slave/test/build/tests 08:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:02 INFO - https://queue.taskcluster.net/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:16:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:16:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:16:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:16:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:16:07 INFO - Downloaded 1361 bytes. 08:16:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:16:07 INFO - Using the following test package requirements: 08:16:07 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:16:07 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:16:07 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:16:07 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:07 INFO - u'jsshell-linux-x86_64.zip'], 08:16:07 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:16:07 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:16:07 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:16:07 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:16:07 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:16:07 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:16:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:07 INFO - https://queue.taskcluster.net/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:16:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:16:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:16:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:16:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:16:09 INFO - Downloaded 24342878 bytes. 08:16:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:16:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:16:10 INFO - Return code: 0 08:16:10 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:16:10 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:10 INFO - https://queue.taskcluster.net/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:16:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:16:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:16:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:16:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:16:12 INFO - Downloaded 24342878 bytes. 08:16:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:16:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:16:14 INFO - Return code: 0 08:16:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:14 INFO - https://queue.taskcluster.net/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:16:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:16:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:16:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:16:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:16:15 INFO - Downloaded 14403317 bytes. 08:16:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:16:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:16:15 INFO - Return code: 0 08:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:15 INFO - https://queue.taskcluster.net/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:16:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:16:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:16:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:16:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:16:17 INFO - Downloaded 60892912 bytes. 08:16:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:16:17 INFO - mkdir: /builds/slave/test/properties 08:16:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:16:17 INFO - Writing to file /builds/slave/test/properties/build_url 08:16:17 INFO - Contents: 08:16:17 INFO - build_url:https://queue.taskcluster.net/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:16:17 INFO - Running post-action listener: _resource_record_post_action 08:16:17 INFO - Running post-action listener: set_extra_try_arguments 08:16:17 INFO - [mozharness: 2016-07-21 15:16:17.836152Z] Finished download-and-extract step (success) 08:16:17 INFO - [mozharness: 2016-07-21 15:16:17.836481Z] Running populate-webroot step. 08:16:17 INFO - Running pre-action listener: _resource_record_pre_action 08:16:17 INFO - Running main action method: populate_webroot 08:16:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:16:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:16:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:16:17 INFO - '--tppagecycles', 08:16:17 INFO - '7'], 08:16:17 INFO - 'tests': ['tsvgm']}}, 08:16:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:16:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:16:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:16:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:16:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:16:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:16:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:17 INFO - 'talos_options': ['--disable-e10s'], 08:16:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:16:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:16:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:17 INFO - 'talos_options': ['--disable-e10s'], 08:16:17 INFO - 'tests': ['damp', 'tps']}, 08:16:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:17 INFO - 'tests': ['damp', 'tps']}, 08:16:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:16:17 INFO - 'tests': ['dromaeo_dom']}, 08:16:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:16:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:16:17 INFO - 'tests': ['basic_compositor_video']}, 08:16:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:16:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:16:17 INFO - 'tests': ['a11yr', 08:16:17 INFO - 'ts_paint', 08:16:17 INFO - 'tpaint', 08:16:17 INFO - 'sessionrestore', 08:16:17 INFO - 'sessionrestore_no_auto_restore', 08:16:17 INFO - 'tabpaint']}, 08:16:17 INFO - 'other-e10s': {'tests': ['a11yr', 08:16:17 INFO - 'ts_paint', 08:16:17 INFO - 'tpaint', 08:16:17 INFO - 'sessionrestore', 08:16:17 INFO - 'sessionrestore_no_auto_restore', 08:16:17 INFO - 'tabpaint']}, 08:16:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:16:17 INFO - 'ts_paint', 08:16:17 INFO - 'tpaint', 08:16:17 INFO - 'sessionrestore', 08:16:17 INFO - 'sessionrestore_no_auto_restore', 08:16:17 INFO - 'tabpaint']}, 08:16:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:16:17 INFO - 'ts_paint', 08:16:17 INFO - 'tpaint', 08:16:17 INFO - 'sessionrestore', 08:16:17 INFO - 'sessionrestore_no_auto_restore', 08:16:17 INFO - 'tabpaint']}, 08:16:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:16:17 INFO - 'tests': ['a11yr', 08:16:17 INFO - 'ts_paint', 08:16:17 INFO - 'tpaint', 08:16:17 INFO - 'sessionrestore', 08:16:17 INFO - 'sessionrestore_no_auto_restore', 08:16:17 INFO - 'tabpaint']}, 08:16:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:16:17 INFO - 'tests': ['a11yr', 08:16:17 INFO - 'ts_paint', 08:16:17 INFO - 'tpaint', 08:16:17 INFO - 'sessionrestore', 08:16:17 INFO - 'sessionrestore_no_auto_restore', 08:16:17 INFO - 'tabpaint']}, 08:16:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:16:17 INFO - 'tests': ['tsvgx', 08:16:17 INFO - 'tsvgr_opacity', 08:16:17 INFO - 'tart', 08:16:17 INFO - 'tscrollx', 08:16:17 INFO - 'cart']}, 08:16:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:16:17 INFO - 'tsvgr_opacity', 08:16:17 INFO - 'tart', 08:16:17 INFO - 'tscrollx', 08:16:17 INFO - 'cart']}, 08:16:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:17 INFO - 'talos_options': ['--disable-e10s'], 08:16:17 INFO - 'tests': ['tp5o']}, 08:16:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:17 INFO - 'tests': ['tp5o']}, 08:16:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:17 INFO - 'talos_options': ['--disable-e10s', 08:16:17 INFO - '--xperf_path', 08:16:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:16:17 INFO - 'tests': ['tp5n']}, 08:16:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:17 INFO - 'talos_options': ['--xperf_path', 08:16:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:16:17 INFO - 'tests': ['tp5n']}}, 08:16:17 INFO - 'talos.zip': {'path': '', 08:16:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:16:17 INFO - Running post-action listener: _resource_record_post_action 08:16:17 INFO - [mozharness: 2016-07-21 15:16:17.858799Z] Finished populate-webroot step (success) 08:16:17 INFO - [mozharness: 2016-07-21 15:16:17.858889Z] Running create-virtualenv step. 08:16:17 INFO - Running pre-action listener: _resource_record_pre_action 08:16:17 INFO - Running main action method: create_virtualenv 08:16:17 INFO - Creating virtualenv /builds/slave/test/build/venv 08:16:17 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:16:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:16:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:16:17 INFO - Using real prefix '/usr' 08:16:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:16:18 INFO - Installing distribute.............................................................................................................................................................................................done. 08:16:20 INFO - Installing pip.................done. 08:16:20 INFO - Return code: 0 08:16:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a23b0>, '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 0x14a32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a3740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469114092.661925-1380067104', '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:16:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:16:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:16:20 INFO - Using env: {'DISPLAY': ':0', 08:16:20 INFO - 'HOME': '/home/cltbld', 08:16:20 INFO - 'LANG': 'en_US.UTF-8', 08:16:20 INFO - 'LANGUAGE': 'en_US:en', 08:16:20 INFO - 'LOGNAME': 'cltbld', 08:16:20 INFO - 'MAIL': '/var/mail/cltbld', 08:16:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:20 INFO - 'MOZ_NO_REMOTE': '1', 08:16:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:20 INFO - 'NO_EM_RESTART': '1', 08:16:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:20 INFO - 'PWD': '/builds/slave/test', 08:16:20 INFO - 'SHELL': '/bin/bash', 08:16:20 INFO - 'SHLVL': '1', 08:16:20 INFO - 'TERM': 'linux', 08:16:20 INFO - 'TMOUT': '86400', 08:16:20 INFO - 'USER': 'cltbld', 08:16:20 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469114092.661925-1380067104', 08:16:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:20 INFO - '_': '/tools/buildbot/bin/python'} 08:16:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:20 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:16:20 INFO - Cleaning up... 08:16:20 INFO - Return code: 0 08:16:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a23b0>, '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 0x14a32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a3740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469114092.661925-1380067104', '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:16:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:16:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:16:20 INFO - Using env: {'DISPLAY': ':0', 08:16:20 INFO - 'HOME': '/home/cltbld', 08:16:20 INFO - 'LANG': 'en_US.UTF-8', 08:16:20 INFO - 'LANGUAGE': 'en_US:en', 08:16:20 INFO - 'LOGNAME': 'cltbld', 08:16:20 INFO - 'MAIL': '/var/mail/cltbld', 08:16:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:20 INFO - 'MOZ_NO_REMOTE': '1', 08:16:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:20 INFO - 'NO_EM_RESTART': '1', 08:16:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:20 INFO - 'PWD': '/builds/slave/test', 08:16:20 INFO - 'SHELL': '/bin/bash', 08:16:20 INFO - 'SHLVL': '1', 08:16:20 INFO - 'TERM': 'linux', 08:16:20 INFO - 'TMOUT': '86400', 08:16:20 INFO - 'USER': 'cltbld', 08:16:20 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469114092.661925-1380067104', 08:16:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:20 INFO - '_': '/tools/buildbot/bin/python'} 08:16:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:20 INFO - Downloading/unpacking psutil>=3.1.1 08:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:16:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:16:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:16:22 INFO - Installing collected packages: psutil 08:16:22 INFO - Running setup.py install for psutil 08:16:23 INFO - building 'psutil._psutil_linux' extension 08:16:23 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:16:23 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:16:23 INFO - building 'psutil._psutil_posix' extension 08:16:23 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:16:23 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:16:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:16:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:16:23 INFO - Successfully installed psutil 08:16:23 INFO - Cleaning up... 08:16:23 INFO - Return code: 0 08:16:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:16:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a23b0>, '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 0x14a32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a3740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469114092.661925-1380067104', '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:16:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:16:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:16:23 INFO - Using env: {'DISPLAY': ':0', 08:16:23 INFO - 'HOME': '/home/cltbld', 08:16:23 INFO - 'LANG': 'en_US.UTF-8', 08:16:23 INFO - 'LANGUAGE': 'en_US:en', 08:16:23 INFO - 'LOGNAME': 'cltbld', 08:16:23 INFO - 'MAIL': '/var/mail/cltbld', 08:16:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:23 INFO - 'MOZ_NO_REMOTE': '1', 08:16:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:23 INFO - 'NO_EM_RESTART': '1', 08:16:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:23 INFO - 'PWD': '/builds/slave/test', 08:16:23 INFO - 'SHELL': '/bin/bash', 08:16:23 INFO - 'SHLVL': '1', 08:16:23 INFO - 'TERM': 'linux', 08:16:23 INFO - 'TMOUT': '86400', 08:16:23 INFO - 'USER': 'cltbld', 08:16:23 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469114092.661925-1380067104', 08:16:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:23 INFO - '_': '/tools/buildbot/bin/python'} 08:16:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:16:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:16:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:16:26 INFO - Installing collected packages: mozsystemmonitor 08:16:26 INFO - Running setup.py install for mozsystemmonitor 08:16:26 INFO - Successfully installed mozsystemmonitor 08:16:26 INFO - Cleaning up... 08:16:26 INFO - Return code: 0 08:16:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a23b0>, '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 0x14a32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a3740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469114092.661925-1380067104', '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:16:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:16:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:16:26 INFO - Using env: {'DISPLAY': ':0', 08:16:26 INFO - 'HOME': '/home/cltbld', 08:16:26 INFO - 'LANG': 'en_US.UTF-8', 08:16:26 INFO - 'LANGUAGE': 'en_US:en', 08:16:26 INFO - 'LOGNAME': 'cltbld', 08:16:26 INFO - 'MAIL': '/var/mail/cltbld', 08:16:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:26 INFO - 'MOZ_NO_REMOTE': '1', 08:16:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:26 INFO - 'NO_EM_RESTART': '1', 08:16:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:26 INFO - 'PWD': '/builds/slave/test', 08:16:26 INFO - 'SHELL': '/bin/bash', 08:16:26 INFO - 'SHLVL': '1', 08:16:26 INFO - 'TERM': 'linux', 08:16:26 INFO - 'TMOUT': '86400', 08:16:26 INFO - 'USER': 'cltbld', 08:16:26 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469114092.661925-1380067104', 08:16:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:26 INFO - '_': '/tools/buildbot/bin/python'} 08:16:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:26 INFO - Downloading/unpacking jsonschema==2.5.1 08:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:16:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:28 INFO - Downloading functools32-3.2.3-2.tar.gz 08:16:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:16:28 INFO - warning: no files found matching '*.txt' 08:16:28 INFO - no previously-included directories found matching 'build' 08:16:28 INFO - no previously-included directories found matching 'dist' 08:16:28 INFO - no previously-included directories found matching '.git*' 08:16:28 INFO - Installing collected packages: jsonschema, functools32 08:16:28 INFO - Running setup.py install for functools32 08:16:28 INFO - warning: no files found matching '*.txt' 08:16:28 INFO - no previously-included directories found matching 'build' 08:16:28 INFO - no previously-included directories found matching 'dist' 08:16:28 INFO - no previously-included directories found matching '.git*' 08:16:29 INFO - Successfully installed jsonschema functools32 08:16:29 INFO - Cleaning up... 08:16:29 INFO - Return code: 0 08:16:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:16: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16: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', '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 0x11e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a23b0>, '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 0x14a32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a3740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469114092.661925-1380067104', '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:16: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:16: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 blobuploader==1.2.4 08:16:29 INFO - Using env: {'DISPLAY': ':0', 08:16:29 INFO - 'HOME': '/home/cltbld', 08:16:29 INFO - 'LANG': 'en_US.UTF-8', 08:16:29 INFO - 'LANGUAGE': 'en_US:en', 08:16:29 INFO - 'LOGNAME': 'cltbld', 08:16:29 INFO - 'MAIL': '/var/mail/cltbld', 08:16:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:29 INFO - 'MOZ_NO_REMOTE': '1', 08:16:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:29 INFO - 'NO_EM_RESTART': '1', 08:16:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:29 INFO - 'PWD': '/builds/slave/test', 08:16:29 INFO - 'SHELL': '/bin/bash', 08:16:29 INFO - 'SHLVL': '1', 08:16:29 INFO - 'TERM': 'linux', 08:16:29 INFO - 'TMOUT': '86400', 08:16:29 INFO - 'USER': 'cltbld', 08:16:29 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469114092.661925-1380067104', 08:16:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:29 INFO - '_': '/tools/buildbot/bin/python'} 08:16:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:29 INFO - Downloading/unpacking blobuploader==1.2.4 08:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:31 INFO - Downloading blobuploader-1.2.4.tar.gz 08:16:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:16:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:16:31 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:16:31 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:16:31 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:16:31 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:16:31 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:16:31 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:16:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:16:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:16:31 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:16:31 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:16:31 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:16:31 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:16:31 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:16:31 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:16:31 INFO - Downloading docopt-0.6.1.tar.gz 08:16:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:16:32 INFO - Installing collected packages: blobuploader, requests, docopt 08:16:32 INFO - Running setup.py install for blobuploader 08:16:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:16:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:16:32 INFO - Running setup.py install for requests 08:16:32 INFO - Running setup.py install for docopt 08:16:32 INFO - Successfully installed blobuploader requests docopt 08:16:32 INFO - Cleaning up... 08:16:32 INFO - Return code: 0 08:16:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:16: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:32 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 0x11e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a23b0>, '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 0x14a32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a3740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469114092.661925-1380067104', '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:16:32 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:16:32 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:16:32 INFO - Using env: {'DISPLAY': ':0', 08:16:32 INFO - 'HOME': '/home/cltbld', 08:16:32 INFO - 'LANG': 'en_US.UTF-8', 08:16:32 INFO - 'LANGUAGE': 'en_US:en', 08:16:32 INFO - 'LOGNAME': 'cltbld', 08:16:32 INFO - 'MAIL': '/var/mail/cltbld', 08:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:32 INFO - 'MOZ_NO_REMOTE': '1', 08:16:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:32 INFO - 'NO_EM_RESTART': '1', 08:16:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:32 INFO - 'PWD': '/builds/slave/test', 08:16:32 INFO - 'SHELL': '/bin/bash', 08:16:32 INFO - 'SHLVL': '1', 08:16:32 INFO - 'TERM': 'linux', 08:16:32 INFO - 'TMOUT': '86400', 08:16:32 INFO - 'USER': 'cltbld', 08:16:32 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469114092.661925-1380067104', 08:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:32 INFO - '_': '/tools/buildbot/bin/python'} 08:16:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:16:32 INFO - Running setup.py (path:/tmp/pip-zy3af7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:16:32 INFO - Running setup.py (path:/tmp/pip-6C93Ts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:16:32 INFO - Running setup.py (path:/tmp/pip-X3KqnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:16:33 INFO - Running setup.py (path:/tmp/pip-48wt2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:16:33 INFO - Running setup.py (path:/tmp/pip-3PYmCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:16:33 INFO - Running setup.py (path:/tmp/pip-bK2i5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:16:33 INFO - Running setup.py (path:/tmp/pip-oDaBvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:16:33 INFO - Running setup.py (path:/tmp/pip-nfZxQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:16:33 INFO - Running setup.py (path:/tmp/pip-d2nmAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:16:33 INFO - Running setup.py (path:/tmp/pip-RocGpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:16:33 INFO - Running setup.py (path:/tmp/pip-KAwQyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:16:33 INFO - Running setup.py (path:/tmp/pip-axpmxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:16:33 INFO - Running setup.py (path:/tmp/pip-3uZs7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:16:33 INFO - Running setup.py (path:/tmp/pip-89RCkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:33 INFO - Running setup.py (path:/tmp/pip-4gdNjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:16:33 INFO - Running setup.py (path:/tmp/pip-aR0K2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:16:34 INFO - Running setup.py (path:/tmp/pip-f8Ygp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:16:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:16:34 INFO - Running setup.py install for manifestparser 08:16:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:16:34 INFO - Running setup.py install for mozcrash 08:16:34 INFO - Running setup.py install for mozdebug 08:16:34 INFO - Running setup.py install for mozdevice 08:16:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:16:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:16:34 INFO - Running setup.py install for mozfile 08:16:34 INFO - Running setup.py install for mozhttpd 08:16:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:16:34 INFO - Running setup.py install for mozinfo 08:16:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:16:34 INFO - Running setup.py install for mozInstall 08:16:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:16:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:16:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:16:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:16:34 INFO - Running setup.py install for mozleak 08:16:34 INFO - Running setup.py install for mozlog 08:16:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:16:35 INFO - Running setup.py install for moznetwork 08:16:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:16:35 INFO - Running setup.py install for mozprocess 08:16:35 INFO - Running setup.py install for mozprofile 08:16:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:16:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:16:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:16:35 INFO - Running setup.py install for mozrunner 08:16:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:16:35 INFO - Running setup.py install for mozscreenshot 08:16:35 INFO - Running setup.py install for moztest 08:16:35 INFO - Running setup.py install for mozversion 08:16:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:16:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:16:35 INFO - Cleaning up... 08:16:35 INFO - Return code: 0 08:16:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:16: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:35 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 0x11e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a23b0>, '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 0x14a32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a3740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469114092.661925-1380067104', '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:16:35 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:16:35 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:16:35 INFO - Using env: {'DISPLAY': ':0', 08:16:35 INFO - 'HOME': '/home/cltbld', 08:16:35 INFO - 'LANG': 'en_US.UTF-8', 08:16:35 INFO - 'LANGUAGE': 'en_US:en', 08:16:35 INFO - 'LOGNAME': 'cltbld', 08:16:35 INFO - 'MAIL': '/var/mail/cltbld', 08:16:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:35 INFO - 'MOZ_NO_REMOTE': '1', 08:16:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:35 INFO - 'NO_EM_RESTART': '1', 08:16:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:35 INFO - 'PWD': '/builds/slave/test', 08:16:35 INFO - 'SHELL': '/bin/bash', 08:16:35 INFO - 'SHLVL': '1', 08:16:35 INFO - 'TERM': 'linux', 08:16:35 INFO - 'TMOUT': '86400', 08:16:35 INFO - 'USER': 'cltbld', 08:16:35 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469114092.661925-1380067104', 08:16:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:35 INFO - '_': '/tools/buildbot/bin/python'} 08:16:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:16:36 INFO - Running setup.py (path:/tmp/pip-lkRgR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:16:36 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:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:16:36 INFO - Running setup.py (path:/tmp/pip-el2EfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:16:36 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:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:16:36 INFO - Running setup.py (path:/tmp/pip-pNOdhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:16:36 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:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:16:36 INFO - Running setup.py (path:/tmp/pip-gf9MJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:16:36 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:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:16:36 INFO - Running setup.py (path:/tmp/pip-dMGXdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:16:36 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:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:16:36 INFO - Running setup.py (path:/tmp/pip-zvORAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:16:36 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:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:16:36 INFO - Running setup.py (path:/tmp/pip-Jo31Jl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:16:36 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:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:16:36 INFO - Running setup.py (path:/tmp/pip-OQnAVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:16:36 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:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:16:36 INFO - Running setup.py (path:/tmp/pip-yaKAiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:16:36 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:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:16:36 INFO - Running setup.py (path:/tmp/pip-RjB__I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:16:36 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:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:16:36 INFO - Running setup.py (path:/tmp/pip-OcvPzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:16:36 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:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:16:36 INFO - Running setup.py (path:/tmp/pip-E5C_vB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:16:37 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:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:16:37 INFO - Running setup.py (path:/tmp/pip-hPxSbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:16:37 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:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:16:37 INFO - Running setup.py (path:/tmp/pip-e0MdK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:16:37 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:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:37 INFO - Running setup.py (path:/tmp/pip-R3nlVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:37 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:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:16:37 INFO - Running setup.py (path:/tmp/pip-ChNUH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:16:37 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:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:16:37 INFO - Running setup.py (path:/tmp/pip-R9T_UL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:16:37 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:16:37 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:16:37 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:16:37 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:16:37 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:16:37 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:16:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:16: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:16: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:16: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:16: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:16: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:16: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:16:39 INFO - Downloading blessings-1.6.tar.gz 08:16:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:16:39 INFO - Installing collected packages: blessings 08:16:39 INFO - Running setup.py install for blessings 08:16:39 INFO - Successfully installed blessings 08:16:39 INFO - Cleaning up... 08:16:39 INFO - Return code: 0 08:16:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:16:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:16:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:16:40 INFO - Reading from file tmpfile_stdout 08:16:40 INFO - Current package versions: 08:16:40 INFO - argparse == 1.2.1 08:16:40 INFO - blessings == 1.6 08:16:40 INFO - blobuploader == 1.2.4 08:16:40 INFO - docopt == 0.6.1 08:16:40 INFO - functools32 == 3.2.3-2 08:16:40 INFO - jsonschema == 2.5.1 08:16:40 INFO - manifestparser == 1.1 08:16:40 INFO - mozInstall == 1.12 08:16:40 INFO - mozcrash == 0.17 08:16:40 INFO - mozdebug == 0.1 08:16:40 INFO - mozdevice == 0.48 08:16:40 INFO - mozfile == 1.2 08:16:40 INFO - mozhttpd == 0.7 08:16:40 INFO - mozinfo == 0.9 08:16:40 INFO - mozleak == 0.1 08:16:40 INFO - mozlog == 3.3 08:16:40 INFO - moznetwork == 0.27 08:16:40 INFO - mozprocess == 0.23 08:16:40 INFO - mozprofile == 0.28 08:16:40 INFO - mozrunner == 6.12 08:16:40 INFO - mozscreenshot == 0.1 08:16:40 INFO - mozsystemmonitor == 0.3 08:16:40 INFO - moztest == 0.7 08:16:40 INFO - mozversion == 1.4 08:16:40 INFO - psutil == 3.1.1 08:16:40 INFO - requests == 1.2.3 08:16:40 INFO - wsgiref == 0.1.2 08:16:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:40 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 0x11e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a23b0>, '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 0x14a32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a3740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469114092.661925-1380067104', '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:16:40 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:16:40 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:16:40 INFO - Using env: {'DISPLAY': ':0', 08:16:40 INFO - 'HOME': '/home/cltbld', 08:16:40 INFO - 'LANG': 'en_US.UTF-8', 08:16:40 INFO - 'LANGUAGE': 'en_US:en', 08:16:40 INFO - 'LOGNAME': 'cltbld', 08:16:40 INFO - 'MAIL': '/var/mail/cltbld', 08:16:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:40 INFO - 'MOZ_NO_REMOTE': '1', 08:16:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:40 INFO - 'NO_EM_RESTART': '1', 08:16:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:40 INFO - 'PWD': '/builds/slave/test', 08:16:40 INFO - 'SHELL': '/bin/bash', 08:16:40 INFO - 'SHLVL': '1', 08:16:40 INFO - 'TERM': 'linux', 08:16:40 INFO - 'TMOUT': '86400', 08:16:40 INFO - 'USER': 'cltbld', 08:16:40 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469114092.661925-1380067104', 08:16:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:40 INFO - '_': '/tools/buildbot/bin/python'} 08:16:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:40 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:16:40 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:16:40 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:16:40 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:16:40 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:16:40 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:16:40 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:16:40 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:16:40 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:16:40 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:16:40 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:16:40 INFO - Cleaning up... 08:16:40 INFO - Return code: 0 08:16:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a23b0>, '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 0x14a32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a3740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469114092.661925-1380067104', '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:16:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:16:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:16:40 INFO - Using env: {'DISPLAY': ':0', 08:16:40 INFO - 'HOME': '/home/cltbld', 08:16:40 INFO - 'LANG': 'en_US.UTF-8', 08:16:40 INFO - 'LANGUAGE': 'en_US:en', 08:16:40 INFO - 'LOGNAME': 'cltbld', 08:16:40 INFO - 'MAIL': '/var/mail/cltbld', 08:16:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:40 INFO - 'MOZ_NO_REMOTE': '1', 08:16:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:40 INFO - 'NO_EM_RESTART': '1', 08:16:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:40 INFO - 'PWD': '/builds/slave/test', 08:16:40 INFO - 'SHELL': '/bin/bash', 08:16:40 INFO - 'SHLVL': '1', 08:16:40 INFO - 'TERM': 'linux', 08:16:40 INFO - 'TMOUT': '86400', 08:16:40 INFO - 'USER': 'cltbld', 08:16:40 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469114092.661925-1380067104', 08:16:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:40 INFO - '_': '/tools/buildbot/bin/python'} 08:16:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:16:40 INFO - Cleaning up... 08:16:40 INFO - Return code: 0 08:16:40 INFO - Running post-action listener: _resource_record_post_action 08:16:40 INFO - Running post-action listener: _start_resource_monitoring 08:16:40 INFO - Starting resource monitoring. 08:16:40 INFO - [mozharness: 2016-07-21 15:16:40.521865Z] Finished create-virtualenv step (success) 08:16:40 INFO - [mozharness: 2016-07-21 15:16:40.522336Z] Running install step. 08:16:40 INFO - Running pre-action listener: _resource_record_pre_action 08:16:40 INFO - Running main action method: install 08:16:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:16:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:16:40 INFO - Reading from file tmpfile_stdout 08:16:40 INFO - Detecting whether we're running mozinstall >=1.0... 08:16:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:16:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:16:40 INFO - Reading from file tmpfile_stdout 08:16:40 INFO - Output received: 08:16:40 INFO - Usage: mozinstall [options] installer 08:16:40 INFO - Options: 08:16:40 INFO - -h, --help show this help message and exit 08:16:40 INFO - -d DEST, --destination=DEST 08:16:40 INFO - Directory to install application into. [default: 08:16:40 INFO - "/builds/slave/test"] 08:16:40 INFO - --app=APP Application being installed. [default: firefox] 08:16:40 INFO - mkdir: /builds/slave/test/build/application 08:16:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:16:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:16:58 INFO - Reading from file tmpfile_stdout 08:16:58 INFO - Output received: 08:16:58 INFO - /builds/slave/test/build/application/firefox/firefox 08:16:58 INFO - Running post-action listener: _resource_record_post_action 08:16:58 INFO - [mozharness: 2016-07-21 15:16:58.068428Z] Finished install step (success) 08:16:58 INFO - [mozharness: 2016-07-21 15:16:58.068677Z] Running run-tests step. 08:16:58 INFO - Running pre-action listener: _resource_record_pre_action 08:16:58 INFO - Running main action method: run_tests 08:16:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:16:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:16:58 INFO - Python 2.7.3 08:16:58 INFO - Return code: 0 08:16:58 INFO - grabbing minidump binary from tooltool 08:16:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:58 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 0x14a23b0>, '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 0x14a32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a3740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:16:58 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:16:58 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:16:58 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:16:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:16:58 INFO - Return code: 0 08:16:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:16:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:16:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:16:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:16:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:16:58 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:16:58 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:16:58 INFO - Using env: {'DISPLAY': ':0', 08:16:58 INFO - 'HOME': '/home/cltbld', 08:16:58 INFO - 'LANG': 'en_US.UTF-8', 08:16:58 INFO - 'LANGUAGE': 'en_US:en', 08:16:58 INFO - 'LOGNAME': 'cltbld', 08:16:58 INFO - 'MAIL': '/var/mail/cltbld', 08:16:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:16:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:16:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:58 INFO - 'MOZ_NO_REMOTE': '1', 08:16:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:16:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:58 INFO - 'NO_EM_RESTART': '1', 08:16:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:58 INFO - 'PWD': '/builds/slave/test', 08:16:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:16:58 INFO - 'SHELL': '/bin/bash', 08:16:58 INFO - 'SHLVL': '1', 08:16:58 INFO - 'TERM': 'linux', 08:16:58 INFO - 'TMOUT': '86400', 08:16:58 INFO - 'USER': 'cltbld', 08:16:58 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469114092.661925-1380067104', 08:16:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:58 INFO - '_': '/tools/buildbot/bin/python'} 08:16:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:16:58 INFO - mozversion application_buildid: 20160721053033 08:16:58 INFO - mozversion application_changeset: d8a5ea157504793ff2bb2b5161103154a31f08e3 08:16:58 INFO - mozversion application_display_name: Nightly 08:16:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:16:58 INFO - mozversion application_name: Firefox 08:16:58 INFO - mozversion application_remotingname: firefox 08:16:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:16:58 INFO - mozversion application_vendor: Mozilla 08:16:58 INFO - mozversion application_version: 50.0a1 08:16:58 INFO - mozversion platform_buildid: 20160721053033 08:16:58 INFO - mozversion platform_changeset: d8a5ea157504793ff2bb2b5161103154a31f08e3 08:16:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:16:58 INFO - mozversion platform_version: 50.0a1 08:16:58 INFO - using testdate: 1469114218 08:16:58 INFO - actual date: 1469114218 08:16:58 INFO - starting webserver on 'localhost:39772' 08:16:58 INFO - SUITE-START | Running 2 tests 08:16:58 INFO - TEST-START | dromaeo_css 08:16:58 INFO - operating with platform_type : linux_ 08:16:58 INFO - Initialising browser for dromaeo_css test... 08:16:58 INFO - TEST-INFO | started process 27468 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX38Tnz/profile http://localhost:39772/getInfo.html) 08:17:03 INFO - PROCESS | 27468 | __metrics Screen width/height:1600/1200 08:17:03 INFO - PROCESS | 27468 | colorDepth:24 08:17:03 INFO - PROCESS | 27468 | Browser inner width/height: 1024/697 08:17:03 INFO - PROCESS | 27468 | __metrics 08:17:03 ERROR - PROCESS | 27468 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 08:17:04 INFO - TEST-INFO | 27468: exit 0 08:17:04 INFO - Browser initialized. 08:17:04 INFO - Running cycle 1/1 for dromaeo_css test... 08:17:04 INFO - TEST-INFO | started process 27591 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX38Tnz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:17:16 INFO - PROCESS | 27591 | RSS: Main: 166932480 08:17:16 INFO - PROCESS | 27591 | 08:18:06 INFO - PROCESS | 27591 | 1469114286197 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:20:14 INFO - PROCESS | 27591 | Cycle 1(1): loaded http://localhost:39772/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39772/tests/dromaeo/cssquery-ext.html) 08:20:15 INFO - PROCESS | 27591 | RSS: Main: 172843008 08:20:15 INFO - PROCESS | 27591 | 08:23:17 INFO - PROCESS | 27591 | Cycle 1(1): loaded http://localhost:39772/tests/dromaeo/cssquery-ext.html (next: http://localhost:39772/tests/dromaeo/cssquery-jquery.html) 08:23:18 INFO - PROCESS | 27591 | RSS: Main: 169619456 08:23:18 INFO - PROCESS | 27591 | 08:26:20 INFO - PROCESS | 27591 | Cycle 1(1): loaded http://localhost:39772/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39772/tests/dromaeo/cssquery-mootools.html) 08:26:20 INFO - PROCESS | 27591 | RSS: Main: 173563904 08:26:20 INFO - PROCESS | 27591 | 08:29:22 INFO - PROCESS | 27591 | Cycle 1(1): loaded http://localhost:39772/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39772/tests/dromaeo/cssquery-prototype.html) 08:29:23 INFO - PROCESS | 27591 | RSS: Main: 167514112 08:29:23 INFO - PROCESS | 27591 | 08:32:25 INFO - PROCESS | 27591 | Cycle 1(1): loaded http://localhost:39772/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39772/tests/dromaeo/cssquery-yui.html) 08:32:26 INFO - PROCESS | 27591 | RSS: Main: 169758720 08:32:26 INFO - PROCESS | 27591 | 08:35:29 INFO - PROCESS | 27591 | Cycle 1(1): loaded http://localhost:39772/tests/dromaeo/cssquery-yui.html (next: http://localhost:39772/tests/dromaeo/cssquery-dojo.html) 08:35:29 INFO - PROCESS | 27591 | RSS: Main: 170741760 08:35:29 INFO - PROCESS | 27591 | 08:35:29 INFO - PROCESS | 27591 | __start_tp_report 08:35:29 INFO - PROCESS | 27591 | _x_x_mozilla_page_load 08:35:29 INFO - PROCESS | 27591 | _x_x_mozilla_page_load_details 08:35:29 INFO - PROCESS | 27591 | |i|pagename|runs| 08:35:29 INFO - PROCESS | 27591 | |0;dojo.html;3049.3291475875308;3097.7831551791355;3100.1009707184917;3100.9379812403754;3110.486769683001;5481.534069604083;5500.092484740013;5541.9722901385485;5586.441355864412;5591.7483713232905;5393.2449457075945;5453.318335208099;5503.229547863302;5533.0870406383;5554;4954.876128096799;5005.724685142316;5077.41609714882;5093.439721630618;5111.744412779365;5067.6452648314635;5152.665076770017;5159.22611608258;5176.430592634807;5210.6613070150315;4925;4977.950220497785;4978.77595508203;5089.287499750019;5099.464556221599;5013.548780609763;5017.172166592508;5019.498050194988;5024.346834911475;5051.217061355459;4968.577670897978;4978.726170060645;4991.051700176955;5003.049420610072;5025;5376.247325374451;5378.408375078739;5466.125419932791;5480.287562616834;5518.448155184449;5846.824595262106;5860.267466566679;5860.915730589854;5863.2670916135485;5877.647341159502;5884.323302820188;5885.764569417218;5891.116332550109;5891.145783861359;5899.439553242478;5410.242566040718;5476;5477.863053423656;5516.338039435253;5517.724113794295;6115.449898208542;6130.3369889931655;6135.263289243823;6135.6189562855025;6139.101670439303;5853.063509838491;5854.121881717776;5857.355690874;5858.384869588717;5890.998530249782;5693.146028095736;5797.333306669787;5806.21616081832;5835.56233282497;5949.405059494016;5845;5847.356790753014;5870.002099643071;5880.764769409261;5933.406659334032;5860.326062502867;5878.147668588031;5878.794242201588;5885.117232415087;5893.587448878623;4428.778561071934;4460.063386688832;4487.932681009787;4519.344695019204;4530.77346132692;3973.602639736061;4009.4186342980106;4012.117334186474;4030.9596904031173;4033.798310084484;5594.356648985418;5628.127640215773;5638.802641907513;5643.322801263875;5653.23681303027;5778.046622307356;5888.941110588925;5931.82204533856;5934.762609495572;5947.256592925884;5591.07747221712;5640.266765320482;5651.57613179005;5674.177244299553;5682.40334764852;5075.365579302587;5087;5149.459306772735;5167.457416971239;5202.557782588447;5950.256217972754;6000.249968753906;6022.45797878193;6125.479334256638;6213.285472170668;5946.762129514771;5958.225430693982;5964.642121472725;5966.552508561788;5976.581639285208;6061.36355682647;6069.635821850703;6096.329403765493;6123.357047509948;6129.141920131096;5662.207290979349;5742.397048309867;5752.108423194411;5810.883782324415;5838.357780644041;5825.330087040044;5875.089361149029;5907.793227237026;5939.584229103922;5983.1025346196675;5839.182514448065;5850.12248162779;5864.091065884794;5869.413058694096;5905.763769449346;5815.156802263733;5828.970855145697;5833.154192641959;5840.912386314294;5843.912341314799;5587.860303492445;5677.914831277617;5704.600677952503;5715.885682286248;5720.485156335783;5818.156367326629;5826.388229236039;5838.649681019152;5869.207656966255;5912.231409916683;5697.829065128053;5745.6552606843725;5771.422857714195;5772.509336706427;5776.220210271559 08:35:29 INFO - PROCESS | 27591 | |1;ext.html;562.2710166238815;588.2323567744097;593.3206478582024;610.0361428942272;611.2878496551517;43994.340084898715;45638.087238255255;45702.31446528301;45818;48995.51004489954;45226.547734522646;45725.314120288225;46235;46281.76859115708;46478.76760616192;8873.778155546115;8973.865392019092;8992;9028.77428064297;9030.322725795559;8865.423747456427;8981.865272020892;8984.056674049229;8986.550672466383;8992.460452372847;9075.909240907606;9119.361644684876;9125;9126.087391260888;9147.17675409213;8972.327075469333;8998.37011409205;9007.819843603123;9048.77378065547;9062.093790620886;8881.200691937693;8891.288696904232;8910.376273660846;8921.866172007425;8929.107089291085;43257.78371108156;43760.343594846105;43805.78097109526;44046.11907761827;44052.55947440548;3501.7898926064518;3550.538430004083;3552.236269202134;3638.381475149231;3735.7758534488016;32927.67072329294;33211.16972075718;33230.169245768804;33248.6675133248;33351.33297334064;4373.868783936487;4421.668374871898;4451.376807246988;4452.866414007585;4556.589906908361;365232;365541;366365;367670;373066.13466932764;34894.12764680904;35952.46071308933;35999.64000359963;53229.46770532245;60056.699716501134;35576;35625;35827.82086089553;35941.46087808685;35959.280814383565;13793.310334483236;13889.166650001032;13906;13907;13947.372368243454;11367.602133925273;11446.14153938458;11467.254628449124;11486.0811135109;11487.597934072268;8122.390820688472;8243.175682431709;8304.335653147733;8305.37709671777;8355.456895301786;3206.679332066821;3215.935681286408;3229.0958531611186;3231.6122065352306;3285.572875526166;1038.7922415516928;1038.9168866490663;1044.4568824211367;1060.4326685223368;1183.7514122034297;32033;32874.17814554655;32945.505817412755;33256.83371583175;33783.493247601305;1144.0904480937675;1149.6608500492375;1184.8696643369221;1233.9511415296927;1280.481405030964;16159.919200403923;17510.600899711182;17547.73678394825;17615.471535853943;17840.821591784177;435195;435792;436638;437292;440039;56901.14648280279;57210.71394643;57362.13956790652;57453;57508;1328.966775830612;1350.1021820489461;1355.4307190979812;1357.8981576381614;1363.6863521390135;31666.525002125447;34823.825880870434;35127.47308790319;35657.28685426225;35778.821105894305;53043.46956530385;53228;53452.73273633607;53474.46525534851;53682.73158634182;464756;465062;468472;468751;469148;28463.857680711462;29520.852395737882;29671.25821854471;30076.24809379783;30101.24746881258;48686;49223.507764921895;50376.24435633542;50895.23657145072;51340.743296284774;41954.79022604867;43005;43502;44134;44606.55393446024;42915.57084429241;43684.344734828366;43746.781266093465;44290;45064.77467612772;41790.582094178666;42203.57796422119;42302.576974229865;42495;42540;36274;38646.42030369603;38810.27462877152;38900.80549597234;38946.22107557776;29501.85249073741;29587.260318492208;29722.702772972858;29942.70057299486;30024.849875750482 08:35:29 INFO - PROCESS | 27591 | |2;jquery.html;374.7133442916168;389.33618181001384;392.90963078491944;397.6600006994022;407.6168401702399;18480.445586632406;20984.265550705728;21063.578728425422;21297.787022129774;21305.680414793773;18936.90531547344;18943;19471.707924381146;19810.603787924232;19935.401937941886;5471;5702.116171993348;5774.769009239625;5779.537636989052;5913.467787899088;3761.9247615047684;4022.3162062449305;5833.708314584275;5850.444207800252;5858.502027327682;6566;6585.374389432996;6630.63531505767;6635.3032931541975;6644.933550664504;6598.340165983387;6603.801885943405;6620.172478440195;6627.867442651168;6667.066610674485;5736.82789516311;5857.6778277194735;5857.70711464425;5874.9412505874825;5910.438508341701;13466.461341546326;15630.9218453907;21059.78940210609;21716.782832171633;22143.778562214495;2285.4514916420108;2375.798057165143;2730.30377253801;2858.6998365171567;2936.0457851198234;9768.36505627139;10080.54637541305;10480.94759526205;11693.649190524298;14550.927245363811;1880.2948894164688;1888.7544619199552;1923.086533896402;1955.4426988308264;2022.6055919095782;82810;83839;84796;85619.57190214009;87907;10243.795124097625;10358.223133265035;10533.631322903662;10731.517081731341;11483.081353491702;14379.85620143806;14397.78403323951;14411.92794036023;14424.90838828364;14522.128672279698;7295.197528271886;7637;7695.6152192390155;7868.25251601097;7876.054873415227;7288;7313.085864266966;7326.377257933029;7490.925090749023;7571.848563028819;4415.66882483815;4465.687401881902;4480.843170489017;4493.303537951622;4523.411956445641;1856.2853301479029;1877.7371168036486;1881.3791448821855;1885.8397036251797;1940.5439721665398;974.1670871404989;1070.4808168038496;1104.5636973395624;1106.9594581093745;1107.06453047175;19435.51411214731;20237.49406264855;20612.27857025027;20934.162633494794;21099.367018989455;969.8351280282369;1012.372329155928;1038.361407734238;1041.2971244410144;1050.632278702448;10739.301945373525;11558.884411155781;11590.246633968765;11600.535978560763;11669.183157179086;415148.89447663154;420003;423479;423801;480368.3742138017;81578.59210703909;81615.46109992442;97524;99870;100999;1025.266934142092;1035.089121573026;1051.8737751469873;1064.3613831701073;1065.984010239847;17728.91135544314;18316.542086447946;18594.349197778552;18676.719849202545;18725.812741872953;43178.35232471453;43334.56665433305;43901.56098438975;44879.775601121786;44972.100557988;60889;60921.69539152276;62146.68926655338;62744.37255627568;62799;8302.584870756558;8480.406371553932;8537.274331681876;8538.786530336543;8798.428102173595;11873.881261187278;13039.934800325938;13195.076344655781;13373.197608143542;13997.300134993413;11343.092552595608;11552.537898483966;11729.35488548104;11784.175107742376;11949;11225.66323010311;11226.719332016764;11527.827082593936;11553.537858485566;11572.94213528927;5925.229720136527;8341.874871876806;11543.36511491876;11576.24754390962;12447.875521245034;8225.753227403187;8582.828343432971;8598.183172598594;8694.260987815853;8822.117788221127;10497.895021049691;10926.453677315943;11717.531298747954;11775.116866234895;11886.702832428913 08:35:29 INFO - PROCESS | 27591 | |3;mootools.html;1446.768517037274;1487.4868170481184;1636.8363163683632;1786.7319902014688;1813.5556788586807;7479;8617.913820861797;8678.175573320541;9222.86165707514;9249.30630202735;8840.292776577875;8841.425307355017;8881.73354799357;8888.111188881108;8945.776355591113;2343.144752165456;2357.610994185957;2363.976360236393;2375.8930848111877;2382.2614989353356;2328.3946173994714;2339.497008143249;2367.6093444581625;2381.6189409694452;2398.448356877919;2347.5539647466926;2352.764723527642;2363.5391098735754;2373.1575290771784;2386.9880650596724;2302.942426439344;2309.4341886237894;2310.376198426424;2311.711036120485;2372.8576285422755;2272.8068114210314;2323.0939933425975;2323.628219484874;2329.49915768109;2340.075670110297;8899.644014239422;8923.464592124494;8956.686515971975;8976.147266009719;8996.820063598756;4948.4309304429735;5022.648414610979;5137.229415587654;5229.163333866563;5262.05283049051;3125.48429509133;3279.7048265656204;3302.768806183568;3340.9498857517156;3358.277970236411;1101.608928830259;1146.249206769559;1156.653004098767;1158.723109090641;1160.7446361800392;11940.40297985106;11994.340311282876;12057.216280941711;12066.396680166044;12127.818082728767;4376.234159022159;4546.4544254689645;4606.101810147056;4726.007538416971;4729.503402142795;9968.053034961667;9978.101970822661;9980.45107519079;10012.299139060342;10049.14582260516;5119.3088932994315;5120.231965205249;5146.665466744725;5147.0735267651435;5150.510701483428;4175.54069052404;4742.217534106902;4775.474697783241;4887.0714564232685;4940.530649588283;3979.980100099539;4053.6757059435176;4072.2669919414197;4102.379560073754;4191.098913733501;1315.5592876386518;1332.8933685305153;1335.4057444437133;1344.3479912242556;1346.1451977994045;1029.1715169288645;1041.6354276003337;1047.711879233217;1057.0011339284304;1065.0574241795912;6051.152838602599;6237.594556353823;6294.339094395114;6448.258450278185;6521.380468855451;983.3362480325751;1019.7654539455818;1021.5300961557618;1022;1033.1424917318607;4083.97958010214;4168.437260969791;4189.874303770892;4206.621404073587;4307.612314891675;10609.73475663099;10836.078933290759;10910.23628346024;10914.672559823219;10955.123590112771;10302.793944121076;10683.145348372267;10824;10882.510287037103;10896.237263391646;7288.854222915512;7671.232876712395;7701.114371847198;7707.499012564165;7728.343090837229;6372.58578192416;6424.935750642434;6487.708053137714;6503.154589903283;6517.315681853527;10233.795324093626;10306.072453478922;10355.948220259152;10365.844512332473;10375.533101010322;9930.155936745457;10158.847617285894;10189.898101019191;10336.793264134825;10344.32761870476;7022.262662420577;7376.7418140364825;7499.362554182955;7604.5437273763755;7802.102758182881;8689.522076285864;8708.956455217683;8760.255378292917;8771.079036701054;8795.604197810986;7760.495567788075;7787.5716835574585;7908.84182316339;8008.079070906921;8012.959935200287;7450.813729656802;7580.128285247267;7670.424718146273;7694.07671079474;7737.651805668871;6917.481188910952;6997.8250543734775;7022.929770702228;7030.648467576499;7061.964690176516;4966.503349665005;4988.925166122439;5009.824656137018;5087.949120508748;5160.948390516047;5101.107306221471;5120.155174396332;5130.076586214517;5173.249878767482;5173.689578625294 08:35:29 INFO - PROCESS | 27591 | |4;prototype.html;326.7435063475171;329.8779451602907;334.04130146479605;335.3059167523228;335.37452650806244;5662.922695659129;5664.3856500897255;5666.235058267138;5677.57418193635;5719.656820590768;5610.523105536025;5637.295338082739;5646.830595082144;5670.901766346457;5689.899005042252;4153.916921661557;4254.191703576311;4331.285337919239;4337.696361254713;4381.189479946204;4335.306350983843;4344.500382456026;4359.215341238576;4366.781660916958;4369.6722745794195;4305.892352691192;4317.179735850194;4332.350147477872;4361.193179261831;4393.714408563449;4252.744835309876;4274.9098979759965;4309.030468144658;4366.8908277293;4382.846600369004;3796.0889386547306;3830.291396091732;3838.673712734421;3846.9807650961848;3850.903727406809;5494.917576236319;5507.623094226444;5513.669179849182;5519.503244707996;5527.474889885454;4800.423949126092;4957.206846904478;4982.128127577659;5000.149974504343;5013.373328333958;5869.589128760988;5902.61632993854;5905.6751878646655;5914;5927.666275088114;4195.181939521794;4216.114615930658;4225.408442818008;4233.216854881826;4257.3613957906255;5997.881101827069;6060.636361818261;6064.3935606439;6115;6153.692315384213;4248.34150706641;4266.978665106717;4286.678499112579;4299.4848013912215;4311.590398912098;4346.174226896879;4349.412829268008;4362.8036738346855;4364.62900653448;4367.388565600819;4675.976620116878;4920.261960705851;4926.69911159524;4971;5005.199168133081;5856.150858125633;5858.560607954335;5871.3541510433815;5883.117532370093;5943.673097979653;1464.282501574221;1470.3824393754649;1488.1368806092441;1489.8733607643255;1496.102338596833;928.7445952363154;949.0462085603924;955.498363359228;995.7908839143716;1002.5388321372104;5554.083841074823;5618.803341883015;5630.352509461382;5639.154126881001;5654.802081927113;5842.5618078644275;5926.962781513218;5933.881322373529;5963.850903727442;5981.551383646157;5415.6479828811;5578.972105139448;5580.302462192226;5651.576131790132;5671.858203544944;3179.205198700325;3184.920376990594;3213.6304325002457;3243.594550681165;3257.804531728104;5973.223480947449;6167.6916154193;6182.876342473125;6216.751329946842;6283.497320214372;6018.969905150534;6073.75704971805;6104.145419641254;6124.040307101684;6135.631862088289;6182.907256391158;6190.783322583688;6203.565750397519;6204.81385558434;6215.875682486416;5759.9136012959;5955.5235581154275;5983.713501597003;6013.398660133952;6021.765538064774;5946.6917278198725;5953.493953014043;5992.670403127696;6006.069059295816;6027.487663548647;5966;6147.938520614915;6160.260768707604;6221.47117495018;6277.15258440123;4202.537720850765;4208.452901122834;4211.873643790691;4228;4263.253930562078;6030.547708921936;6041.69791510414;6104.359042300494;6125.84685382869;6131.601445906002;5761.34977910166;5802.328461729006;5808.489792653856;5820.82537523875;5821.505172060422;5844.970775146097;5855.209546711139;5866.413358664099;5896;5927.170196172453;5557.638753481011;5814.476697097281;5818.912716309174;5821.7089145543405;5840.912386314294;5844.707764611668;5847.596576821617;5880.500157486662;5888.586739182651;5967.492763115184;5785.971070144622;5857.832601937311;5869.178315035983;5880.911786323123;5881.794137205177 08:35:29 INFO - PROCESS | 27591 | |5;yui.html;735.8712225360563;760.4980712729599;773.2229109744709;820.5568992743919;835.9498430094193;15378.461753838617;16235.91882040591;16264.512064638066;16352.345906163739;16396.91801540992;14336.211508367036;14529.854701452983;14530.709385812277;14537.127772333668;14537.273136343194;668.8194187569353;787.1656044592736;809.4859764049842;831.1273163178669;838.1450920061534;822.7284995951352;831.4553967151495;835.3359079531787;836.3643630840575;837.3845223760532;868.7306934850185;879.4371602174581;879.9340049496282;881.8897637795276;882.7307671160294;868.2793281576277;868.5874209750381;870.2298465857762;872.3936863879575;874.1346067393266;633.8383712153418;634.4480302137171;635.6821589205397;637.2448648351718;637.8022812927961;14513;14588.416463341453;14643.780343294859;14668.779968300483;14677.266136693122;15309.234538273042;15395.769063464057;15404.845951540565;15473.767893481607;15682.137482438462;12451.377431128407;12503.312317822516;12576.37118144089;12647;12817.615471535868;3891.610838916114;3932.2528719543197;3964.1080756829483;3972.7616343019513;4005.1589166275116;67468.32531674669;71660;72099.63950180268;77579.6121019397;78998.21001789966;10649.893501065046;10876.238663293652;10878.238523303293;10991.175661825235;11106.278091924;20033.799662003486;20082.598348032956;20088.196472141244;20098.296559620343;20112.09495572703;8035.517868927883;8049.476784009021;8050.235227653364;8212.055613604392;8270.710525131592;4318.460192475941;4429.889252768707;4454.7549884756645;4490.887727806831;4512.751798651106;3424.9657503424646;3441.0709108541055;3499.8950031499094;3516.191276006533;3518.7536872419196;642.1876326447049;642.6208536963121;651.0559688451764;654.6759354119741;688.8105770913039;646.2438946432685;678.5555461172939;679.7756740275697;722.8048426924806;798.5807451088225;9065.296817290451;9393.765155871159;9458.101480359355;9490.478023708623;9807.558659860324;628.1088655777415;745.4669911013651;783.3341659589304;786.7010535996285;803.2248879830875;4393.0994146199955;4415.646748260131;4524.47968483622;4601.348671162264;4728.101660684459;113668.43165784118;124435.17865802735;127079.3646031764;128579.35710321576;133047;108736;109296.45351773349;110961;111169;115684;76533;99357.50321248492;99754;102964.48517757363;106127.93872061335;8619.525926074126;8777.51723655205;8863.512506812187;8951.373403861668;9070.909290907006;56940.43059569351;57199;57243.71378143083;57299.71350143223;59253.703731481066;48408.5159148404;83061.09286174955;83701.16298836934;84804.57597711972;84959.97767122858;10825.07986821129;10956.233063685784;11295.943520282346;11324.660260192208;12367.257964521797;11902.226355286879;12128.696782580506;12189.14675972709;12440.502379905065;12708.364581771059;11485.712857178303;11578.94210528942;11789.351585662527;11831;12130.33283169434;11454.312741235553;11646.24299420535;11769.882301177222;11922.225055371373;12270.263784172977;11375.31748095117;11640.94179529097;11688.47401866901;11880.524779008743;12112.818307725214;9772.706818795448;9779.364341317792;9879.802403952024;10273.332233405104;10395.480225988518;8932.598033088396;9396.95301523488;10164.390136591828;10178;10329.380237185793 08:35:29 INFO - PROCESS | 27591 | __end_tp_report 08:35:29 INFO - PROCESS | 27591 | __start_cc_report 08:35:29 INFO - PROCESS | 27591 | _x_x_mozilla_cycle_collect,371 08:35:29 INFO - PROCESS | 27591 | __end_cc_report 08:35:29 INFO - PROCESS | 27591 | __startTimestamp1469115329494__endTimestamp 08:35:29 INFO - PROCESS | 27591 | 08:35:29 INFO - PROCESS | 27591 | ------- Summary: start ------- 08:35:29 INFO - PROCESS | 27591 | Number of tests: 6 08:35:29 INFO - PROCESS | 27591 | 08:35:29 INFO - PROCESS | 27591 | [#0] dojo.html Cycles:165 Average:5490.22 Median:5720.49 stddev:635.80 (11.1%) stddev-sans-first:608.23 08:35:29 INFO - PROCESS | 27591 | Values: 3049.3 3097.8 3100.1 3100.9 3110.5 5481.5 5500.1 5542.0 5586.4 5591.7 5393.2 5453.3 5503.2 5533.1 5554.0 4954.9 5005.7 5077.4 5093.4 5111.7 5067.6 5152.7 5159.2 5176.4 5210.7 4925.0 4978.0 4978.8 5089.3 5099.5 5013.5 5017.2 5019.5 5024.3 5051.2 4968.6 4978.7 4991.1 5003.0 5025.0 5376.2 5378.4 5466.1 5480.3 5518.4 5846.8 5860.3 5860.9 5863.3 5877.6 5884.3 5885.8 5891.1 5891.1 5899.4 5410.2 5476.0 5477.9 5516.3 5517.7 6115.4 6130.3 6135.3 6135.6 6139.1 5853.1 5854.1 5857.4 5858.4 5891.0 5693.1 5797.3 5806.2 5835.6 5949.4 5845.0 5847.4 5870.0 5880.8 5933.4 5860.3 5878.1 5878.8 5885.1 5893.6 4428.8 4460.1 4487.9 4519.3 4530.8 3973.6 4009.4 4012.1 4031.0 4033.8 5594.4 5628.1 5638.8 5643.3 5653.2 5778.0 5888.9 5931.8 5934.8 5947.3 5591.1 5640.3 5651.6 5674.2 5682.4 5075.4 5087.0 5149.5 5167.5 5202.6 5950.3 6000.2 6022.5 6125.5 6213.3 5946.8 5958.2 5964.6 5966.6 5976.6 6061.4 6069.6 6096.3 6123.4 6129.1 5662.2 5742.4 5752.1 5810.9 5838.4 5825.3 5875.1 5907.8 5939.6 5983.1 5839.2 5850.1 5864.1 5869.4 5905.8 5815.2 5829.0 5833.2 5840.9 5843.9 5587.9 5677.9 5704.6 5715.9 5720.5 5818.2 5826.4 5838.6 5869.2 5912.2 5697.8 5745.7 5771.4 5772.5 5776.2 08:35:29 INFO - PROCESS | 27591 | 08:35:29 INFO - PROCESS | 27591 | [#1] ext.html Cycles:180 Average:57991.07 Median:43131.39 stddev:112715.17 (261.3%) stddev-sans-first:112948.89 08:35:29 INFO - PROCESS | 27591 | Values: 562.3 588.2 593.3 610.0 611.3 43994.3 45638.1 45702.3 45818.0 48995.5 45226.5 45725.3 46235.0 46281.8 46478.8 8873.8 8973.9 8992.0 9028.8 9030.3 8865.4 8981.9 8984.1 8986.6 8992.5 9075.9 9119.4 9125.0 9126.1 9147.2 8972.3 8998.4 9007.8 9048.8 9062.1 8881.2 8891.3 8910.4 8921.9 8929.1 43257.8 43760.3 43805.8 44046.1 44052.6 3501.8 3550.5 3552.2 3638.4 3735.8 32927.7 33211.2 33230.2 33248.7 33351.3 4373.9 4421.7 4451.4 4452.9 4556.6 365232.0 365541.0 366365.0 367670.0 373066.1 34894.1 35952.5 35999.6 53229.5 60056.7 35576.0 35625.0 35827.8 35941.5 35959.3 13793.3 13889.2 13906.0 13907.0 13947.4 11367.6 11446.1 11467.3 11486.1 11487.6 8122.4 8243.2 8304.3 8305.4 8355.5 3206.7 3215.9 3229.1 3231.6 3285.6 1038.8 1038.9 1044.5 1060.4 1183.8 32033.0 32874.2 32945.5 33256.8 33783.5 1144.1 1149.7 1184.9 1234.0 1280.5 16159.9 17510.6 17547.7 17615.5 17840.8 435195.0 435792.0 436638.0 437292.0 440039.0 56901.1 57210.7 57362.1 57453.0 57508.0 1329.0 1350.1 1355.4 1357.9 1363.7 31666.5 34823.8 35127.5 35657.3 35778.8 53043.5 53228.0 53452.7 53474.5 53682.7 464756.0 465062.0 468472.0 468751.0 469148.0 28463.9 29520.9 29671.3 30076.2 30101.2 48686.0 49223.5 50376.2 50895.2 51340.7 41954.8 43005.0 43502.0 44134.0 44606.6 42915.6 43684.3 43746.8 44290.0 45064.8 41790.6 42203.6 42302.6 42495.0 42540.0 36274.0 38646.4 38810.3 38900.8 38946.2 29501.9 29587.3 29722.7 29942.7 30024.8 08:35:29 INFO - PROCESS | 27591 | 08:35:29 INFO - PROCESS | 27591 | [#2] jquery.html Cycles:180 Average:27651.23 Median:12214.62 stddev:71969.53 (589.2%) stddev-sans-first:72142.28 08:35:29 INFO - PROCESS | 27591 | Values: 374.7 389.3 392.9 397.7 407.6 18480.4 20984.3 21063.6 21297.8 21305.7 18936.9 18943.0 19471.7 19810.6 19935.4 5471.0 5702.1 5774.8 5779.5 5913.5 3761.9 4022.3 5833.7 5850.4 5858.5 6566.0 6585.4 6630.6 6635.3 6644.9 6598.3 6603.8 6620.2 6627.9 6667.1 5736.8 5857.7 5857.7 5874.9 5910.4 13466.5 15630.9 21059.8 21716.8 22143.8 2285.5 2375.8 2730.3 2858.7 2936.0 9768.4 10080.5 10480.9 11693.6 14550.9 1880.3 1888.8 1923.1 1955.4 2022.6 82810.0 83839.0 84796.0 85619.6 87907.0 10243.8 10358.2 10533.6 10731.5 11483.1 14379.9 14397.8 14411.9 14424.9 14522.1 7295.2 7637.0 7695.6 7868.3 7876.1 7288.0 7313.1 7326.4 7490.9 7571.8 4415.7 4465.7 4480.8 4493.3 4523.4 1856.3 1877.7 1881.4 1885.8 1940.5 974.2 1070.5 1104.6 1107.0 1107.1 19435.5 20237.5 20612.3 20934.2 21099.4 969.8 1012.4 1038.4 1041.3 1050.6 10739.3 11558.9 11590.2 11600.5 11669.2 415148.9 420003.0 423479.0 423801.0 480368.4 81578.6 81615.5 97524.0 99870.0 100999.0 1025.3 1035.1 1051.9 1064.4 1066.0 17728.9 18316.5 18594.3 18676.7 18725.8 43178.4 43334.6 43901.6 44879.8 44972.1 60889.0 60921.7 62146.7 62744.4 62799.0 8302.6 8480.4 8537.3 8538.8 8798.4 11873.9 13039.9 13195.1 13373.2 13997.3 11343.1 11552.5 11729.4 11784.2 11949.0 11225.7 11226.7 11527.8 11553.5 11572.9 5925.2 8341.9 11543.4 11576.2 12447.9 8225.8 8582.8 8598.2 8694.3 8822.1 10497.9 10926.5 11717.5 11775.1 11886.7 08:35:29 INFO - PROCESS | 27591 | 08:35:29 INFO - PROCESS | 27591 | [#3] mootools.html Cycles:180 Average:5803.47 Median:4341.92 stddev:3255.57 (75.0%) stddev-sans-first:3248.24 08:35:29 INFO - PROCESS | 27591 | Values: 1446.8 1487.5 1636.8 1786.7 1813.6 7479.0 8617.9 8678.2 9222.9 9249.3 8840.3 8841.4 8881.7 8888.1 8945.8 2343.1 2357.6 2364.0 2375.9 2382.3 2328.4 2339.5 2367.6 2381.6 2398.4 2347.6 2352.8 2363.5 2373.2 2387.0 2302.9 2309.4 2310.4 2311.7 2372.9 2272.8 2323.1 2323.6 2329.5 2340.1 8899.6 8923.5 8956.7 8976.1 8996.8 4948.4 5022.6 5137.2 5229.2 5262.1 3125.5 3279.7 3302.8 3340.9 3358.3 1101.6 1146.2 1156.7 1158.7 1160.7 11940.4 11994.3 12057.2 12066.4 12127.8 4376.2 4546.5 4606.1 4726.0 4729.5 9968.1 9978.1 9980.5 10012.3 10049.1 5119.3 5120.2 5146.7 5147.1 5150.5 4175.5 4742.2 4775.5 4887.1 4940.5 3980.0 4053.7 4072.3 4102.4 4191.1 1315.6 1332.9 1335.4 1344.3 1346.1 1029.2 1041.6 1047.7 1057.0 1065.1 6051.2 6237.6 6294.3 6448.3 6521.4 983.3 1019.8 1021.5 1022.0 1033.1 4084.0 4168.4 4189.9 4206.6 4307.6 10609.7 10836.1 10910.2 10914.7 10955.1 10302.8 10683.1 10824.0 10882.5 10896.2 7288.9 7671.2 7701.1 7707.5 7728.3 6372.6 6424.9 6487.7 6503.2 6517.3 10233.8 10306.1 10355.9 10365.8 10375.5 9930.2 10158.8 10189.9 10336.8 10344.3 7022.3 7376.7 7499.4 7604.5 7802.1 8689.5 8709.0 8760.3 8771.1 8795.6 7760.5 7787.6 7908.8 8008.1 8013.0 7450.8 7580.1 7670.4 7694.1 7737.7 6917.5 6997.8 7022.9 7030.6 7062.0 4966.5 4988.9 5009.8 5087.9 5160.9 5101.1 5120.2 5130.1 5173.2 5173.7 08:35:29 INFO - PROCESS | 27591 | 08:35:29 INFO - PROCESS | 27591 | [#4] prototype.html Cycles:180 Average:4936.99 Median:5665.31 stddev:1459.75 (25.8%) stddev-sans-first:1422.24 08:35:29 INFO - PROCESS | 27591 | Values: 326.7 329.9 334.0 335.3 335.4 5662.9 5664.4 5666.2 5677.6 5719.7 5610.5 5637.3 5646.8 5670.9 5689.9 4153.9 4254.2 4331.3 4337.7 4381.2 4335.3 4344.5 4359.2 4366.8 4369.7 4305.9 4317.2 4332.4 4361.2 4393.7 4252.7 4274.9 4309.0 4366.9 4382.8 3796.1 3830.3 3838.7 3847.0 3850.9 5494.9 5507.6 5513.7 5519.5 5527.5 4800.4 4957.2 4982.1 5000.1 5013.4 5869.6 5902.6 5905.7 5914.0 5927.7 4195.2 4216.1 4225.4 4233.2 4257.4 5997.9 6060.6 6064.4 6115.0 6153.7 4248.3 4267.0 4286.7 4299.5 4311.6 4346.2 4349.4 4362.8 4364.6 4367.4 4676.0 4920.3 4926.7 4971.0 5005.2 5856.2 5858.6 5871.4 5883.1 5943.7 1464.3 1470.4 1488.1 1489.9 1496.1 928.7 949.0 955.5 995.8 1002.5 5554.1 5618.8 5630.4 5639.2 5654.8 5842.6 5927.0 5933.9 5963.9 5981.6 5415.6 5579.0 5580.3 5651.6 5671.9 3179.2 3184.9 3213.6 3243.6 3257.8 5973.2 6167.7 6182.9 6216.8 6283.5 6019.0 6073.8 6104.1 6124.0 6135.6 6182.9 6190.8 6203.6 6204.8 6215.9 5759.9 5955.5 5983.7 6013.4 6021.8 5946.7 5953.5 5992.7 6006.1 6027.5 5966.0 6147.9 6160.3 6221.5 6277.2 4202.5 4208.5 4211.9 4228.0 4263.3 6030.5 6041.7 6104.4 6125.8 6131.6 5761.3 5802.3 5808.5 5820.8 5821.5 5845.0 5855.2 5866.4 5896.0 5927.2 5557.6 5814.5 5818.9 5821.7 5840.9 5844.7 5847.6 5880.5 5888.6 5967.5 5786.0 5857.8 5869.2 5880.9 5881.8 08:35:29 INFO - PROCESS | 27591 | 08:35:29 INFO - PROCESS | 27591 | [#5] yui.html Cycles:180 Average:21510.61 Median:4442.32 stddev:32859.45 (739.7%) stddev-sans-first:32914.61 08:35:29 INFO - PROCESS | 27591 | Values: 735.9 760.5 773.2 820.6 835.9 15378.5 16235.9 16264.5 16352.3 16396.9 14336.2 14529.9 14530.7 14537.1 14537.3 668.8 787.2 809.5 831.1 838.1 822.7 831.5 835.3 836.4 837.4 868.7 879.4 879.9 881.9 882.7 868.3 868.6 870.2 872.4 874.1 633.8 634.4 635.7 637.2 637.8 14513.0 14588.4 14643.8 14668.8 14677.3 15309.2 15395.8 15404.8 15473.8 15682.1 12451.4 12503.3 12576.4 12647.0 12817.6 3891.6 3932.3 3964.1 3972.8 4005.2 67468.3 71660.0 72099.6 77579.6 78998.2 10649.9 10876.2 10878.2 10991.2 11106.3 20033.8 20082.6 20088.2 20098.3 20112.1 8035.5 8049.5 8050.2 8212.1 8270.7 4318.5 4429.9 4454.8 4490.9 4512.8 3425.0 3441.1 3499.9 3516.2 3518.8 642.2 642.6 651.1 654.7 688.8 646.2 678.6 679.8 722.8 798.6 9065.3 9393.8 9458.1 9490.5 9807.6 628.1 745.5 783.3 786.7 803.2 4393.1 4415.6 4524.5 4601.3 4728.1 113668.4 124435.2 127079.4 128579.4 133047.0 108736.0 109296.5 110961.0 111169.0 115684.0 76533.0 99357.5 99754.0 102964.5 106127.9 8619.5 8777.5 8863.5 8951.4 9070.9 56940.4 57199.0 57243.7 57299.7 59253.7 48408.5 83061.1 83701.2 84804.6 84960.0 10825.1 10956.2 11295.9 11324.7 12367.3 11902.2 12128.7 12189.1 12440.5 12708.4 11485.7 11578.9 11789.4 11831.0 12130.3 11454.3 11646.2 11769.9 11922.2 12270.3 11375.3 11640.9 11688.5 11880.5 12112.8 9772.7 9779.4 9879.8 10273.3 10395.5 8932.6 9397.0 10164.4 10178.0 10329.4 08:35:29 INFO - PROCESS | 27591 | -------- Summary: end -------- 08:35:29 INFO - PROCESS | 27591 | 08:35:30 INFO - TEST-INFO | 27591: exit 0 08:35:30 INFO - TEST-OK | dromaeo_css | took 1111912ms 08:35:30 INFO - TEST-START | kraken 08:35:30 INFO - operating with platform_type : linux_ 08:35:30 INFO - Initialising browser for kraken test... 08:35:30 INFO - TEST-INFO | started process 27837 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUlaSJE/profile http://localhost:39772/getInfo.html) 08:35:34 INFO - PROCESS | 27837 | __metrics Screen width/height:1600/1200 08:35:34 INFO - PROCESS | 27837 | colorDepth:24 08:35:34 INFO - PROCESS | 27837 | Browser inner width/height: 1024/697 08:35:34 INFO - PROCESS | 27837 | __metrics 08:35:35 ERROR - PROCESS | 27837 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 08:35:36 INFO - TEST-INFO | 27837: exit 0 08:35:36 INFO - Browser initialized. 08:35:36 INFO - Running cycle 1/1 for kraken test... 08:35:36 INFO - TEST-INFO | started process 27959 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUlaSJE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:35:48 INFO - PROCESS | 27959 | RSS: Main: 167288832 08:35:48 INFO - PROCESS | 27959 | 08:35:50 INFO - PROCESS | 27959 | Cycle 1(1): loaded http://localhost:39772/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39772/tests/kraken/driver.html?testName=audio-beat-detection) 08:35:51 INFO - PROCESS | 27959 | RSS: Main: 172638208 08:35:51 INFO - PROCESS | 27959 | 08:35:54 INFO - PROCESS | 27959 | Cycle 1(1): loaded http://localhost:39772/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39772/tests/kraken/driver.html?testName=audio-dft) 08:35:55 INFO - PROCESS | 27959 | RSS: Main: 171638784 08:35:55 INFO - PROCESS | 27959 | 08:35:57 INFO - PROCESS | 27959 | Cycle 1(1): loaded http://localhost:39772/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39772/tests/kraken/driver.html?testName=audio-fft) 08:35:58 INFO - PROCESS | 27959 | RSS: Main: 168443904 08:35:58 INFO - PROCESS | 27959 | 08:36:00 INFO - PROCESS | 27959 | Cycle 1(1): loaded http://localhost:39772/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39772/tests/kraken/driver.html?testName=audio-oscillator) 08:36:01 INFO - PROCESS | 27959 | RSS: Main: 169205760 08:36:01 INFO - PROCESS | 27959 | 08:36:03 INFO - PROCESS | 27959 | Cycle 1(1): loaded http://localhost:39772/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39772/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:36:04 INFO - PROCESS | 27959 | RSS: Main: 169615360 08:36:04 INFO - PROCESS | 27959 | 08:36:07 INFO - PROCESS | 27959 | Cycle 1(1): loaded http://localhost:39772/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39772/tests/kraken/driver.html?testName=imaging-darkroom) 08:36:08 INFO - PROCESS | 27959 | RSS: Main: 170020864 08:36:08 INFO - PROCESS | 27959 | 08:36:11 INFO - PROCESS | 27959 | Cycle 1(1): loaded http://localhost:39772/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39772/tests/kraken/driver.html?testName=imaging-desaturate) 08:36:12 INFO - PROCESS | 27959 | RSS: Main: 166764544 08:36:12 INFO - PROCESS | 27959 | 08:36:14 INFO - PROCESS | 27959 | Cycle 1(1): loaded http://localhost:39772/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39772/tests/kraken/driver.html?testName=json-parse-financial) 08:36:15 INFO - PROCESS | 27959 | RSS: Main: 168681472 08:36:15 INFO - PROCESS | 27959 | 08:36:17 INFO - PROCESS | 27959 | Cycle 1(1): loaded http://localhost:39772/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39772/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:36:17 INFO - PROCESS | 27959 | RSS: Main: 168910848 08:36:17 INFO - PROCESS | 27959 | 08:36:19 INFO - PROCESS | 27959 | Cycle 1(1): loaded http://localhost:39772/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39772/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:36:20 INFO - PROCESS | 27959 | RSS: Main: 169345024 08:36:20 INFO - PROCESS | 27959 | 08:36:22 INFO - PROCESS | 27959 | Cycle 1(1): loaded http://localhost:39772/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39772/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:36:22 INFO - PROCESS | 27959 | RSS: Main: 168845312 08:36:22 INFO - PROCESS | 27959 | 08:36:25 INFO - PROCESS | 27959 | Cycle 1(1): loaded http://localhost:39772/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39772/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:36:26 INFO - PROCESS | 27959 | RSS: Main: 169627648 08:36:26 INFO - PROCESS | 27959 | 08:36:28 INFO - PROCESS | 27959 | Cycle 1(1): loaded http://localhost:39772/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39772/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:36:29 INFO - PROCESS | 27959 | RSS: Main: 169504768 08:36:29 INFO - PROCESS | 27959 | 08:36:31 INFO - PROCESS | 27959 | Cycle 1(1): loaded http://localhost:39772/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39772/tests/kraken/driver.html?testName=ai-astar) 08:36:31 INFO - PROCESS | 27959 | RSS: Main: 170237952 08:36:31 INFO - PROCESS | 27959 | 08:36:31 INFO - PROCESS | 27959 | __start_tp_report 08:36:31 INFO - PROCESS | 27959 | _x_x_mozilla_page_load 08:36:31 INFO - PROCESS | 27959 | _x_x_mozilla_page_load_details 08:36:31 INFO - PROCESS | 27959 | |i|pagename|runs| 08:36:31 INFO - PROCESS | 27959 | |0;ai-astar;102;113;106;111;119;113;114;112;113;111 08:36:31 INFO - PROCESS | 27959 | |1;audio-beat-detection;145;118;154;179;117;144;165;120;178;121 08:36:31 INFO - PROCESS | 27959 | |2;audio-dft;163;160;161;164;162;169;165;160;161;163 08:36:31 INFO - PROCESS | 27959 | |3;audio-fft;76;75;76;169;76;77;75;83;182;80 08:36:31 INFO - PROCESS | 27959 | |4;audio-oscillator;84;83;158;85;84;85;144;84;84;144 08:36:31 INFO - PROCESS | 27959 | |5;imaging-gaussian-blur;123;117;118;117;118;118;118;117;117;118 08:36:31 INFO - PROCESS | 27959 | |6;imaging-darkroom;147;147;148;147;147;148;148;147;146;147 08:36:31 INFO - PROCESS | 27959 | |7;imaging-desaturate;96;96;96;95;97;96;96;96;96;95 08:36:31 INFO - PROCESS | 27959 | |8;json-parse-financial;54;53;55;52;54;51;52;52;51;53 08:36:31 INFO - PROCESS | 27959 | |9;json-stringify-tinderbox;63;63;64;64;63;63;63;63;66;63 08:36:31 INFO - PROCESS | 27959 | |10;stanford-crypto-aes;82;76;77;76;77;83;77;77;86;76 08:36:31 INFO - PROCESS | 27959 | |11;stanford-crypto-ccm;136;121;123;125;137;126;123;126;169;132 08:36:31 INFO - PROCESS | 27959 | |12;stanford-crypto-pbkdf2;157;157;160;154;160;157;162;158;159;155 08:36:31 INFO - PROCESS | 27959 | |13;stanford-crypto-sha256-iterative;65;72;65;63;64;65;68;65;64;66 08:36:31 INFO - PROCESS | 27959 | __end_tp_report 08:36:31 INFO - PROCESS | 27959 | __start_cc_report 08:36:31 INFO - PROCESS | 27959 | _x_x_mozilla_cycle_collect,934 08:36:31 INFO - PROCESS | 27959 | __end_cc_report 08:36:31 INFO - PROCESS | 27959 | __startTimestamp1469115391399__endTimestamp 08:36:31 INFO - PROCESS | 27959 | 08:36:31 INFO - PROCESS | 27959 | ------- Summary: start ------- 08:36:31 INFO - PROCESS | 27959 | Number of tests: 14 08:36:31 INFO - PROCESS | 27959 | 08:36:31 INFO - PROCESS | 27959 | [#0] ai-astar Cycles:10 Average:111.40 Median:113.00 stddev:4.60 (4.1%) stddev-sans-first:3.40 08:36:31 INFO - PROCESS | 27959 | Values: 102.0 113.0 106.0 111.0 119.0 113.0 114.0 112.0 113.0 111.0 08:36:31 INFO - PROCESS | 27959 | 08:36:31 INFO - PROCESS | 27959 | [#1] audio-beat-detection Cycles:10 Average:144.10 Median:149.50 stddev:24.57 (16.4%) stddev-sans-first:26.06 08:36:31 INFO - PROCESS | 27959 | Values: 145.0 118.0 154.0 179.0 117.0 144.0 165.0 120.0 178.0 121.0 08:36:31 INFO - PROCESS | 27959 | 08:36:31 INFO - PROCESS | 27959 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:2.74 (1.7%) stddev-sans-first:2.91 08:36:31 INFO - PROCESS | 27959 | Values: 163.0 160.0 161.0 164.0 162.0 169.0 165.0 160.0 161.0 163.0 08:36:31 INFO - PROCESS | 27959 | 08:36:31 INFO - PROCESS | 27959 | [#3] audio-fft Cycles:10 Average:96.90 Median:76.00 stddev:41.61 (54.8%) stddev-sans-first:43.44 08:36:31 INFO - PROCESS | 27959 | Values: 76.0 75.0 76.0 169.0 76.0 77.0 75.0 83.0 182.0 80.0 08:36:31 INFO - PROCESS | 27959 | 08:36:31 INFO - PROCESS | 27959 | [#4] audio-oscillator Cycles:10 Average:103.50 Median:84.00 stddev:31.41 (37.4%) stddev-sans-first:32.51 08:36:31 INFO - PROCESS | 27959 | Values: 84.0 83.0 158.0 85.0 84.0 85.0 144.0 84.0 84.0 144.0 08:36:31 INFO - PROCESS | 27959 | 08:36:31 INFO - PROCESS | 27959 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:1.79 (1.5%) stddev-sans-first:0.53 08:36:31 INFO - PROCESS | 27959 | Values: 123.0 117.0 118.0 117.0 118.0 118.0 118.0 117.0 117.0 118.0 08:36:31 INFO - PROCESS | 27959 | 08:36:31 INFO - PROCESS | 27959 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 08:36:31 INFO - PROCESS | 27959 | Values: 147.0 147.0 148.0 147.0 147.0 148.0 148.0 147.0 146.0 147.0 08:36:31 INFO - PROCESS | 27959 | 08:36:31 INFO - PROCESS | 27959 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 08:36:31 INFO - PROCESS | 27959 | Values: 96.0 96.0 96.0 95.0 97.0 96.0 96.0 96.0 96.0 95.0 08:36:31 INFO - PROCESS | 27959 | 08:36:31 INFO - PROCESS | 27959 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:53.00 stddev:1.34 (2.5%) stddev-sans-first:1.33 08:36:31 INFO - PROCESS | 27959 | Values: 54.0 53.0 55.0 52.0 54.0 51.0 52.0 52.0 51.0 53.0 08:36:31 INFO - PROCESS | 27959 | 08:36:31 INFO - PROCESS | 27959 | [#9] json-stringify-tinderbox Cycles:10 Average:63.50 Median:63.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 08:36:31 INFO - PROCESS | 27959 | Values: 63.0 63.0 64.0 64.0 63.0 63.0 63.0 63.0 66.0 63.0 08:36:31 INFO - PROCESS | 27959 | 08:36:31 INFO - PROCESS | 27959 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:77.00 stddev:3.59 (4.7%) stddev-sans-first:3.61 08:36:31 INFO - PROCESS | 27959 | Values: 82.0 76.0 77.0 76.0 77.0 83.0 77.0 77.0 86.0 76.0 08:36:31 INFO - PROCESS | 27959 | 08:36:31 INFO - PROCESS | 27959 | [#11] stanford-crypto-ccm Cycles:10 Average:131.80 Median:129.00 stddev:14.20 (11.0%) stddev-sans-first:14.97 08:36:31 INFO - PROCESS | 27959 | Values: 136.0 121.0 123.0 125.0 137.0 126.0 123.0 126.0 169.0 132.0 08:36:31 INFO - PROCESS | 27959 | 08:36:31 INFO - PROCESS | 27959 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.90 Median:158.50 stddev:2.42 (1.5%) stddev-sans-first:2.55 08:36:31 INFO - PROCESS | 27959 | Values: 157.0 157.0 160.0 154.0 160.0 157.0 162.0 158.0 159.0 155.0 08:36:31 INFO - PROCESS | 27959 | 08:36:31 INFO - PROCESS | 27959 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:65.00 stddev:2.58 (4.0%) stddev-sans-first:2.73 08:36:31 INFO - PROCESS | 27959 | Values: 65.0 72.0 65.0 63.0 64.0 65.0 68.0 65.0 64.0 66.0 08:36:31 INFO - PROCESS | 27959 | -------- Summary: end -------- 08:36:31 INFO - PROCESS | 27959 | 08:36:32 INFO - TEST-INFO | 27959: exit 0 08:36:32 INFO - TEST-OK | kraken | took 62156ms 08:36:32 INFO - SUITE-END | took 1174s 08:36:32 INFO - Completed test suite (00:19:34) 08:36:32 INFO - javascript benchmark 08:36:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7284.772207466839, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3049.3291475875308, 3097.7831551791355, 3100.1009707184917, 3100.9379812403754, 3110.486769683001, 5481.534069604083, 5500.092484740013, 5541.9722901385485, 5586.441355864412, 5591.7483713232905, 5393.2449457075945, 5453.318335208099, 5503.229547863302, 5533.0870406383, 5554.0, 4954.876128096799, 5005.724685142316, 5077.41609714882, 5093.439721630618, 5111.744412779365, 5067.6452648314635, 5152.665076770017, 5159.22611608258, 5176.430592634807, 5210.6613070150315, 4925.0, 4977.950220497785, 4978.77595508203, 5089.287499750019, 5099.464556221599, 5013.548780609763, 5017.172166592508, 5019.498050194988, 5024.346834911475, 5051.217061355459, 4968.577670897978, 4978.726170060645, 4991.051700176955, 5003.049420610072, 5025.0, 5376.247325374451, 5378.408375078739, 5466.125419932791, 5480.287562616834, 5518.448155184449, 5846.824595262106, 5860.267466566679, 5860.915730589854, 5863.2670916135485, 5877.647341159502, 5884.323302820188, 5885.764569417218, 5891.116332550109, 5891.145783861359, 5899.439553242478, 5410.242566040718, 5476.0, 5477.863053423656, 5516.338039435253, 5517.724113794295, 6115.449898208542, 6130.3369889931655, 6135.263289243823, 6135.6189562855025, 6139.101670439303, 5853.063509838491, 5854.121881717776, 5857.355690874, 5858.384869588717, 5890.998530249782, 5693.146028095736, 5797.333306669787, 5806.21616081832, 5835.56233282497, 5949.405059494016, 5845.0, 5847.356790753014, 5870.002099643071, 5880.764769409261, 5933.406659334032, 5860.326062502867, 5878.147668588031, 5878.794242201588, 5885.117232415087, 5893.587448878623, 4428.778561071934, 4460.063386688832, 4487.932681009787, 4519.344695019204, 4530.77346132692, 3973.602639736061, 4009.4186342980106, 4012.117334186474, 4030.9596904031173, 4033.798310084484, 5594.356648985418, 5628.127640215773, 5638.802641907513, 5643.322801263875, 5653.23681303027, 5778.046622307356, 5888.941110588925, 5931.82204533856, 5934.762609495572, 5947.256592925884, 5591.07747221712, 5640.266765320482, 5651.57613179005, 5674.177244299553, 5682.40334764852, 5075.365579302587, 5087.0, 5149.459306772735, 5167.457416971239, 5202.557782588447, 5950.256217972754, 6000.249968753906, 6022.45797878193, 6125.479334256638, 6213.285472170668, 5946.762129514771, 5958.225430693982, 5964.642121472725, 5966.552508561788, 5976.581639285208, 6061.36355682647, 6069.635821850703, 6096.329403765493, 6123.357047509948, 6129.141920131096, 5662.207290979349, 5742.397048309867, 5752.108423194411, 5810.883782324415, 5838.357780644041, 5825.330087040044, 5875.089361149029, 5907.793227237026, 5939.584229103922, 5983.1025346196675, 5839.182514448065, 5850.12248162779, 5864.091065884794, 5869.413058694096, 5905.763769449346, 5815.156802263733, 5828.970855145697, 5833.154192641959, 5840.912386314294, 5843.912341314799, 5587.860303492445, 5677.914831277617, 5704.600677952503, 5715.885682286248, 5720.485156335783, 5818.156367326629, 5826.388229236039, 5838.649681019152, 5869.207656966255, 5912.231409916683, 5697.829065128053, 5745.6552606843725, 5771.422857714195, 5772.509336706427, 5776.220210271559], "value": 5445.520856809205, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.2710166238815, 588.2323567744097, 593.3206478582024, 610.0361428942272, 611.2878496551517, 43994.340084898715, 45638.087238255255, 45702.31446528301, 45818.0, 48995.51004489954, 45226.547734522646, 45725.314120288225, 46235.0, 46281.76859115708, 46478.76760616192, 8873.778155546115, 8973.865392019092, 8992.0, 9028.77428064297, 9030.322725795559, 8865.423747456427, 8981.865272020892, 8984.056674049229, 8986.550672466383, 8992.460452372847, 9075.909240907606, 9119.361644684876, 9125.0, 9126.087391260888, 9147.17675409213, 8972.327075469333, 8998.37011409205, 9007.819843603123, 9048.77378065547, 9062.093790620886, 8881.200691937693, 8891.288696904232, 8910.376273660846, 8921.866172007425, 8929.107089291085, 43257.78371108156, 43760.343594846105, 43805.78097109526, 44046.11907761827, 44052.55947440548, 3501.7898926064518, 3550.538430004083, 3552.236269202134, 3638.381475149231, 3735.7758534488016, 32927.67072329294, 33211.16972075718, 33230.169245768804, 33248.6675133248, 33351.33297334064, 4373.868783936487, 4421.668374871898, 4451.376807246988, 4452.866414007585, 4556.589906908361, 365232.0, 365541.0, 366365.0, 367670.0, 373066.13466932764, 34894.12764680904, 35952.46071308933, 35999.64000359963, 53229.46770532245, 60056.699716501134, 35576.0, 35625.0, 35827.82086089553, 35941.46087808685, 35959.280814383565, 13793.310334483236, 13889.166650001032, 13906.0, 13907.0, 13947.372368243454, 11367.602133925273, 11446.14153938458, 11467.254628449124, 11486.0811135109, 11487.597934072268, 8122.390820688472, 8243.175682431709, 8304.335653147733, 8305.37709671777, 8355.456895301786, 3206.679332066821, 3215.935681286408, 3229.0958531611186, 3231.6122065352306, 3285.572875526166, 1038.7922415516928, 1038.9168866490663, 1044.4568824211367, 1060.4326685223368, 1183.7514122034297, 32033.0, 32874.17814554655, 32945.505817412755, 33256.83371583175, 33783.493247601305, 1144.0904480937675, 1149.6608500492375, 1184.8696643369221, 1233.9511415296927, 1280.481405030964, 16159.919200403923, 17510.600899711182, 17547.73678394825, 17615.471535853943, 17840.821591784177, 435195.0, 435792.0, 436638.0, 437292.0, 440039.0, 56901.14648280279, 57210.71394643, 57362.13956790652, 57453.0, 57508.0, 1328.966775830612, 1350.1021820489461, 1355.4307190979812, 1357.8981576381614, 1363.6863521390135, 31666.525002125447, 34823.825880870434, 35127.47308790319, 35657.28685426225, 35778.821105894305, 53043.46956530385, 53228.0, 53452.73273633607, 53474.46525534851, 53682.73158634182, 464756.0, 465062.0, 468472.0, 468751.0, 469148.0, 28463.857680711462, 29520.852395737882, 29671.25821854471, 30076.24809379783, 30101.24746881258, 48686.0, 49223.507764921895, 50376.24435633542, 50895.23657145072, 51340.743296284774, 41954.79022604867, 43005.0, 43502.0, 44134.0, 44606.55393446024, 42915.57084429241, 43684.344734828366, 43746.781266093465, 44290.0, 45064.77467612772, 41790.582094178666, 42203.57796422119, 42302.576974229865, 42495.0, 42540.0, 36274.0, 38646.42030369603, 38810.27462877152, 38900.80549597234, 38946.22107557776, 29501.85249073741, 29587.260318492208, 29722.702772972858, 29942.70057299486, 30024.849875750482], "value": 19073.30756672436, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.7133442916168, 389.33618181001384, 392.90963078491944, 397.6600006994022, 407.6168401702399, 18480.445586632406, 20984.265550705728, 21063.578728425422, 21297.787022129774, 21305.680414793773, 18936.90531547344, 18943.0, 19471.707924381146, 19810.603787924232, 19935.401937941886, 5471.0, 5702.116171993348, 5774.769009239625, 5779.537636989052, 5913.467787899088, 3761.9247615047684, 4022.3162062449305, 5833.708314584275, 5850.444207800252, 5858.502027327682, 6566.0, 6585.374389432996, 6630.63531505767, 6635.3032931541975, 6644.933550664504, 6598.340165983387, 6603.801885943405, 6620.172478440195, 6627.867442651168, 6667.066610674485, 5736.82789516311, 5857.6778277194735, 5857.70711464425, 5874.9412505874825, 5910.438508341701, 13466.461341546326, 15630.9218453907, 21059.78940210609, 21716.782832171633, 22143.778562214495, 2285.4514916420108, 2375.798057165143, 2730.30377253801, 2858.6998365171567, 2936.0457851198234, 9768.36505627139, 10080.54637541305, 10480.94759526205, 11693.649190524298, 14550.927245363811, 1880.2948894164688, 1888.7544619199552, 1923.086533896402, 1955.4426988308264, 2022.6055919095782, 82810.0, 83839.0, 84796.0, 85619.57190214009, 87907.0, 10243.795124097625, 10358.223133265035, 10533.631322903662, 10731.517081731341, 11483.081353491702, 14379.85620143806, 14397.78403323951, 14411.92794036023, 14424.90838828364, 14522.128672279698, 7295.197528271886, 7637.0, 7695.6152192390155, 7868.25251601097, 7876.054873415227, 7288.0, 7313.085864266966, 7326.377257933029, 7490.925090749023, 7571.848563028819, 4415.66882483815, 4465.687401881902, 4480.843170489017, 4493.303537951622, 4523.411956445641, 1856.2853301479029, 1877.7371168036486, 1881.3791448821855, 1885.8397036251797, 1940.5439721665398, 974.1670871404989, 1070.4808168038496, 1104.5636973395624, 1106.9594581093745, 1107.06453047175, 19435.51411214731, 20237.49406264855, 20612.27857025027, 20934.162633494794, 21099.367018989455, 969.8351280282369, 1012.372329155928, 1038.361407734238, 1041.2971244410144, 1050.632278702448, 10739.301945373525, 11558.884411155781, 11590.246633968765, 11600.535978560763, 11669.183157179086, 415148.89447663154, 420003.0, 423479.0, 423801.0, 480368.3742138017, 81578.59210703909, 81615.46109992442, 97524.0, 99870.0, 100999.0, 1025.266934142092, 1035.089121573026, 1051.8737751469873, 1064.3613831701073, 1065.984010239847, 17728.91135544314, 18316.542086447946, 18594.349197778552, 18676.719849202545, 18725.812741872953, 43178.35232471453, 43334.56665433305, 43901.56098438975, 44879.775601121786, 44972.100557988, 60889.0, 60921.69539152276, 62146.68926655338, 62744.37255627568, 62799.0, 8302.584870756558, 8480.406371553932, 8537.274331681876, 8538.786530336543, 8798.428102173595, 11873.881261187278, 13039.934800325938, 13195.076344655781, 13373.197608143542, 13997.300134993413, 11343.092552595608, 11552.537898483966, 11729.35488548104, 11784.175107742376, 11949.0, 11225.66323010311, 11226.719332016764, 11527.827082593936, 11553.537858485566, 11572.94213528927, 5925.229720136527, 8341.874871876806, 11543.36511491876, 11576.24754390962, 12447.875521245034, 8225.753227403187, 8582.828343432971, 8598.183172598594, 8694.260987815853, 8822.117788221127, 10497.895021049691, 10926.453677315943, 11717.531298747954, 11775.116866234895, 11886.702832428913], "value": 9258.696253407748, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1446.768517037274, 1487.4868170481184, 1636.8363163683632, 1786.7319902014688, 1813.5556788586807, 7479.0, 8617.913820861797, 8678.175573320541, 9222.86165707514, 9249.30630202735, 8840.292776577875, 8841.425307355017, 8881.73354799357, 8888.111188881108, 8945.776355591113, 2343.144752165456, 2357.610994185957, 2363.976360236393, 2375.8930848111877, 2382.2614989353356, 2328.3946173994714, 2339.497008143249, 2367.6093444581625, 2381.6189409694452, 2398.448356877919, 2347.5539647466926, 2352.764723527642, 2363.5391098735754, 2373.1575290771784, 2386.9880650596724, 2302.942426439344, 2309.4341886237894, 2310.376198426424, 2311.711036120485, 2372.8576285422755, 2272.8068114210314, 2323.0939933425975, 2323.628219484874, 2329.49915768109, 2340.075670110297, 8899.644014239422, 8923.464592124494, 8956.686515971975, 8976.147266009719, 8996.820063598756, 4948.4309304429735, 5022.648414610979, 5137.229415587654, 5229.163333866563, 5262.05283049051, 3125.48429509133, 3279.7048265656204, 3302.768806183568, 3340.9498857517156, 3358.277970236411, 1101.608928830259, 1146.249206769559, 1156.653004098767, 1158.723109090641, 1160.7446361800392, 11940.40297985106, 11994.340311282876, 12057.216280941711, 12066.396680166044, 12127.818082728767, 4376.234159022159, 4546.4544254689645, 4606.101810147056, 4726.007538416971, 4729.503402142795, 9968.053034961667, 9978.101970822661, 9980.45107519079, 10012.299139060342, 10049.14582260516, 5119.3088932994315, 5120.231965205249, 5146.665466744725, 5147.0735267651435, 5150.510701483428, 4175.54069052404, 4742.217534106902, 4775.474697783241, 4887.0714564232685, 4940.530649588283, 3979.980100099539, 4053.6757059435176, 4072.2669919414197, 4102.379560073754, 4191.098913733501, 1315.5592876386518, 1332.8933685305153, 1335.4057444437133, 1344.3479912242556, 1346.1451977994045, 1029.1715169288645, 1041.6354276003337, 1047.711879233217, 1057.0011339284304, 1065.0574241795912, 6051.152838602599, 6237.594556353823, 6294.339094395114, 6448.258450278185, 6521.380468855451, 983.3362480325751, 1019.7654539455818, 1021.5300961557618, 1022.0, 1033.1424917318607, 4083.97958010214, 4168.437260969791, 4189.874303770892, 4206.621404073587, 4307.612314891675, 10609.73475663099, 10836.078933290759, 10910.23628346024, 10914.672559823219, 10955.123590112771, 10302.793944121076, 10683.145348372267, 10824.0, 10882.510287037103, 10896.237263391646, 7288.854222915512, 7671.232876712395, 7701.114371847198, 7707.499012564165, 7728.343090837229, 6372.58578192416, 6424.935750642434, 6487.708053137714, 6503.154589903283, 6517.315681853527, 10233.795324093626, 10306.072453478922, 10355.948220259152, 10365.844512332473, 10375.533101010322, 9930.155936745457, 10158.847617285894, 10189.898101019191, 10336.793264134825, 10344.32761870476, 7022.262662420577, 7376.7418140364825, 7499.362554182955, 7604.5437273763755, 7802.102758182881, 8689.522076285864, 8708.956455217683, 8760.255378292917, 8771.079036701054, 8795.604197810986, 7760.495567788075, 7787.5716835574585, 7908.84182316339, 8008.079070906921, 8012.959935200287, 7450.813729656802, 7580.128285247267, 7670.424718146273, 7694.07671079474, 7737.651805668871, 6917.481188910952, 6997.8250543734775, 7022.929770702228, 7030.648467576499, 7061.964690176516, 4966.503349665005, 4988.925166122439, 5009.824656137018, 5087.949120508748, 5160.948390516047, 5101.107306221471, 5120.155174396332, 5130.076586214517, 5173.249878767482, 5173.689578625294], "value": 4681.135605935349, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.7435063475171, 329.8779451602907, 334.04130146479605, 335.3059167523228, 335.37452650806244, 5662.922695659129, 5664.3856500897255, 5666.235058267138, 5677.57418193635, 5719.656820590768, 5610.523105536025, 5637.295338082739, 5646.830595082144, 5670.901766346457, 5689.899005042252, 4153.916921661557, 4254.191703576311, 4331.285337919239, 4337.696361254713, 4381.189479946204, 4335.306350983843, 4344.500382456026, 4359.215341238576, 4366.781660916958, 4369.6722745794195, 4305.892352691192, 4317.179735850194, 4332.350147477872, 4361.193179261831, 4393.714408563449, 4252.744835309876, 4274.9098979759965, 4309.030468144658, 4366.8908277293, 4382.846600369004, 3796.0889386547306, 3830.291396091732, 3838.673712734421, 3846.9807650961848, 3850.903727406809, 5494.917576236319, 5507.623094226444, 5513.669179849182, 5519.503244707996, 5527.474889885454, 4800.423949126092, 4957.206846904478, 4982.128127577659, 5000.149974504343, 5013.373328333958, 5869.589128760988, 5902.61632993854, 5905.6751878646655, 5914.0, 5927.666275088114, 4195.181939521794, 4216.114615930658, 4225.408442818008, 4233.216854881826, 4257.3613957906255, 5997.881101827069, 6060.636361818261, 6064.3935606439, 6115.0, 6153.692315384213, 4248.34150706641, 4266.978665106717, 4286.678499112579, 4299.4848013912215, 4311.590398912098, 4346.174226896879, 4349.412829268008, 4362.8036738346855, 4364.62900653448, 4367.388565600819, 4675.976620116878, 4920.261960705851, 4926.69911159524, 4971.0, 5005.199168133081, 5856.150858125633, 5858.560607954335, 5871.3541510433815, 5883.117532370093, 5943.673097979653, 1464.282501574221, 1470.3824393754649, 1488.1368806092441, 1489.8733607643255, 1496.102338596833, 928.7445952363154, 949.0462085603924, 955.498363359228, 995.7908839143716, 1002.5388321372104, 5554.083841074823, 5618.803341883015, 5630.352509461382, 5639.154126881001, 5654.802081927113, 5842.5618078644275, 5926.962781513218, 5933.881322373529, 5963.850903727442, 5981.551383646157, 5415.6479828811, 5578.972105139448, 5580.302462192226, 5651.576131790132, 5671.858203544944, 3179.205198700325, 3184.920376990594, 3213.6304325002457, 3243.594550681165, 3257.804531728104, 5973.223480947449, 6167.6916154193, 6182.876342473125, 6216.751329946842, 6283.497320214372, 6018.969905150534, 6073.75704971805, 6104.145419641254, 6124.040307101684, 6135.631862088289, 6182.907256391158, 6190.783322583688, 6203.565750397519, 6204.81385558434, 6215.875682486416, 5759.9136012959, 5955.5235581154275, 5983.713501597003, 6013.398660133952, 6021.765538064774, 5946.6917278198725, 5953.493953014043, 5992.670403127696, 6006.069059295816, 6027.487663548647, 5966.0, 6147.938520614915, 6160.260768707604, 6221.47117495018, 6277.15258440123, 4202.537720850765, 4208.452901122834, 4211.873643790691, 4228.0, 4263.253930562078, 6030.547708921936, 6041.69791510414, 6104.359042300494, 6125.84685382869, 6131.601445906002, 5761.34977910166, 5802.328461729006, 5808.489792653856, 5820.82537523875, 5821.505172060422, 5844.970775146097, 5855.209546711139, 5866.413358664099, 5896.0, 5927.170196172453, 5557.638753481011, 5814.476697097281, 5818.912716309174, 5821.7089145543405, 5840.912386314294, 5844.707764611668, 5847.596576821617, 5880.500157486662, 5888.586739182651, 5967.492763115184, 5785.971070144622, 5857.832601937311, 5869.178315035983, 5880.911786323123, 5881.794137205177], "value": 4462.917687276597, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.8712225360563, 760.4980712729599, 773.2229109744709, 820.5568992743919, 835.9498430094193, 15378.461753838617, 16235.91882040591, 16264.512064638066, 16352.345906163739, 16396.91801540992, 14336.211508367036, 14529.854701452983, 14530.709385812277, 14537.127772333668, 14537.273136343194, 668.8194187569353, 787.1656044592736, 809.4859764049842, 831.1273163178669, 838.1450920061534, 822.7284995951352, 831.4553967151495, 835.3359079531787, 836.3643630840575, 837.3845223760532, 868.7306934850185, 879.4371602174581, 879.9340049496282, 881.8897637795276, 882.7307671160294, 868.2793281576277, 868.5874209750381, 870.2298465857762, 872.3936863879575, 874.1346067393266, 633.8383712153418, 634.4480302137171, 635.6821589205397, 637.2448648351718, 637.8022812927961, 14513.0, 14588.416463341453, 14643.780343294859, 14668.779968300483, 14677.266136693122, 15309.234538273042, 15395.769063464057, 15404.845951540565, 15473.767893481607, 15682.137482438462, 12451.377431128407, 12503.312317822516, 12576.37118144089, 12647.0, 12817.615471535868, 3891.610838916114, 3932.2528719543197, 3964.1080756829483, 3972.7616343019513, 4005.1589166275116, 67468.32531674669, 71660.0, 72099.63950180268, 77579.6121019397, 78998.21001789966, 10649.893501065046, 10876.238663293652, 10878.238523303293, 10991.175661825235, 11106.278091924, 20033.799662003486, 20082.598348032956, 20088.196472141244, 20098.296559620343, 20112.09495572703, 8035.517868927883, 8049.476784009021, 8050.235227653364, 8212.055613604392, 8270.710525131592, 4318.460192475941, 4429.889252768707, 4454.7549884756645, 4490.887727806831, 4512.751798651106, 3424.9657503424646, 3441.0709108541055, 3499.8950031499094, 3516.191276006533, 3518.7536872419196, 642.1876326447049, 642.6208536963121, 651.0559688451764, 654.6759354119741, 688.8105770913039, 646.2438946432685, 678.5555461172939, 679.7756740275697, 722.8048426924806, 798.5807451088225, 9065.296817290451, 9393.765155871159, 9458.101480359355, 9490.478023708623, 9807.558659860324, 628.1088655777415, 745.4669911013651, 783.3341659589304, 786.7010535996285, 803.2248879830875, 4393.0994146199955, 4415.646748260131, 4524.47968483622, 4601.348671162264, 4728.101660684459, 113668.43165784118, 124435.17865802735, 127079.3646031764, 128579.35710321576, 133047.0, 108736.0, 109296.45351773349, 110961.0, 111169.0, 115684.0, 76533.0, 99357.50321248492, 99754.0, 102964.48517757363, 106127.93872061335, 8619.525926074126, 8777.51723655205, 8863.512506812187, 8951.373403861668, 9070.909290907006, 56940.43059569351, 57199.0, 57243.71378143083, 57299.71350143223, 59253.703731481066, 48408.5159148404, 83061.09286174955, 83701.16298836934, 84804.57597711972, 84959.97767122858, 10825.07986821129, 10956.233063685784, 11295.943520282346, 11324.660260192208, 12367.257964521797, 11902.226355286879, 12128.696782580506, 12189.14675972709, 12440.502379905065, 12708.364581771059, 11485.712857178303, 11578.94210528942, 11789.351585662527, 11831.0, 12130.33283169434, 11454.312741235553, 11646.24299420535, 11769.882301177222, 11922.225055371373, 12270.263784172977, 11375.31748095117, 11640.94179529097, 11688.47401866901, 11880.524779008743, 12112.818307725214, 9772.706818795448, 9779.364341317792, 9879.802403952024, 10273.332233405104, 10395.480225988518, 8932.598033088396, 9396.95301523488, 10164.390136591828, 10178.0, 10329.380237185793], "value": 7438.24178121442, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 106.0, 111.0, 119.0, 113.0, 114.0, 112.0, 113.0, 111.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 118.0, 154.0, 179.0, 117.0, 144.0, 165.0, 120.0, 178.0, 121.0], "value": 144.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 161.0, 164.0, 162.0, 169.0, 165.0, 160.0, 161.0, 163.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 169.0, 76.0, 77.0, 75.0, 83.0, 182.0, 80.0], "value": 96.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 158.0, 85.0, 84.0, 85.0, 144.0, 84.0, 84.0, 144.0], "value": 103.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 147.0, 147.0, 148.0, 148.0, 147.0, 146.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 97.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 55.0, 52.0, 54.0, 51.0, 52.0, 52.0, 51.0, 53.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 64.0, 63.0, 63.0, 63.0, 63.0, 66.0, 63.0], "value": 63.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 76.0, 77.0, 76.0, 77.0, 83.0, 77.0, 77.0, 86.0, 76.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 121.0, 123.0, 125.0, 137.0, 126.0, 123.0, 126.0, 169.0, 132.0], "value": 131.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 157.0, 160.0, 154.0, 160.0, 157.0, 162.0, 158.0, 159.0, 155.0], "value": 157.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 65.0, 63.0, 64.0, 65.0, 68.0, 65.0, 64.0, 66.0], "value": 65.7, "unit": "score"}]}]} 08:36:32 INFO - Return code: 0 08:36:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:36:32 ERROR - # TBPL SUCCESS # 08:36:32 INFO - Running post-action listener: _resource_record_post_action 08:36:32 INFO - [mozharness: 2016-07-21 15:36:32.704059Z] Finished run-tests step (success) 08:36:32 INFO - Running post-run listener: _resource_record_post_run 08:36:32 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 552169472; Read time: 0; Write time: 554260 08:36:32 INFO - TinderboxPrint: CPU usage
13.3% 08:36:32 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:36:32 INFO - TinderboxPrint: I/O write bytes / time
552,169,472 / 554,260 08:36:32 INFO - TinderboxPrint: CPU idle
8,240.8 (86.6%) 08:36:32 INFO - TinderboxPrint: CPU user
1,213.3 (12.8%) 08:36:32 INFO - TinderboxPrint: Swap in / out
0 / 0 08:36:32 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 257531904; Read time: 0; Write time: 331780 08:36:32 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 294637568; Read time: 0; Write time: 222480 08:36:33 INFO - Running post-run listener: _upload_blobber_files 08:36:33 INFO - Blob upload gear active. 08:36:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:36:33 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:36:33 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:36:33 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:36:33 INFO - (blobuploader) - INFO - Open directory for files ... 08:36:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:36:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:36:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:36:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:34 INFO - (blobuploader) - INFO - Done attempting. 08:36:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:36:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:36:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:36:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:54 INFO - (blobuploader) - INFO - Done attempting. 08:36:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:36:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:36:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:36:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:54 INFO - (blobuploader) - INFO - Done attempting. 08:36:54 INFO - (blobuploader) - INFO - Iteration through files over. 08:36:54 INFO - Return code: 0 08:36:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:36:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:36:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/897d34352bf39c416d4ae38d73f487ae80c3c49480c4a5dd1e8872f87d22ca36b0a5a218a996a0038103244202dfdad93fa4864620cb1b8ffe28983811797216", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c97830e468af373803323f8d6b1c96989eeb75fd0dfd91ef05279503a476772356efa75b01c90efd456e6fc709f673ddc54f681d4fa20586de493ca88d276f7a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f663b3f95428acd5a0997781ec297ed547d48c45363262c5996b02857e540840ef42d022de17e155abc8eab6a629e23910c1a7ff6a913dab714085be080fa884"} 08:36:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:36:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:36:54 INFO - Contents: 08:36:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/897d34352bf39c416d4ae38d73f487ae80c3c49480c4a5dd1e8872f87d22ca36b0a5a218a996a0038103244202dfdad93fa4864620cb1b8ffe28983811797216", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c97830e468af373803323f8d6b1c96989eeb75fd0dfd91ef05279503a476772356efa75b01c90efd456e6fc709f673ddc54f681d4fa20586de493ca88d276f7a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f663b3f95428acd5a0997781ec297ed547d48c45363262c5996b02857e540840ef42d022de17e155abc8eab6a629e23910c1a7ff6a913dab714085be080fa884"} 08:36:54 INFO - Running post-run listener: copy_logs_to_upload_dir 08:36:54 INFO - Copying logs to upload dir... 08:36:54 INFO - mkdir: /builds/slave/test/build/upload/logs 08:36:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.518953 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-07-21 08:36:54.723369) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 08:36:54.726570) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1469114092.661925-1380067104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/897d34352bf39c416d4ae38d73f487ae80c3c49480c4a5dd1e8872f87d22ca36b0a5a218a996a0038103244202dfdad93fa4864620cb1b8ffe28983811797216", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c97830e468af373803323f8d6b1c96989eeb75fd0dfd91ef05279503a476772356efa75b01c90efd456e6fc709f673ddc54f681d4fa20586de493ca88d276f7a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f663b3f95428acd5a0997781ec297ed547d48c45363262c5996b02857e540840ef42d022de17e155abc8eab6a629e23910c1a7ff6a913dab714085be080fa884"} build_url:https://queue.taskcluster.net/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011333 build_url: 'https://queue.taskcluster.net/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/897d34352bf39c416d4ae38d73f487ae80c3c49480c4a5dd1e8872f87d22ca36b0a5a218a996a0038103244202dfdad93fa4864620cb1b8ffe28983811797216", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c97830e468af373803323f8d6b1c96989eeb75fd0dfd91ef05279503a476772356efa75b01c90efd456e6fc709f673ddc54f681d4fa20586de493ca88d276f7a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f663b3f95428acd5a0997781ec297ed547d48c45363262c5996b02857e540840ef42d022de17e155abc8eab6a629e23910c1a7ff6a913dab714085be080fa884"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 08:36:54.751286) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 08:36:54.751599) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1469114092.661925-1380067104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 08:36:54.833977) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 08:36:54.834295) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 08:36:54.834575) ========= ========= Total master_lag: 0.16 =========