builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-056 starttime: 1469048646.25 results: success (0) buildid: 20160720113021 builduid: f91670464df8443d9c1dd4474181f491 revision: 0cca5d80caa9f04d491c28b388f2f396fd45fe5c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 14:04:06.253964) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 14:04:06.254436) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 14:04:06.254712) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 14:04:06.267633) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 14:04:06.267937) ========= 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=52faae308a556c440401f8e5000001e8-1469048641.730910-1476768479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-20 14:04:06-- 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% 17.3M=0.001s 2016-07-20 14:04:06 (17.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085579 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 14:04:06.365388) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 14:04:06.365698) ========= 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=52faae308a556c440401f8e5000001e8-1469048641.730910-1476768479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018771 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 14:04:06.415889) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 14:04:06.416239) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0cca5d80caa9f04d491c28b388f2f396fd45fe5c --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 0cca5d80caa9f04d491c28b388f2f396fd45fe5c --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=52faae308a556c440401f8e5000001e8-1469048641.730910-1476768479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-20 14:04:06,483 truncating revision to first 12 chars 2016-07-20 14:04:06,484 Setting DEBUG logging. 2016-07-20 14:04:06,484 attempt 1/10 2016-07-20 14:04:06,484 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0cca5d80caa9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-20 14:04:06,788 unpacking tar archive at: fx-team-0cca5d80caa9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.642618 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 14:04:07.072080) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 14:04:07.072396) ========= script_repo_revision: 0cca5d80caa9f04d491c28b388f2f396fd45fe5c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 14:04:07.072770) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 14:04:07.073030) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 14:04:07.082052) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-20 14:04:07.082381) ========= /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=52faae308a556c440401f8e5000001e8-1469048641.730910-1476768479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:04:07 INFO - MultiFileLogger online at 20160720 14:04:07 in /builds/slave/test 14:04:07 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 14:04:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:04:07 INFO - {'append_to_log': False, 14:04:07 INFO - 'base_work_dir': '/builds/slave/test', 14:04:07 INFO - 'blob_upload_branch': 'Fx-Team', 14:04:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:04:07 INFO - 'branch': 'Fx-Team', 14:04:07 INFO - 'buildbot_json_path': 'buildprops.json', 14:04:07 INFO - 'config_files': ('talos/linux_config.py',), 14:04:07 INFO - 'default_actions': ('clobber', 14:04:07 INFO - 'read-buildbot-config', 14:04:07 INFO - 'download-and-extract', 14:04:07 INFO - 'populate-webroot', 14:04:07 INFO - 'create-virtualenv', 14:04:07 INFO - 'install', 14:04:07 INFO - 'run-tests'), 14:04:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:04:07 INFO - 'download_minidump_stackwalk': True, 14:04:07 INFO - 'download_symbols': 'ondemand', 14:04:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:04:07 INFO - 'tooltool.py': '/tools/tooltool.py', 14:04:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:04:07 INFO - '/tools/misc-python/virtualenv.py')}, 14:04:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:04:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:04:07 INFO - 'installer_path': 'installer.exe', 14:04:07 INFO - 'log_level': 'info', 14:04:07 INFO - 'log_name': 'talos', 14:04:07 INFO - 'log_to_console': True, 14:04:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:04:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:04:07 INFO - 'opt_config_files': (), 14:04:07 INFO - 'pip_index': False, 14:04:07 INFO - 'sps_profile': False, 14:04:07 INFO - 'sps_profile_interval': 0, 14:04:07 INFO - 'suite': 'dromaeojs-e10s', 14:04:07 INFO - 'system_bits': '32', 14:04:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:04:07 INFO - 'title': 'talos-linux64-ix-056', 14:04:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:04:07 INFO - 'use_talos_json': True, 14:04:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:04:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:04:07 INFO - 'work_dir': 'build'} 14:04:07 INFO - [mozharness: 2016-07-20 21:04:07.242767Z] Running clobber step. 14:04:07 INFO - Running pre-action listener: _resource_record_pre_action 14:04:07 INFO - Running main action method: clobber 14:04:07 INFO - rmtree: /builds/slave/test/build 14:04:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:04:07 INFO - Running post-action listener: _resource_record_post_action 14:04:07 INFO - [mozharness: 2016-07-20 21:04:07.706716Z] Finished clobber step (success) 14:04:07 INFO - [mozharness: 2016-07-20 21:04:07.706817Z] Running read-buildbot-config step. 14:04:07 INFO - Running pre-action listener: _resource_record_pre_action 14:04:07 INFO - Running main action method: read_buildbot_config 14:04:07 INFO - Using buildbot properties: 14:04:07 INFO - { 14:04:07 INFO - "project": "", 14:04:07 INFO - "product": "firefox", 14:04:07 INFO - "script_repo_revision": "production", 14:04:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:04:07 INFO - "repository": "", 14:04:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 14:04:07 INFO - "buildid": "20160720113021", 14:04:07 INFO - "pgo_build": "True", 14:04:07 INFO - "basedir": "/builds/slave/test", 14:04:07 INFO - "buildnumber": 592, 14:04:07 INFO - "slavename": "talos-linux64-ix-056", 14:04:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:04:07 INFO - "platform": "ubuntu64_hw", 14:04:07 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:04:07 INFO - "branch": "fx-team", 14:04:07 INFO - "repo_path": "integration/fx-team", 14:04:07 INFO - "revision": "0cca5d80caa9f04d491c28b388f2f396fd45fe5c", 14:04:07 INFO - "stage_platform": "linux64-pgo", 14:04:07 INFO - "builduid": "f91670464df8443d9c1dd4474181f491", 14:04:07 INFO - "slavebuilddir": "test" 14:04:07 INFO - } 14:04:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/IB9Gnhi1TSGb5x3jn7ENvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:04:07 INFO - Running post-action listener: _resource_record_post_action 14:04:07 INFO - [mozharness: 2016-07-20 21:04:07.709278Z] Finished read-buildbot-config step (success) 14:04:07 INFO - [mozharness: 2016-07-20 21:04:07.709367Z] Running download-and-extract step. 14:04:07 INFO - Running pre-action listener: _resource_record_pre_action 14:04:07 INFO - Running main action method: download_and_extract 14:04:07 INFO - mkdir: /builds/slave/test/build/tests 14:04: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')]} 14:04:07 INFO - https://queue.taskcluster.net/v1/task/IB9Gnhi1TSGb5x3jn7ENvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:04:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IB9Gnhi1TSGb5x3jn7ENvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:04:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IB9Gnhi1TSGb5x3jn7ENvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:04:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IB9Gnhi1TSGb5x3jn7ENvg/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 14:04:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IB9Gnhi1TSGb5x3jn7ENvg/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 14:04:08 INFO - Downloaded 1361 bytes. 14:04:08 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:04:08 INFO - Using the following test package requirements: 14:04:08 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:04:08 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:04:08 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:04:08 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:08 INFO - u'jsshell-linux-x86_64.zip'], 14:04:08 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:04:08 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:04:08 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:04:08 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:04:08 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:04:08 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:04:08 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:04:08 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')]} 14:04:08 INFO - https://queue.taskcluster.net/v1/task/IB9Gnhi1TSGb5x3jn7ENvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:04:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IB9Gnhi1TSGb5x3jn7ENvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:04:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IB9Gnhi1TSGb5x3jn7ENvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:04:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IB9Gnhi1TSGb5x3jn7ENvg/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 14:04:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IB9Gnhi1TSGb5x3jn7ENvg/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 14:04:10 INFO - Downloaded 24342663 bytes. 14:04:10 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'] 14:04:10 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 14:04:11 INFO - Return code: 0 14:04:11 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 14:04:11 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')]} 14:04:11 INFO - https://queue.taskcluster.net/v1/task/IB9Gnhi1TSGb5x3jn7ENvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:04:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IB9Gnhi1TSGb5x3jn7ENvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:04:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IB9Gnhi1TSGb5x3jn7ENvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:04:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IB9Gnhi1TSGb5x3jn7ENvg/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 14:04:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IB9Gnhi1TSGb5x3jn7ENvg/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 14:04:13 INFO - Downloaded 24342663 bytes. 14:04:13 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'] 14:04:13 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 14:04:14 INFO - Return code: 0 14:04: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')]} 14:04:14 INFO - https://queue.taskcluster.net/v1/task/IB9Gnhi1TSGb5x3jn7ENvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:04:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IB9Gnhi1TSGb5x3jn7ENvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:04:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IB9Gnhi1TSGb5x3jn7ENvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:04:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IB9Gnhi1TSGb5x3jn7ENvg/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 14:04:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IB9Gnhi1TSGb5x3jn7ENvg/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 14:04:16 INFO - Downloaded 14403317 bytes. 14:04:16 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'] 14:04:16 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 14:04:16 INFO - Return code: 0 14:04:16 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')]} 14:04:16 INFO - https://queue.taskcluster.net/v1/task/IB9Gnhi1TSGb5x3jn7ENvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:04:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IB9Gnhi1TSGb5x3jn7ENvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:04:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IB9Gnhi1TSGb5x3jn7ENvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:04:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IB9Gnhi1TSGb5x3jn7ENvg/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 14:04:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IB9Gnhi1TSGb5x3jn7ENvg/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 14:04:19 INFO - Downloaded 60914020 bytes. 14:04:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IB9Gnhi1TSGb5x3jn7ENvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:04:19 INFO - mkdir: /builds/slave/test/properties 14:04:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:04:19 INFO - Writing to file /builds/slave/test/properties/build_url 14:04:19 INFO - Contents: 14:04:19 INFO - build_url:https://queue.taskcluster.net/v1/task/IB9Gnhi1TSGb5x3jn7ENvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:04:19 INFO - Running post-action listener: _resource_record_post_action 14:04:19 INFO - Running post-action listener: set_extra_try_arguments 14:04:19 INFO - [mozharness: 2016-07-20 21:04:19.817066Z] Finished download-and-extract step (success) 14:04:19 INFO - [mozharness: 2016-07-20 21:04:19.817300Z] Running populate-webroot step. 14:04:19 INFO - Running pre-action listener: _resource_record_pre_action 14:04:19 INFO - Running main action method: populate_webroot 14:04:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:04:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:04:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:04:19 INFO - '--tppagecycles', 14:04:19 INFO - '7'], 14:04:19 INFO - 'tests': ['tsvgm']}}, 14:04:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:04:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:04:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:04:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:04:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:04:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:04:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:19 INFO - 'talos_options': ['--disable-e10s'], 14:04:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:04:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:04:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:19 INFO - 'talos_options': ['--disable-e10s'], 14:04:19 INFO - 'tests': ['damp', 'tps']}, 14:04:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:19 INFO - 'tests': ['damp', 'tps']}, 14:04:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:04:19 INFO - 'tests': ['dromaeo_dom']}, 14:04:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:04:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:04:19 INFO - 'tests': ['basic_compositor_video']}, 14:04:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:04:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:04:19 INFO - 'tests': ['a11yr', 14:04:19 INFO - 'ts_paint', 14:04:19 INFO - 'tpaint', 14:04:19 INFO - 'sessionrestore', 14:04:19 INFO - 'sessionrestore_no_auto_restore', 14:04:19 INFO - 'tabpaint']}, 14:04:19 INFO - 'other-e10s': {'tests': ['a11yr', 14:04:19 INFO - 'ts_paint', 14:04:19 INFO - 'tpaint', 14:04:19 INFO - 'sessionrestore', 14:04:19 INFO - 'sessionrestore_no_auto_restore', 14:04:19 INFO - 'tabpaint']}, 14:04:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:04:19 INFO - 'ts_paint', 14:04:19 INFO - 'tpaint', 14:04:19 INFO - 'sessionrestore', 14:04:19 INFO - 'sessionrestore_no_auto_restore', 14:04:19 INFO - 'tabpaint']}, 14:04:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:04:19 INFO - 'ts_paint', 14:04:19 INFO - 'tpaint', 14:04:19 INFO - 'sessionrestore', 14:04:19 INFO - 'sessionrestore_no_auto_restore', 14:04:19 INFO - 'tabpaint']}, 14:04:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:04:19 INFO - 'tests': ['a11yr', 14:04:19 INFO - 'ts_paint', 14:04:19 INFO - 'tpaint', 14:04:19 INFO - 'sessionrestore', 14:04:19 INFO - 'sessionrestore_no_auto_restore', 14:04:19 INFO - 'tabpaint']}, 14:04:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:04:19 INFO - 'tests': ['a11yr', 14:04:19 INFO - 'ts_paint', 14:04:19 INFO - 'tpaint', 14:04:19 INFO - 'sessionrestore', 14:04:19 INFO - 'sessionrestore_no_auto_restore', 14:04:19 INFO - 'tabpaint']}, 14:04:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:04:19 INFO - 'tests': ['tsvgx', 14:04:19 INFO - 'tsvgr_opacity', 14:04:19 INFO - 'tart', 14:04:19 INFO - 'tscrollx', 14:04:19 INFO - 'cart']}, 14:04:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:04:19 INFO - 'tsvgr_opacity', 14:04:19 INFO - 'tart', 14:04:19 INFO - 'tscrollx', 14:04:19 INFO - 'cart']}, 14:04:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:19 INFO - 'talos_options': ['--disable-e10s'], 14:04:19 INFO - 'tests': ['tp5o']}, 14:04:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:19 INFO - 'tests': ['tp5o']}, 14:04:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:19 INFO - 'talos_options': ['--disable-e10s', 14:04:19 INFO - '--xperf_path', 14:04:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:04:19 INFO - 'tests': ['tp5n']}, 14:04:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:19 INFO - 'talos_options': ['--xperf_path', 14:04:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:04:19 INFO - 'tests': ['tp5n']}}, 14:04:19 INFO - 'talos.zip': {'path': '', 14:04:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:04:19 INFO - Running post-action listener: _resource_record_post_action 14:04:19 INFO - [mozharness: 2016-07-20 21:04:19.836834Z] Finished populate-webroot step (success) 14:04:19 INFO - [mozharness: 2016-07-20 21:04:19.836924Z] Running create-virtualenv step. 14:04:19 INFO - Running pre-action listener: _resource_record_pre_action 14:04:19 INFO - Running main action method: create_virtualenv 14:04:19 INFO - Creating virtualenv /builds/slave/test/build/venv 14:04:19 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:04:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:04:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:04:19 INFO - Using real prefix '/usr' 14:04:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:04:20 INFO - Installing distribute.............................................................................................................................................................................................done. 14:04:22 INFO - Installing pip.................done. 14:04:22 INFO - Return code: 0 14:04:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:04:22 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')]} 14:04:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:22 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')]} 14:04:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:22 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 0x12ea030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ab180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a93b0>, '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 0x15aa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15aa740>, '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': '52faae308a556c440401f8e5000001e8-1469048641.730910-1476768479', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:04:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:04:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:04:22 INFO - Using env: {'DISPLAY': ':0', 14:04:22 INFO - 'HOME': '/home/cltbld', 14:04:22 INFO - 'LANG': 'en_US.UTF-8', 14:04:22 INFO - 'LANGUAGE': 'en_US:en', 14:04:22 INFO - 'LOGNAME': 'cltbld', 14:04:22 INFO - 'MAIL': '/var/mail/cltbld', 14:04:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:22 INFO - 'MOZ_NO_REMOTE': '1', 14:04:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:22 INFO - 'NO_EM_RESTART': '1', 14:04:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:22 INFO - 'PWD': '/builds/slave/test', 14:04:22 INFO - 'SHELL': '/bin/bash', 14:04:22 INFO - 'SHLVL': '1', 14:04:22 INFO - 'TERM': 'linux', 14:04:22 INFO - 'TMOUT': '86400', 14:04:22 INFO - 'USER': 'cltbld', 14:04:22 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1469048641.730910-1476768479', 14:04:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:22 INFO - '_': '/tools/buildbot/bin/python'} 14:04:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:04:22 INFO - Cleaning up... 14:04:22 INFO - Return code: 0 14:04:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:04:22 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')]} 14:04:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:22 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')]} 14:04:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:22 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 0x12ea030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ab180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a93b0>, '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 0x15aa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15aa740>, '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': '52faae308a556c440401f8e5000001e8-1469048641.730910-1476768479', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:04:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:04:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:04:22 INFO - Using env: {'DISPLAY': ':0', 14:04:22 INFO - 'HOME': '/home/cltbld', 14:04:22 INFO - 'LANG': 'en_US.UTF-8', 14:04:22 INFO - 'LANGUAGE': 'en_US:en', 14:04:22 INFO - 'LOGNAME': 'cltbld', 14:04:22 INFO - 'MAIL': '/var/mail/cltbld', 14:04:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:22 INFO - 'MOZ_NO_REMOTE': '1', 14:04:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:22 INFO - 'NO_EM_RESTART': '1', 14:04:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:22 INFO - 'PWD': '/builds/slave/test', 14:04:22 INFO - 'SHELL': '/bin/bash', 14:04:22 INFO - 'SHLVL': '1', 14:04:22 INFO - 'TERM': 'linux', 14:04:22 INFO - 'TMOUT': '86400', 14:04:22 INFO - 'USER': 'cltbld', 14:04:22 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1469048641.730910-1476768479', 14:04:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:22 INFO - '_': '/tools/buildbot/bin/python'} 14:04:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:22 INFO - Downloading/unpacking psutil>=3.1.1 14:04:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:04:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:04:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:04:24 INFO - Installing collected packages: psutil 14:04:24 INFO - Running setup.py install for psutil 14:04:24 INFO - building 'psutil._psutil_linux' extension 14:04:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:04:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:04:25 INFO - building 'psutil._psutil_posix' extension 14:04:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:04:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:04:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:04:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:04:25 INFO - Successfully installed psutil 14:04:25 INFO - Cleaning up... 14:04:25 INFO - Return code: 0 14:04:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:04:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:04:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:04:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:25 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 0x12ea030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ab180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a93b0>, '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 0x15aa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15aa740>, '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': '52faae308a556c440401f8e5000001e8-1469048641.730910-1476768479', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:04:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:04:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:04:25 INFO - Using env: {'DISPLAY': ':0', 14:04:25 INFO - 'HOME': '/home/cltbld', 14:04:25 INFO - 'LANG': 'en_US.UTF-8', 14:04:25 INFO - 'LANGUAGE': 'en_US:en', 14:04:25 INFO - 'LOGNAME': 'cltbld', 14:04:25 INFO - 'MAIL': '/var/mail/cltbld', 14:04:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:25 INFO - 'MOZ_NO_REMOTE': '1', 14:04:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:25 INFO - 'NO_EM_RESTART': '1', 14:04:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:25 INFO - 'PWD': '/builds/slave/test', 14:04:25 INFO - 'SHELL': '/bin/bash', 14:04:25 INFO - 'SHLVL': '1', 14:04:25 INFO - 'TERM': 'linux', 14:04:25 INFO - 'TMOUT': '86400', 14:04:25 INFO - 'USER': 'cltbld', 14:04:25 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1469048641.730910-1476768479', 14:04:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:25 INFO - '_': '/tools/buildbot/bin/python'} 14:04:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:04:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:04:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:04:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:04:27 INFO - Installing collected packages: mozsystemmonitor 14:04:27 INFO - Running setup.py install for mozsystemmonitor 14:04:27 INFO - Successfully installed mozsystemmonitor 14:04:27 INFO - Cleaning up... 14:04:27 INFO - Return code: 0 14:04:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:04:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:04:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:04:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:27 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 0x12ea030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ab180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a93b0>, '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 0x15aa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15aa740>, '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': '52faae308a556c440401f8e5000001e8-1469048641.730910-1476768479', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:04:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:04:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:04:27 INFO - Using env: {'DISPLAY': ':0', 14:04:27 INFO - 'HOME': '/home/cltbld', 14:04:27 INFO - 'LANG': 'en_US.UTF-8', 14:04:27 INFO - 'LANGUAGE': 'en_US:en', 14:04:27 INFO - 'LOGNAME': 'cltbld', 14:04:27 INFO - 'MAIL': '/var/mail/cltbld', 14:04:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:27 INFO - 'MOZ_NO_REMOTE': '1', 14:04:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:27 INFO - 'NO_EM_RESTART': '1', 14:04:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:27 INFO - 'PWD': '/builds/slave/test', 14:04:27 INFO - 'SHELL': '/bin/bash', 14:04:27 INFO - 'SHLVL': '1', 14:04:27 INFO - 'TERM': 'linux', 14:04:27 INFO - 'TMOUT': '86400', 14:04:27 INFO - 'USER': 'cltbld', 14:04:27 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1469048641.730910-1476768479', 14:04:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:27 INFO - '_': '/tools/buildbot/bin/python'} 14:04:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:28 INFO - Downloading/unpacking jsonschema==2.5.1 14:04: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 14:04: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 14:04: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 14:04: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 14:04: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 14:04: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 14:04:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:04:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:04:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:30 INFO - Downloading functools32-3.2.3-2.tar.gz 14:04:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:04:30 INFO - warning: no files found matching '*.txt' 14:04:30 INFO - no previously-included directories found matching 'build' 14:04:30 INFO - no previously-included directories found matching 'dist' 14:04:30 INFO - no previously-included directories found matching '.git*' 14:04:30 INFO - Installing collected packages: jsonschema, functools32 14:04:30 INFO - Running setup.py install for functools32 14:04:30 INFO - warning: no files found matching '*.txt' 14:04:30 INFO - no previously-included directories found matching 'build' 14:04:30 INFO - no previously-included directories found matching 'dist' 14:04:30 INFO - no previously-included directories found matching '.git*' 14:04:30 INFO - Successfully installed jsonschema functools32 14:04:30 INFO - Cleaning up... 14:04:30 INFO - Return code: 0 14:04:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:04:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x12ea030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ab180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a93b0>, '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 0x15aa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15aa740>, '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': '52faae308a556c440401f8e5000001e8-1469048641.730910-1476768479', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:04:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:04:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:04:30 INFO - Using env: {'DISPLAY': ':0', 14:04:30 INFO - 'HOME': '/home/cltbld', 14:04:30 INFO - 'LANG': 'en_US.UTF-8', 14:04:30 INFO - 'LANGUAGE': 'en_US:en', 14:04:30 INFO - 'LOGNAME': 'cltbld', 14:04:30 INFO - 'MAIL': '/var/mail/cltbld', 14:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:30 INFO - 'MOZ_NO_REMOTE': '1', 14:04:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:30 INFO - 'NO_EM_RESTART': '1', 14:04:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:30 INFO - 'PWD': '/builds/slave/test', 14:04:30 INFO - 'SHELL': '/bin/bash', 14:04:30 INFO - 'SHLVL': '1', 14:04:30 INFO - 'TERM': 'linux', 14:04:30 INFO - 'TMOUT': '86400', 14:04:30 INFO - 'USER': 'cltbld', 14:04:30 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1469048641.730910-1476768479', 14:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:30 INFO - '_': '/tools/buildbot/bin/python'} 14:04:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:30 INFO - Downloading/unpacking blobuploader==1.2.4 14:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:32 INFO - Downloading blobuploader-1.2.4.tar.gz 14:04:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:04:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:04:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:33 INFO - Downloading docopt-0.6.1.tar.gz 14:04:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:04:33 INFO - Installing collected packages: blobuploader, requests, docopt 14:04:33 INFO - Running setup.py install for blobuploader 14:04:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:04:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:04:33 INFO - Running setup.py install for requests 14:04:33 INFO - Running setup.py install for docopt 14:04:33 INFO - Successfully installed blobuploader requests docopt 14:04:33 INFO - Cleaning up... 14:04:33 INFO - Return code: 0 14:04:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:04:33 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')]} 14:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:33 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')]} 14:04:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:33 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 0x12ea030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ab180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a93b0>, '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 0x15aa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15aa740>, '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': '52faae308a556c440401f8e5000001e8-1469048641.730910-1476768479', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:04:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:04:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:04:33 INFO - Using env: {'DISPLAY': ':0', 14:04:33 INFO - 'HOME': '/home/cltbld', 14:04:33 INFO - 'LANG': 'en_US.UTF-8', 14:04:33 INFO - 'LANGUAGE': 'en_US:en', 14:04:33 INFO - 'LOGNAME': 'cltbld', 14:04:33 INFO - 'MAIL': '/var/mail/cltbld', 14:04:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:33 INFO - 'MOZ_NO_REMOTE': '1', 14:04:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:33 INFO - 'NO_EM_RESTART': '1', 14:04:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:33 INFO - 'PWD': '/builds/slave/test', 14:04:33 INFO - 'SHELL': '/bin/bash', 14:04:33 INFO - 'SHLVL': '1', 14:04:33 INFO - 'TERM': 'linux', 14:04:33 INFO - 'TMOUT': '86400', 14:04:33 INFO - 'USER': 'cltbld', 14:04:33 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1469048641.730910-1476768479', 14:04:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:33 INFO - '_': '/tools/buildbot/bin/python'} 14:04:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:04:34 INFO - Running setup.py (path:/tmp/pip-YWhpSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:04:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:04:34 INFO - Running setup.py (path:/tmp/pip-MGGGH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:04:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:04:34 INFO - Running setup.py (path:/tmp/pip-hAsMrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:04:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:04:34 INFO - Running setup.py (path:/tmp/pip-SwCGiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:04:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:04:34 INFO - Running setup.py (path:/tmp/pip-VQR9Ed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:04:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:04:34 INFO - Running setup.py (path:/tmp/pip-Q4q7aR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:04:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:04:34 INFO - Running setup.py (path:/tmp/pip-037wQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:04:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:04:34 INFO - Running setup.py (path:/tmp/pip-rkMOtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:04:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:04:34 INFO - Running setup.py (path:/tmp/pip-DXonc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:04:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:04:34 INFO - Running setup.py (path:/tmp/pip-n3Q6fp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:04:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:04:34 INFO - Running setup.py (path:/tmp/pip-Z5Qul4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:04:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:04:34 INFO - Running setup.py (path:/tmp/pip-rWtkI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:04:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:04:34 INFO - Running setup.py (path:/tmp/pip-TLHyNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:04:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:04:35 INFO - Running setup.py (path:/tmp/pip-cSmKuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:04:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:04:35 INFO - Running setup.py (path:/tmp/pip-9GvYtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:04:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:04:35 INFO - Running setup.py (path:/tmp/pip-xg6G6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:04:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:04:35 INFO - Running setup.py (path:/tmp/pip-7L1pXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:04:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:04:35 INFO - Running setup.py install for manifestparser 14:04:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:04:35 INFO - Running setup.py install for mozcrash 14:04:35 INFO - Running setup.py install for mozdebug 14:04:35 INFO - Running setup.py install for mozdevice 14:04:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:04:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:04:35 INFO - Running setup.py install for mozfile 14:04:35 INFO - Running setup.py install for mozhttpd 14:04:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:04:35 INFO - Running setup.py install for mozinfo 14:04:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:04:36 INFO - Running setup.py install for mozInstall 14:04:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:04:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:04:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:04:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:04:36 INFO - Running setup.py install for mozleak 14:04:36 INFO - Running setup.py install for mozlog 14:04:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:04:36 INFO - Running setup.py install for moznetwork 14:04:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:04:36 INFO - Running setup.py install for mozprocess 14:04:36 INFO - Running setup.py install for mozprofile 14:04:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:04:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:04:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:04:36 INFO - Running setup.py install for mozrunner 14:04:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:04:36 INFO - Running setup.py install for mozscreenshot 14:04:36 INFO - Running setup.py install for moztest 14:04:36 INFO - Running setup.py install for mozversion 14:04:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:04:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:04:37 INFO - Cleaning up... 14:04:37 INFO - Return code: 0 14:04:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:04:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:04:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:37 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 0x12ea030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ab180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a93b0>, '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 0x15aa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15aa740>, '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': '52faae308a556c440401f8e5000001e8-1469048641.730910-1476768479', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:04:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:04:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:04:37 INFO - Using env: {'DISPLAY': ':0', 14:04:37 INFO - 'HOME': '/home/cltbld', 14:04:37 INFO - 'LANG': 'en_US.UTF-8', 14:04:37 INFO - 'LANGUAGE': 'en_US:en', 14:04:37 INFO - 'LOGNAME': 'cltbld', 14:04:37 INFO - 'MAIL': '/var/mail/cltbld', 14:04:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:37 INFO - 'MOZ_NO_REMOTE': '1', 14:04:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:37 INFO - 'NO_EM_RESTART': '1', 14:04:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:37 INFO - 'PWD': '/builds/slave/test', 14:04:37 INFO - 'SHELL': '/bin/bash', 14:04:37 INFO - 'SHLVL': '1', 14:04:37 INFO - 'TERM': 'linux', 14:04:37 INFO - 'TMOUT': '86400', 14:04:37 INFO - 'USER': 'cltbld', 14:04:37 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1469048641.730910-1476768479', 14:04:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:37 INFO - '_': '/tools/buildbot/bin/python'} 14:04:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:04:37 INFO - Running setup.py (path:/tmp/pip-K95Ql8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:04:37 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:04:37 INFO - Running setup.py (path:/tmp/pip-C92jYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:04:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:04:37 INFO - Running setup.py (path:/tmp/pip-oRK_Sq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:04:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:04:37 INFO - Running setup.py (path:/tmp/pip-d9mb_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:04:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:04:37 INFO - Running setup.py (path:/tmp/pip-Gvm1vV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:04:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:04:37 INFO - Running setup.py (path:/tmp/pip-Kxr7FB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:04:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:04:37 INFO - Running setup.py (path:/tmp/pip-2sHNbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:04:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:04:37 INFO - Running setup.py (path:/tmp/pip-ywkKzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:04:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:04:37 INFO - Running setup.py (path:/tmp/pip-OXMdaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:04:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:04:37 INFO - Running setup.py (path:/tmp/pip-t4qJfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:04:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:04:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:04:38 INFO - Running setup.py (path:/tmp/pip-WJDeuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:04:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:04:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:04:38 INFO - Running setup.py (path:/tmp/pip-K23oPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:04:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:04:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:04:38 INFO - Running setup.py (path:/tmp/pip-4zYHQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:04:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:04:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:04:38 INFO - Running setup.py (path:/tmp/pip-G63DRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:04:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:04:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:04:38 INFO - Running setup.py (path:/tmp/pip-HVLdyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:04:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:04:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:04:38 INFO - Running setup.py (path:/tmp/pip-BI4SMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:04:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:04:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:04:38 INFO - Running setup.py (path:/tmp/pip-apysEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:04:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:04:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:04:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:04:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:04:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:04:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:04:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:40 INFO - Downloading blessings-1.6.tar.gz 14:04:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:04:40 INFO - Installing collected packages: blessings 14:04:40 INFO - Running setup.py install for blessings 14:04:40 INFO - Successfully installed blessings 14:04:40 INFO - Cleaning up... 14:04:40 INFO - Return code: 0 14:04:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:04:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:04:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:04:40 INFO - Reading from file tmpfile_stdout 14:04:40 INFO - Current package versions: 14:04:40 INFO - argparse == 1.2.1 14:04:40 INFO - blessings == 1.6 14:04:40 INFO - blobuploader == 1.2.4 14:04:40 INFO - docopt == 0.6.1 14:04:40 INFO - functools32 == 3.2.3-2 14:04:40 INFO - jsonschema == 2.5.1 14:04:40 INFO - manifestparser == 1.1 14:04:40 INFO - mozInstall == 1.12 14:04:40 INFO - mozcrash == 0.17 14:04:40 INFO - mozdebug == 0.1 14:04:40 INFO - mozdevice == 0.48 14:04:40 INFO - mozfile == 1.2 14:04:40 INFO - mozhttpd == 0.7 14:04:40 INFO - mozinfo == 0.9 14:04:40 INFO - mozleak == 0.1 14:04:40 INFO - mozlog == 3.3 14:04:40 INFO - moznetwork == 0.27 14:04:40 INFO - mozprocess == 0.23 14:04:40 INFO - mozprofile == 0.28 14:04:40 INFO - mozrunner == 6.12 14:04:40 INFO - mozscreenshot == 0.1 14:04:40 INFO - mozsystemmonitor == 0.3 14:04:40 INFO - moztest == 0.7 14:04:40 INFO - mozversion == 1.4 14:04:40 INFO - psutil == 3.1.1 14:04:40 INFO - requests == 1.2.3 14:04:40 INFO - wsgiref == 0.1.2 14:04:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:04: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')]} 14:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04: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')]} 14:04:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04: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 0x12ea030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ab180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a93b0>, '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 0x15aa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15aa740>, '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': '52faae308a556c440401f8e5000001e8-1469048641.730910-1476768479', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:04: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 14:04: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 14:04:40 INFO - Using env: {'DISPLAY': ':0', 14:04:40 INFO - 'HOME': '/home/cltbld', 14:04:40 INFO - 'LANG': 'en_US.UTF-8', 14:04:40 INFO - 'LANGUAGE': 'en_US:en', 14:04:40 INFO - 'LOGNAME': 'cltbld', 14:04:40 INFO - 'MAIL': '/var/mail/cltbld', 14:04:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:40 INFO - 'MOZ_NO_REMOTE': '1', 14:04:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:40 INFO - 'NO_EM_RESTART': '1', 14:04:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:40 INFO - 'PWD': '/builds/slave/test', 14:04:40 INFO - 'SHELL': '/bin/bash', 14:04:40 INFO - 'SHLVL': '1', 14:04:40 INFO - 'TERM': 'linux', 14:04:40 INFO - 'TMOUT': '86400', 14:04:40 INFO - 'USER': 'cltbld', 14:04:40 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1469048641.730910-1476768479', 14:04:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:40 INFO - '_': '/tools/buildbot/bin/python'} 14:04:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:04:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:04:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:04:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:04:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:04:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:04:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:04:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:04:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:04:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:04:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:04:41 INFO - Cleaning up... 14:04:41 INFO - Return code: 0 14:04:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:04:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:04:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:04:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ea030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ab180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a93b0>, '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 0x15aa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15aa740>, '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': '52faae308a556c440401f8e5000001e8-1469048641.730910-1476768479', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:04:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:04:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:04:41 INFO - Using env: {'DISPLAY': ':0', 14:04:41 INFO - 'HOME': '/home/cltbld', 14:04:41 INFO - 'LANG': 'en_US.UTF-8', 14:04:41 INFO - 'LANGUAGE': 'en_US:en', 14:04:41 INFO - 'LOGNAME': 'cltbld', 14:04:41 INFO - 'MAIL': '/var/mail/cltbld', 14:04:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:41 INFO - 'MOZ_NO_REMOTE': '1', 14:04:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:41 INFO - 'NO_EM_RESTART': '1', 14:04:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:41 INFO - 'PWD': '/builds/slave/test', 14:04:41 INFO - 'SHELL': '/bin/bash', 14:04:41 INFO - 'SHLVL': '1', 14:04:41 INFO - 'TERM': 'linux', 14:04:41 INFO - 'TMOUT': '86400', 14:04:41 INFO - 'USER': 'cltbld', 14:04:41 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1469048641.730910-1476768479', 14:04:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:41 INFO - '_': '/tools/buildbot/bin/python'} 14:04:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:04:41 INFO - Cleaning up... 14:04:41 INFO - Return code: 0 14:04:41 INFO - Running post-action listener: _resource_record_post_action 14:04:41 INFO - Running post-action listener: _start_resource_monitoring 14:04:41 INFO - Starting resource monitoring. 14:04:41 INFO - [mozharness: 2016-07-20 21:04:41.405757Z] Finished create-virtualenv step (success) 14:04:41 INFO - [mozharness: 2016-07-20 21:04:41.406322Z] Running install step. 14:04:41 INFO - Running pre-action listener: _resource_record_pre_action 14:04:41 INFO - Running main action method: install 14:04:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:04:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:04:41 INFO - Reading from file tmpfile_stdout 14:04:41 INFO - Detecting whether we're running mozinstall >=1.0... 14:04:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:04:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:04:41 INFO - Reading from file tmpfile_stdout 14:04:41 INFO - Output received: 14:04:41 INFO - Usage: mozinstall [options] installer 14:04:41 INFO - Options: 14:04:41 INFO - -h, --help show this help message and exit 14:04:41 INFO - -d DEST, --destination=DEST 14:04:41 INFO - Directory to install application into. [default: 14:04:41 INFO - "/builds/slave/test"] 14:04:41 INFO - --app=APP Application being installed. [default: firefox] 14:04:41 INFO - mkdir: /builds/slave/test/build/application 14:04:41 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'] 14:04:41 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 14:04:58 INFO - Reading from file tmpfile_stdout 14:04:58 INFO - Output received: 14:04:58 INFO - /builds/slave/test/build/application/firefox/firefox 14:04:58 INFO - Running post-action listener: _resource_record_post_action 14:04:58 INFO - [mozharness: 2016-07-20 21:04:58.945129Z] Finished install step (success) 14:04:58 INFO - [mozharness: 2016-07-20 21:04:58.945381Z] Running run-tests step. 14:04:58 INFO - Running pre-action listener: _resource_record_pre_action 14:04:58 INFO - Running main action method: run_tests 14:04:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:04:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:04:58 INFO - Python 2.7.3 14:04:58 INFO - Return code: 0 14:04:58 INFO - grabbing minidump binary from tooltool 14:04: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')]} 14:04: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 0x15a93b0>, '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 0x15aa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15aa740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:04: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 14:04: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 14:04: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 14:04:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:04:59 INFO - Return code: 0 14:04:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:04:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:04:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:04:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:04:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:04:59 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/IB9Gnhi1TSGb5x3jn7ENvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 14:04:59 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/IB9Gnhi1TSGb5x3jn7ENvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 14:04:59 INFO - Using env: {'DISPLAY': ':0', 14:04:59 INFO - 'HOME': '/home/cltbld', 14:04:59 INFO - 'LANG': 'en_US.UTF-8', 14:04:59 INFO - 'LANGUAGE': 'en_US:en', 14:04:59 INFO - 'LOGNAME': 'cltbld', 14:04:59 INFO - 'MAIL': '/var/mail/cltbld', 14:04:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:04:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:59 INFO - 'MOZ_NO_REMOTE': '1', 14:04:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:04:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:59 INFO - 'NO_EM_RESTART': '1', 14:04:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:59 INFO - 'PWD': '/builds/slave/test', 14:04:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:04:59 INFO - 'SHELL': '/bin/bash', 14:04:59 INFO - 'SHLVL': '1', 14:04:59 INFO - 'TERM': 'linux', 14:04:59 INFO - 'TMOUT': '86400', 14:04:59 INFO - 'USER': 'cltbld', 14:04:59 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1469048641.730910-1476768479', 14:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:59 INFO - '_': '/tools/buildbot/bin/python'} 14:04:59 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/IB9Gnhi1TSGb5x3jn7ENvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 14:04:59 INFO - mozversion application_buildid: 20160720113021 14:04:59 INFO - mozversion application_changeset: 0cca5d80caa9f04d491c28b388f2f396fd45fe5c 14:04:59 INFO - mozversion application_display_name: Nightly 14:04:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:04:59 INFO - mozversion application_name: Firefox 14:04:59 INFO - mozversion application_remotingname: firefox 14:04:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:04:59 INFO - mozversion application_vendor: Mozilla 14:04:59 INFO - mozversion application_version: 50.0a1 14:04:59 INFO - mozversion platform_buildid: 20160720113021 14:04:59 INFO - mozversion platform_changeset: 0cca5d80caa9f04d491c28b388f2f396fd45fe5c 14:04:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:04:59 INFO - mozversion platform_version: 50.0a1 14:04:59 INFO - using testdate: 1469048699 14:04:59 INFO - actual date: 1469048699 14:04:59 INFO - starting webserver on 'localhost:59659' 14:04:59 INFO - SUITE-START | Running 2 tests 14:04:59 INFO - TEST-START | dromaeo_css 14:04:59 INFO - operating with platform_type : linux_ 14:04:59 INFO - Initialising browser for dromaeo_css test... 14:04:59 INFO - TEST-INFO | started process 3862 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGQ7WjP/profile http://localhost:59659/getInfo.html) 14:05:06 INFO - PROCESS | 3862 | __metrics Screen width/height:1600/1200 14:05:06 INFO - PROCESS | 3862 | colorDepth:24 14:05:06 INFO - PROCESS | 3862 | Browser inner width/height: 1024/697 14:05:06 INFO - PROCESS | 3862 | __metrics 14:05:07 ERROR - PROCESS | 3862 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 14:05:08 INFO - TEST-INFO | 3862: exit 0 14:05:08 INFO - Browser initialized. 14:05:08 INFO - Running cycle 1/1 for dromaeo_css test... 14:05:08 INFO - TEST-INFO | started process 3983 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGQ7WjP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:05:19 INFO - PROCESS | 3983 | RSS: Main: 168050688 14:05:19 INFO - PROCESS | 3983 | 14:06:09 INFO - PROCESS | 3983 | 1469048769357 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:08:17 INFO - PROCESS | 3983 | Cycle 1(1): loaded http://localhost:59659/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59659/tests/dromaeo/cssquery-ext.html) 14:08:18 INFO - PROCESS | 3983 | RSS: Main: 173596672 14:08:18 INFO - PROCESS | 3983 | 14:11:20 INFO - PROCESS | 3983 | Cycle 1(1): loaded http://localhost:59659/tests/dromaeo/cssquery-ext.html (next: http://localhost:59659/tests/dromaeo/cssquery-jquery.html) 14:11:21 INFO - PROCESS | 3983 | RSS: Main: 169222144 14:11:21 INFO - PROCESS | 3983 | 14:14:23 INFO - PROCESS | 3983 | Cycle 1(1): loaded http://localhost:59659/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59659/tests/dromaeo/cssquery-mootools.html) 14:14:23 INFO - PROCESS | 3983 | RSS: Main: 173658112 14:14:23 INFO - PROCESS | 3983 | 14:17:25 INFO - PROCESS | 3983 | Cycle 1(1): loaded http://localhost:59659/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59659/tests/dromaeo/cssquery-prototype.html) 14:17:26 INFO - PROCESS | 3983 | RSS: Main: 168042496 14:17:26 INFO - PROCESS | 3983 | 14:20:28 INFO - PROCESS | 3983 | Cycle 1(1): loaded http://localhost:59659/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59659/tests/dromaeo/cssquery-yui.html) 14:20:29 INFO - PROCESS | 3983 | RSS: Main: 169947136 14:20:29 INFO - PROCESS | 3983 | 14:23:32 INFO - PROCESS | 3983 | Cycle 1(1): loaded http://localhost:59659/tests/dromaeo/cssquery-yui.html (next: http://localhost:59659/tests/dromaeo/cssquery-dojo.html) 14:23:32 INFO - PROCESS | 3983 | RSS: Main: 170938368 14:23:32 INFO - PROCESS | 3983 | 14:23:32 INFO - PROCESS | 3983 | __start_tp_report 14:23:32 INFO - PROCESS | 3983 | _x_x_mozilla_page_load 14:23:32 INFO - PROCESS | 3983 | _x_x_mozilla_page_load_details 14:23:32 INFO - PROCESS | 3983 | |i|pagename|runs| 14:23:32 INFO - PROCESS | 3983 | |0;dojo.html;3022.1840103172144;3037.98481007595;3052.6031615889933;3061.173483159547;3061.5866857974165;5287.841364759059;5301.946980530199;5344.064788661984;5380.0046991306535;5391.865203369918;5231.398389185245;5358.624896257264;5404.864878378043;5423.972880135604;5429.294191755076;4834.685745426554;4899.779509922044;4982.57648099912;5037.118504261758;5065.79736810529;4868.415790105192;5055.646104772667;5058.570021548155;5065.062963351773;5078.390593128811;4825.155597770394;4847.903041939177;4855.198892182786;4921.261810728383;4931.580815630676;4943.604511639096;4945.7774400152075;4959.553640172366;4963.106640804654;4985.451600323961;4856.198727210006;4904.509549045102;4909.852704418873;4930.876728081791;4974.054929563371;5141.2545180948555;5298.947010529922;5346.385165705916;5366.329208848894;5473.863153421156;5617.887642247173;5708.457696518824;5757.654540727528;5785.450382213683;5823.883522329572;5793.971030144822;5799.768009279624;5802.187693722883;5807.0998995155815;5822.214001109881;5158.74206289684;5193.480651934777;5256.369235691665;5337.2527846101575;5373.435789242151;5755.366909639936;5762.222100016528;5766.875459285483;5806.564507661942;5818.8254352369495;5518.641288316247;5518.9238098571195;5524.309461317335;5546.057170281062;5550.47270509301;5592.664440133523;5622.943770562242;5662.801801936995;5689.288838895138;5744.971275143597;5507.834764957058;5603.6077474577205;5736.082226843685;5805.187273781674;5821.592488525847;5582;5634.1830434586755;5645.125005624135;5656.462636049569;5687.488126068591;4295.72077814941;4307.5261721210645;4328.653707703376;4344.674149438742;4391.407160033355;3873.3996230584303;3895.4351619015083;3897.337452633059;3930.606939306104;3951.8221680024467;5455.290812194389;5484.341878974548;5488.506034456918;5503.972480137573;5507.366652834975;5669.773209071674;5789.8263052108505;5813.6221145625395;5824.854378640483;5825.242718446575;5423.538999185034;5467.781288748405;5470.152126420411;5490.039243132436;5511.3937466878615;4918.827841025547;4964.230544265644;4965.106280869478;4989.301497790312;5017.89964200714;5760.164776107525;5913.881722365529;5928.7332070056955;5935.73289201987;5967.701614919237;5536.003519366553;5548.91676624851;5625.718714064362;5669.6314739541795;5724.484796368347;5840.386759390203;5841.970790146022;5842.941570584239;5851.502622277154;5858.443447872445;5522.475364840334;5565.16522521625;5580.888382232414;5587.6088673794075;5601;5527.088030475087;5696.829095127153;5698.1737648041635;5743.42565743439;5822.359540450462;5610.158476228598;5648.519875810603;5658.321001479849;5659.151127330933;5663.546916246608;5549.916751248816;5584.385717570983;5614.29821272341;5616.943830561642;5617.4101719320515;5438.809641662523;5498.80754173602;5546.057170281143;5553.583481238842;5574.219609254788;5593.748281327432;5630.971845140748;5658.971705141448;5663.9716801415725;5674.687892165805;5505.091659876236;5505.532029777513;5518.481895742108;5534.335879694462;5541.972290138524 14:23:32 INFO - PROCESS | 3983 | |1;ext.html;554.1196741854636;592.5851903667433;598.8712426828231;609.8963176260035;627.1627377451102;39483.80258098709;43334.34998475025;43338.34992475116;43505;43635.3454698179;43244.78377608107;43862;43865.34201986973;43877.78061109698;43983;8616.181462761027;8772.078931712174;8785.209331160195;8817.16236957488;8830;8824.558772061404;8906.910930890674;8915;8919.464832110061;8919.687810926618;8847.646094156225;8867.201951824334;8891.244244239248;8896.06591307913;8909.73270801877;8855.158759917798;8884.244839188677;8902.554872256394;8910.821783564325;8953.865692014626;8719.60761765722;8744.562771861381;8796.25231855293;8798.912010879872;8806.955965220197;40634.79682601568;40710;40979.180416391806;40994.590054099375;41689;3602.855885764566;3702.37059699849;3736.8878933632036;3752;3850.2299540092095;32679;33364.499532507034;33413.164670883176;33773.83113084443;34732.82633586841;4381.3208952612395;4423.911521769579;4465.441819772528;4564.246899261618;4616;251505;253845;256042;256072;256161;34640.82679586586;35526.28947421089;51859.74070129701;52119.21821172685;52169.73915130476;36167.4574881377;36547;36799.264014719556;36808.263834723155;36970.81514592464;14760.48338308154;14777;14847.2576371181;14897.47858824936;14930.776038359434;13295.933520332337;13410.597682069554;13483.730325393633;13515.729685406433;13529.391177397041;8104.432689711782;8284.668613255402;8314.127016663284;8397.076321604618;8409.789755256168;3239.9146285994457;3250.2524419383203;3257.641659417462;3330.317284956578;3353;994.2245048861755;1055.1347894726405;1058.2486434631344;1072.469127781753;1096.9177311701494;32508.34983300321;33225;33262.50106248408;33308.167295817315;33679.15802104967;1077.2997551591527;1087.722630729159;1168.415792103948;1176.7117056321256;1179.186361410624;16973.321067157423;17251;17336.739948900777;17535.210915508833;17536.298548057934;624644;626042;628162;633021;634383;59102.70448647815;59638.403615964155;59815.40184598098;59821.40178598245;60149;1347.2253454263837;1392.6866455047737;1400.0549629000384;1411.422045115627;1414.1373762005169;30815.53776693396;31399.372012560078;31740.841295793372;32424;32517.512237315987;51386.22920656268;51594.484055158966;51638;51717.7414112927;51721.189758358276;476632;479644;479830;482172;482242;27989.860050699615;28288.43423131567;28355;28594;28779.856100719364;48625.270620940006;49523.50476495333;49679.503204967485;49759.253611195134;49908.500914990385;41437.79281103575;42308.15383692247;42707.3593896098;42813.57186428096;44303.55696442995;41130;41231.381529276485;41719.16561668689;42567;42720;39674.2065158701;40664.39003415011;41451.1709765797;41534;41568.376474353514;33358.66641333653;37611;38169.236615266986;38314;38788.224235514564;28358.29104272327;28542.14373568796;28567;28716;29011.12966611005 14:23:32 INFO - PROCESS | 3983 | |2;jquery.html;366.96146904575016;375.95488541375033;387.12316602894447;394;400.69747340757726;15648.217589120555;17715.82284177158;19292;20221.59556808863;20497.872617006058;16398.426055088075;16684;18356.449306520826;18781.060946952664;18970;5179.766910489027;5217.843464696065;5234.973825130888;5284.550813180885;5312.814051508198;5230.084735171349;5268.657537260085;5272.736363181844;5279.656822306538;5282.577393808505;5483.232347471358;5591.9720401397935;5597.44025597441;5601.887962240753;5620.747066382002;5290.7354632268425;5540.9168862467295;5583.748731307081;5593.049181639131;5611.803586874481;5417.891642167135;5474.972625136849;5487.341519017704;5535.280413546254;5548.667079975174;21338.786612133834;22082.668759968612;22238.88880555603;23210.41973950648;24076.638850417257;2278.8491811635186;2286.16554957441;2315.4211447138214;2317.5133222023396;2368.7631236876173;9876.061774131445;9988.550515226832;10034;10116.89883101167;10179.796404071878;1878.6994080946984;1936.3706795291587;1957.6378370001453;1972.7928567500348;2000.7198992141111;82221;85916;86039.13960860374;86319;90450.09549904482;10882.945585272022;10884.29252098627;11088.112950963903;11088.33469991803;11188.888111118784;12574.748505029847;15411.537653870178;15480.767788483181;15482.612934676723;15497.5350739478;7868.527888326718;7888.723894663659;8064.314533264621;8120.918790812135;8139.593020348959;7718.53688778675;7723.382129429632;7802.843943121105;7909.3277071449575;8213.34293256538;3945.585713500041;4003.499562554681;4122.445746871528;4135.29699951009;4184.5187803403;1876.6715824730618;1974.328728232408;2041.8264447522126;2051.7332746742827;2060.8175473579263;956.4739393333639;968.2157452463528;968.970930872075;998.2164001258977;1070.8072546941469;20023.799762002483;20081.497962551053;20231.595368092556;20317.593648126956;20343.491412714506;1016.339379403379;1031.3554028732042;1038.4703801061362;1056.8626078609732;1069.5614797932965;10476;11162.274452160584;11186.664400068012;11191.888081119085;11234.606788762354;460396;462320;463425;485923;486120;57974;81540.59229703814;94001;96564;98820;983.4492684096786;1016.0804471952895;1017.8066167428314;1022.8005538919988;1024.3751311699857;17205;17242.224099915282;18110.5472363192;18228.908855455637;18340.72488912694;36892.81553592215;43799.34300985424;43829;43960.560394395645;45439;55819.72090139523;56402.05185636966;59163;59937.400625994924;66535;12312.876871231172;12606.936965315115;12872.751991842857;12958.157719748186;12982.285974271506;12332.876671233531;12412.937935310627;12926.289054102115;13420.865791341961;13446.865531344562;7542.585157816373;7648.923510764821;7795.805104872424;8204.138565450541;11481.598144064918;6775.322467753185;7766.378689704697;7950.3639708822;7995.200479951958;8192.918070819454;7338.853222935405;7813.531188128731;7834.529928204098;8010.9599452004695;8159.061707903667;12510.624681259576;12526.561570344995;12962.870371296167;13087.345632718516;13119.672008199872;11629.360385178557;11765.823512647488;11889;11919.82120268214;12316.261024338568 14:23:32 INFO - PROCESS | 3983 | |3;mootools.html;1458.496818597584;1470.62499062739;1591.4907229686498;1748.4089478574492;1776.618027124168;6970.686319115639;7678.462507624468;7728.111267204274;8135.837283254331;8156.632951517181;7751.341136003446;7992.760217193479;7996.840063198732;8023.117457079717;8026.43814932955;2149.527104037113;2170.251263314154;2170.5007848194923;2181.3455963211054;2185.7814218578173;2162.3296777998794;2188.39819049761;2224.277109939268;2227.3429338345145;2231.866088034715;2182.388931099295;2190.1786829938774;2198.318521258415;2204.2725900452892;2214.0922221889027;2139.935801925945;2141.593097311506;2143.0463443767453;2158.57907707997;2162.5782972320403;2125.9255926042515;2166.8266538677026;2168.1435832846096;2178.161407857986;2184.2791878680155;7963.203679631991;7970.163132871023;7978.920210797875;7988.201179881965;8047.597620118971;4684.36761037259;4885.926711099336;4905.583025442842;4955.1080805455;4966.230234313687;3118;3167.7149056585017;3177.9205519861957;3207.1135977620097;3217.8391080445886;1044.1646682653848;1084.8643919510062;1095.6001059613263;1114.8160553508742;1132.5356603792488;10684.358938463716;10730.980556847087;10754.784904301949;10784.191185661186;10819.945900270526;4086.8160932758096;4343.630791382768;4355.3684715716045;4368.672349573794;4372.912541749147;9297.72106836796;9315.72052838416;9345.719628411158;9371.671991480265;9408.576614052385;4971.676841005323;4973.378327709036;4984.40187177541;4992.650514464025;5001.799928002912;3952.4980507407;4386.4736231652405;4397.120575884772;4553.2942393929;4565.931511027337;3530.3645343838357;3561.415170249214;3658.5243918290453;3703.203811180609;3744.7753134811455;1161.866385365677;1165.906727461801;1167.1246565076192;1176.8352430659716;1198.1972078707113;970.2092794372705;971.5482300730195;975.5609975511048;984.8571957066329;1009.5204777730667;5461.808836690697;5496.230527726121;5634.774609015593;5651.208830763697;5694;973.3916302311055;980.7989362180735;981.4847205217176;994.1400688404478;1009.0111690543162;3885.1646895916947;4007.779572123561;4008.4588580541254;4030.5364883038824;4055.945454181934;9020.503872286956;9346.48594327305;9358.953205234066;9374.67188648394;9416.387934784218;8780.341474389446;9082.137196966278;9199.724008279762;9432.952835235918;9443.197328227041;6957.304269573104;7088.751893683696;7200.099987501562;7217.566945983258;7290.125184977836;5269.578433725216;5488.368837583729;5549.722513874371;5566.471185237396;5669.092945128759;8754.824903502022;8888.511131887808;8894.243989260985;8929.419587726778;8954.059823718677;8735.908011498563;8880.73357799267;8890;8925.910740892508;8980.910190898006;6280.842978925563;6599.274079851117;6646.634435106115;6755.695993680394;7034;7796.376289896682;7816.84366312682;7818.569978651229;7851.607419628882;7862.842743145219;6932.549384290005;6990.930090699231;7055.788326350218;7061.046758687511;7097.716091356495;6758.628275444898;6785.2536221016635;6799.796006119825;6865.965670171817;7023.859522809617;6609.3060228675295;6613.900791488035;6635.834104147435;6662.067310576426;6663.600183988976;4663.556962088596;4689.953100469088;4732.97633511844;4770.117528257283;4813.774587748017;4804.567588917014;4863.392075990501;4879.194932836042;4930.63329601786;5053.974730126326 14:23:32 INFO - PROCESS | 3983 | |4;prototype.html;300.1281277887736;304.8612881139081;305.3328477277151;307.96612372639004;308.3309218994781;5647.774089036438;5715.685637289953;5733.283339582557;5753.108268218422;5771.826845194641;5476.726163691809;5520.889582208353;5620.156976453534;5656.133475952936;5662.810809729962;4174.248635245654;4203.4115223868685;4277.4867015958125;4343;4358.5423530529315;4329.761863097544;4343.522212556616;4344.674149438789;4347.261095561785;4347.500037495697;4328.891777705551;4345.913081738363;4353.28170851809;4368.301071828508;4375.934360984587;4249.893752656178;4265.680073994447;4298;4318.611324980736;4327.134573085364;3800.37293846515;3813;3815.351390263634;3819.2934307152987;3823.9101855971194;5483.341998960111;5486.945130548684;5522;5522.889542209174;5526.734039043973;4887.437944636376;4927.753612319406;4927.753612319406;4981.402231732179;4993.275974983643;5763.740631671585;5783.248177736909;5789.392113828029;5889;5893.44012318829;4137.77242251676;4170.082581831992;4171.874843754692;4174.3321068629175;4175.979120104411;5767.192593036978;6058.606190597597;6061.666433384692;6066.75732970685;6119.418655227746;4161.875143745632;4168.791560421967;4169.81084930414;4172.7913604319665;4188.643965262987;4241.257779888507;4246.660267178619;4248.723832950848;4259.7231179973205;4264.637505811978;4779.02030083832;4896.290037944549;4904.283500774772;4918.9178380756175;4929.457759646436;5842.649441033466;5856.560757943172;5884.440978107073;5908.20239267702;5963.910541341883;1436.2244388030556;1464.9598784862867;1473.9336729846968;1474.3144437836243;1483.807105076333;919;931.8602209668468;932.8927173375013;938.8452203789377;941.5904081724472;4972.65191436596;5006.923511444984;5041.6470847040355;5086.18621020635;5108.208227724708;5341.278927344836;5375.892482150335;5383.892322153535;5389.790186023712;5454.59090568209;4760.285957106462;5016.473270306566;5041.269015992661;5051.494850514919;5058.367704036996;2838.4748821468093;2859.6997315281596;2866.4123854609757;2872.928176795555;2876.554134109216;5436.532136323171;5473.044555939828;5483.862903427446;5512.889742205133;5522.751476183501;5231.816886409034;5451.383335998743;5455.380957613665;5495.725213739377;5501.559875210054;5535.252740880011;5543.780368318963;5555.833325000256;5573.804916827891;5618.85952851182;5068.22612085767;5267.024865675372;5317.893642127058;5385.569154467555;5477.603211181124;5269.973650131725;5297.841064768063;5304.469553044664;5319.627626066138;5380.542653874464;5377;5427.511523962862;5542.8337149885565;5549.472800084147;5586.720663966704;3839.1937693084765;3880.320943834874;3907.866718651559;3908.355121404936;4195.888089656304;5756.481916627524;5992.580519363602;5993.190919225849;6022.04283607838;6129.724162412613;5718.255931940798;5912.556558258062;5925.288965324189;5942.732577033958;5955.791547295824;5826.82519524415;5897.764089436546;5933.703314834154;5966.582339236212;5979.940200597938;5697;5811.186433899173;5828.329742079545;5852.882942341044;5917.0828521577505;5921.378255283305;6002.849928751816;6030.4572588467245;6037.486813620892;6055.757769689163;5745.454181852718;5828.912566311594;5837.766489340549;5864.648121112747;5869.73586188614 14:23:32 INFO - PROCESS | 3983 | |5;yui.html;758.4842307231088;760.1258552664433;781.6521647866698;782.9295363417291;805.569020573993;15348.53954381369;16787.91606041971;16803.0758308293;16828.74756878648;16842.66314673707;15191.54425367238;15340;15359;15512.922435387836;15517.53447396577;794.1423262876094;808.2281421242728;816.7835523586255;818.292177266663;818.5088946632033;659.4724220623506;774.1832366852968;807.7859367267679;807.8828569857367;808.030363563723;838.3000194837318;844.4975239732349;851.7998270406449;852.8166444214493;854.5727136431784;849.7663142635763;853.3301358433631;854.2525290370926;856.1010938514535;858.8282343531318;629.937006299371;629.9905501417483;631.1321932343028;631.1668597451365;632.3139393757732;15937.442189523312;15941.963772354877;15959.361625534964;15997.120158391284;16038;16031.19844007795;16117.838821611751;16181.83818161815;16279.104649244287;16345;12538.498460061586;12562.685932851751;12646.21815624201;12769;12879.613611591574;3975.0857302820223;3984;3992.281389349916;3997.7401468904427;4151.5640857709805;85134;85854;86465;87845.99999999936;89187;12280.938595306967;12328.630141095602;12350.258984460961;12411;13081.476740930446;23860.64209036866;24003.63994540083;24061;24088.759112409003;24112;8772.626624698389;8781.121887811169;8981.46111233315;9130.543472826332;9513.952430237943;4817;4841.8547443576745;4919.06537757832;4926.408830940239;5053.1157047516535;3522.154682876091;3590.5152804371596;3599.0282623691455;3634.636536346397;3636.090977255686;609.8780243951228;618.3414663383483;619.8357435279654;621.6052806467925;633.2021652717609;652.4444356306058;676.4182802789597;731.7585196885121;749.7375918428506;768.3545821509958;9153.542322883963;9770;9867.555959981819;10039.297249192487;10274.743131421774;630.5334052800895;639.8560323927079;677.5866721300004;701.7789396340137;726.23019599225;4693.55411235932;4949.430815456197;4998;5003.874903127378;5017.297578339036;95635;97345;100285.49857250667;114083;131730;65504.67247663827;93611;97461.51269243608;98121.01878981262;98994;55602.721986389806;86159.13840861636;87839.56080219558;90078;91006.08993910109;9678.903210967801;9695.175910047725;9713.174380177765;9749.853752193865;9863.21094312439;48770.51229487802;48997.75501122472;49586.25620615766;50326;51020;68636.31363686499;68811.65594171998;71674;73605.26394735984;74186;13299.534516291884;13359.666008349868;13651.658708532366;13843.377048033064;14298.356573954405;15423.151726655142;15656.13891235993;15763.369465221263;15916.363345466514;16595.004299742053;13451.260180690157;13668.65828354299;13909.652258693613;13949.232792196526;14063.718725625635;13114.770394596278;13179.934100329438;13378.13042152296;13618.319084045559;13754.518591849237;13027.934860325639;13310.201387916755;13549.458021679417;13587.388567514683;13859;11009.394483303495;11281.605143819927;11827.82258266144;11891.405429728651;12019.278843269432;9622.711318660451;10487;10709.946450267698;11572.884271157182;11728.530858765555 14:23:32 INFO - PROCESS | 3983 | __end_tp_report 14:23:32 INFO - PROCESS | 3983 | __start_cc_report 14:23:32 INFO - PROCESS | 3983 | _x_x_mozilla_cycle_collect,358 14:23:32 INFO - PROCESS | 3983 | __end_cc_report 14:23:32 INFO - PROCESS | 3983 | __startTimestamp1469049812292__endTimestamp 14:23:32 INFO - PROCESS | 3983 | 14:23:32 INFO - PROCESS | 3983 | ------- Summary: start ------- 14:23:32 INFO - PROCESS | 3983 | Number of tests: 6 14:23:32 INFO - PROCESS | 3983 | 14:23:32 INFO - PROCESS | 3983 | [#0] dojo.html Cycles:165 Average:5317.37 Median:5518.92 stddev:595.71 (10.8%) stddev-sans-first:569.68 14:23:32 INFO - PROCESS | 3983 | Values: 3022.2 3038.0 3052.6 3061.2 3061.6 5287.8 5301.9 5344.1 5380.0 5391.9 5231.4 5358.6 5404.9 5424.0 5429.3 4834.7 4899.8 4982.6 5037.1 5065.8 4868.4 5055.6 5058.6 5065.1 5078.4 4825.2 4847.9 4855.2 4921.3 4931.6 4943.6 4945.8 4959.6 4963.1 4985.5 4856.2 4904.5 4909.9 4930.9 4974.1 5141.3 5298.9 5346.4 5366.3 5473.9 5617.9 5708.5 5757.7 5785.5 5823.9 5794.0 5799.8 5802.2 5807.1 5822.2 5158.7 5193.5 5256.4 5337.3 5373.4 5755.4 5762.2 5766.9 5806.6 5818.8 5518.6 5518.9 5524.3 5546.1 5550.5 5592.7 5622.9 5662.8 5689.3 5745.0 5507.8 5603.6 5736.1 5805.2 5821.6 5582.0 5634.2 5645.1 5656.5 5687.5 4295.7 4307.5 4328.7 4344.7 4391.4 3873.4 3895.4 3897.3 3930.6 3951.8 5455.3 5484.3 5488.5 5504.0 5507.4 5669.8 5789.8 5813.6 5824.9 5825.2 5423.5 5467.8 5470.2 5490.0 5511.4 4918.8 4964.2 4965.1 4989.3 5017.9 5760.2 5913.9 5928.7 5935.7 5967.7 5536.0 5548.9 5625.7 5669.6 5724.5 5840.4 5842.0 5842.9 5851.5 5858.4 5522.5 5565.2 5580.9 5587.6 5601.0 5527.1 5696.8 5698.2 5743.4 5822.4 5610.2 5648.5 5658.3 5659.2 5663.5 5549.9 5584.4 5614.3 5616.9 5617.4 5438.8 5498.8 5546.1 5553.6 5574.2 5593.7 5631.0 5659.0 5664.0 5674.7 5505.1 5505.5 5518.5 5534.3 5542.0 14:23:32 INFO - PROCESS | 3983 | 14:23:32 INFO - PROCESS | 3983 | [#1] ext.html Cycles:180 Average:60180.35 Median:41444.48 stddev:128514.55 (310.1%) stddev-sans-first:128797.09 14:23:32 INFO - PROCESS | 3983 | Values: 554.1 592.6 598.9 609.9 627.2 39483.8 43334.3 43338.3 43505.0 43635.3 43244.8 43862.0 43865.3 43877.8 43983.0 8616.2 8772.1 8785.2 8817.2 8830.0 8824.6 8906.9 8915.0 8919.5 8919.7 8847.6 8867.2 8891.2 8896.1 8909.7 8855.2 8884.2 8902.6 8910.8 8953.9 8719.6 8744.6 8796.3 8798.9 8807.0 40634.8 40710.0 40979.2 40994.6 41689.0 3602.9 3702.4 3736.9 3752.0 3850.2 32679.0 33364.5 33413.2 33773.8 34732.8 4381.3 4423.9 4465.4 4564.2 4616.0 251505.0 253845.0 256042.0 256072.0 256161.0 34640.8 35526.3 51859.7 52119.2 52169.7 36167.5 36547.0 36799.3 36808.3 36970.8 14760.5 14777.0 14847.3 14897.5 14930.8 13295.9 13410.6 13483.7 13515.7 13529.4 8104.4 8284.7 8314.1 8397.1 8409.8 3239.9 3250.3 3257.6 3330.3 3353.0 994.2 1055.1 1058.2 1072.5 1096.9 32508.3 33225.0 33262.5 33308.2 33679.2 1077.3 1087.7 1168.4 1176.7 1179.2 16973.3 17251.0 17336.7 17535.2 17536.3 624644.0 626042.0 628162.0 633021.0 634383.0 59102.7 59638.4 59815.4 59821.4 60149.0 1347.2 1392.7 1400.1 1411.4 1414.1 30815.5 31399.4 31740.8 32424.0 32517.5 51386.2 51594.5 51638.0 51717.7 51721.2 476632.0 479644.0 479830.0 482172.0 482242.0 27989.9 28288.4 28355.0 28594.0 28779.9 48625.3 49523.5 49679.5 49759.3 49908.5 41437.8 42308.2 42707.4 42813.6 44303.6 41130.0 41231.4 41719.2 42567.0 42720.0 39674.2 40664.4 41451.2 41534.0 41568.4 33358.7 37611.0 38169.2 38314.0 38788.2 28358.3 28542.1 28567.0 28716.0 29011.1 14:23:32 INFO - PROCESS | 3983 | 14:23:32 INFO - PROCESS | 3983 | [#2] jquery.html Cycles:180 Average:28371.38 Median:18634.39 stddev:77970.64 (418.4%) stddev-sans-first:78161.01 14:23:32 INFO - PROCESS | 3983 | Values: 367.0 376.0 387.1 394.0 400.7 15648.2 17715.8 19292.0 20221.6 20497.9 16398.4 16684.0 18356.4 18781.1 18970.0 5179.8 5217.8 5235.0 5284.6 5312.8 5230.1 5268.7 5272.7 5279.7 5282.6 5483.2 5592.0 5597.4 5601.9 5620.7 5290.7 5540.9 5583.7 5593.0 5611.8 5417.9 5475.0 5487.3 5535.3 5548.7 21338.8 22082.7 22238.9 23210.4 24076.6 2278.8 2286.2 2315.4 2317.5 2368.8 9876.1 9988.6 10034.0 10116.9 10179.8 1878.7 1936.4 1957.6 1972.8 2000.7 82221.0 85916.0 86039.1 86319.0 90450.1 10882.9 10884.3 11088.1 11088.3 11188.9 12574.7 15411.5 15480.8 15482.6 15497.5 7868.5 7888.7 8064.3 8120.9 8139.6 7718.5 7723.4 7802.8 7909.3 8213.3 3945.6 4003.5 4122.4 4135.3 4184.5 1876.7 1974.3 2041.8 2051.7 2060.8 956.5 968.2 969.0 998.2 1070.8 20023.8 20081.5 20231.6 20317.6 20343.5 1016.3 1031.4 1038.5 1056.9 1069.6 10476.0 11162.3 11186.7 11191.9 11234.6 460396.0 462320.0 463425.0 485923.0 486120.0 57974.0 81540.6 94001.0 96564.0 98820.0 983.4 1016.1 1017.8 1022.8 1024.4 17205.0 17242.2 18110.5 18228.9 18340.7 36892.8 43799.3 43829.0 43960.6 45439.0 55819.7 56402.1 59163.0 59937.4 66535.0 12312.9 12606.9 12872.8 12958.2 12982.3 12332.9 12412.9 12926.3 13420.9 13446.9 7542.6 7648.9 7795.8 8204.1 11481.6 6775.3 7766.4 7950.4 7995.2 8192.9 7338.9 7813.5 7834.5 8011.0 8159.1 12510.6 12526.6 12962.9 13087.3 13119.7 11629.4 11765.8 11889.0 11919.8 12316.3 14:23:32 INFO - PROCESS | 3983 | 14:23:32 INFO - PROCESS | 3983 | [#3] mootools.html Cycles:180 Average:5250.75 Median:5027.89 stddev:2838.58 (56.5%) stddev-sans-first:2832.24 14:23:32 INFO - PROCESS | 3983 | Values: 1458.5 1470.6 1591.5 1748.4 1776.6 6970.7 7678.5 7728.1 8135.8 8156.6 7751.3 7992.8 7996.8 8023.1 8026.4 2149.5 2170.3 2170.5 2181.3 2185.8 2162.3 2188.4 2224.3 2227.3 2231.9 2182.4 2190.2 2198.3 2204.3 2214.1 2139.9 2141.6 2143.0 2158.6 2162.6 2125.9 2166.8 2168.1 2178.2 2184.3 7963.2 7970.2 7978.9 7988.2 8047.6 4684.4 4885.9 4905.6 4955.1 4966.2 3118.0 3167.7 3177.9 3207.1 3217.8 1044.2 1084.9 1095.6 1114.8 1132.5 10684.4 10731.0 10754.8 10784.2 10819.9 4086.8 4343.6 4355.4 4368.7 4372.9 9297.7 9315.7 9345.7 9371.7 9408.6 4971.7 4973.4 4984.4 4992.7 5001.8 3952.5 4386.5 4397.1 4553.3 4565.9 3530.4 3561.4 3658.5 3703.2 3744.8 1161.9 1165.9 1167.1 1176.8 1198.2 970.2 971.5 975.6 984.9 1009.5 5461.8 5496.2 5634.8 5651.2 5694.0 973.4 980.8 981.5 994.1 1009.0 3885.2 4007.8 4008.5 4030.5 4055.9 9020.5 9346.5 9359.0 9374.7 9416.4 8780.3 9082.1 9199.7 9433.0 9443.2 6957.3 7088.8 7200.1 7217.6 7290.1 5269.6 5488.4 5549.7 5566.5 5669.1 8754.8 8888.5 8894.2 8929.4 8954.1 8735.9 8880.7 8890.0 8925.9 8980.9 6280.8 6599.3 6646.6 6755.7 7034.0 7796.4 7816.8 7818.6 7851.6 7862.8 6932.5 6990.9 7055.8 7061.0 7097.7 6758.6 6785.3 6799.8 6866.0 7023.9 6609.3 6613.9 6635.8 6662.1 6663.6 4663.6 4690.0 4733.0 4770.1 4813.8 4804.6 4863.4 4879.2 4930.6 5054.0 14:23:32 INFO - PROCESS | 3983 | 14:23:32 INFO - PROCESS | 3983 | [#4] prototype.html Cycles:180 Average:4750.54 Median:5378.77 stddev:1396.68 (26.0%) stddev-sans-first:1360.06 14:23:32 INFO - PROCESS | 3983 | Values: 300.1 304.9 305.3 308.0 308.3 5647.8 5715.7 5733.3 5753.1 5771.8 5476.7 5520.9 5620.2 5656.1 5662.8 4174.2 4203.4 4277.5 4343.0 4358.5 4329.8 4343.5 4344.7 4347.3 4347.5 4328.9 4345.9 4353.3 4368.3 4375.9 4249.9 4265.7 4298.0 4318.6 4327.1 3800.4 3813.0 3815.4 3819.3 3823.9 5483.3 5486.9 5522.0 5522.9 5526.7 4887.4 4927.8 4927.8 4981.4 4993.3 5763.7 5783.2 5789.4 5889.0 5893.4 4137.8 4170.1 4171.9 4174.3 4176.0 5767.2 6058.6 6061.7 6066.8 6119.4 4161.9 4168.8 4169.8 4172.8 4188.6 4241.3 4246.7 4248.7 4259.7 4264.6 4779.0 4896.3 4904.3 4918.9 4929.5 5842.6 5856.6 5884.4 5908.2 5963.9 1436.2 1465.0 1473.9 1474.3 1483.8 919.0 931.9 932.9 938.8 941.6 4972.7 5006.9 5041.6 5086.2 5108.2 5341.3 5375.9 5383.9 5389.8 5454.6 4760.3 5016.5 5041.3 5051.5 5058.4 2838.5 2859.7 2866.4 2872.9 2876.6 5436.5 5473.0 5483.9 5512.9 5522.8 5231.8 5451.4 5455.4 5495.7 5501.6 5535.3 5543.8 5555.8 5573.8 5618.9 5068.2 5267.0 5317.9 5385.6 5477.6 5270.0 5297.8 5304.5 5319.6 5380.5 5377.0 5427.5 5542.8 5549.5 5586.7 3839.2 3880.3 3907.9 3908.4 4195.9 5756.5 5992.6 5993.2 6022.0 6129.7 5718.3 5912.6 5925.3 5942.7 5955.8 5826.8 5897.8 5933.7 5966.6 5979.9 5697.0 5811.2 5828.3 5852.9 5917.1 5921.4 6002.8 6030.5 6037.5 6055.8 5745.5 5828.9 5837.8 5864.6 5869.7 14:23:32 INFO - PROCESS | 3983 | 14:23:32 INFO - PROCESS | 3983 | [#5] yui.html Cycles:180 Average:20761.59 Median:4937.92 stddev:29074.98 (588.8%) stddev-sans-first:29117.74 14:23:32 INFO - PROCESS | 3983 | Values: 758.5 760.1 781.7 782.9 805.6 15348.5 16787.9 16803.1 16828.7 16842.7 15191.5 15340.0 15359.0 15512.9 15517.5 794.1 808.2 816.8 818.3 818.5 659.5 774.2 807.8 807.9 808.0 838.3 844.5 851.8 852.8 854.6 849.8 853.3 854.3 856.1 858.8 629.9 630.0 631.1 631.2 632.3 15937.4 15942.0 15959.4 15997.1 16038.0 16031.2 16117.8 16181.8 16279.1 16345.0 12538.5 12562.7 12646.2 12769.0 12879.6 3975.1 3984.0 3992.3 3997.7 4151.6 85134.0 85854.0 86465.0 87846.0 89187.0 12280.9 12328.6 12350.3 12411.0 13081.5 23860.6 24003.6 24061.0 24088.8 24112.0 8772.6 8781.1 8981.5 9130.5 9514.0 4817.0 4841.9 4919.1 4926.4 5053.1 3522.2 3590.5 3599.0 3634.6 3636.1 609.9 618.3 619.8 621.6 633.2 652.4 676.4 731.8 749.7 768.4 9153.5 9770.0 9867.6 10039.3 10274.7 630.5 639.9 677.6 701.8 726.2 4693.6 4949.4 4998.0 5003.9 5017.3 95635.0 97345.0 100285.5 114083.0 131730.0 65504.7 93611.0 97461.5 98121.0 98994.0 55602.7 86159.1 87839.6 90078.0 91006.1 9678.9 9695.2 9713.2 9749.9 9863.2 48770.5 48997.8 49586.3 50326.0 51020.0 68636.3 68811.7 71674.0 73605.3 74186.0 13299.5 13359.7 13651.7 13843.4 14298.4 15423.2 15656.1 15763.4 15916.4 16595.0 13451.3 13668.7 13909.7 13949.2 14063.7 13114.8 13179.9 13378.1 13618.3 13754.5 13027.9 13310.2 13549.5 13587.4 13859.0 11009.4 11281.6 11827.8 11891.4 12019.3 9622.7 10487.0 10709.9 11572.9 11728.5 14:23:32 INFO - PROCESS | 3983 | -------- Summary: end -------- 14:23:32 INFO - PROCESS | 3983 | 14:23:32 INFO - TEST-INFO | 3983: exit 0 14:23:32 INFO - TEST-OK | dromaeo_css | took 1113770ms 14:23:32 INFO - TEST-START | kraken 14:23:32 INFO - operating with platform_type : linux_ 14:23:32 INFO - Initialising browser for kraken test... 14:23:33 INFO - TEST-INFO | started process 4230 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkVyuSU/profile http://localhost:59659/getInfo.html) 14:23:38 INFO - PROCESS | 4230 | __metrics Screen width/height:1600/1200 14:23:38 INFO - PROCESS | 4230 | colorDepth:24 14:23:38 INFO - PROCESS | 4230 | Browser inner width/height: 1024/697 14:23:38 INFO - PROCESS | 4230 | __metrics 14:23:38 ERROR - PROCESS | 4230 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 14:23:39 INFO - TEST-INFO | 4230: exit 0 14:23:39 INFO - Browser initialized. 14:23:39 INFO - Running cycle 1/1 for kraken test... 14:23:39 INFO - TEST-INFO | started process 4349 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkVyuSU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:23:51 INFO - PROCESS | 4349 | RSS: Main: 167301120 14:23:51 INFO - PROCESS | 4349 | 14:23:54 INFO - PROCESS | 4349 | Cycle 1(1): loaded http://localhost:59659/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59659/tests/kraken/driver.html?testName=audio-beat-detection) 14:23:55 INFO - PROCESS | 4349 | RSS: Main: 173125632 14:23:55 INFO - PROCESS | 4349 | 14:23:57 INFO - PROCESS | 4349 | Cycle 1(1): loaded http://localhost:59659/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59659/tests/kraken/driver.html?testName=audio-dft) 14:23:58 INFO - PROCESS | 4349 | RSS: Main: 171880448 14:23:58 INFO - PROCESS | 4349 | 14:24:01 INFO - PROCESS | 4349 | Cycle 1(1): loaded http://localhost:59659/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59659/tests/kraken/driver.html?testName=audio-fft) 14:24:01 INFO - PROCESS | 4349 | RSS: Main: 167817216 14:24:01 INFO - PROCESS | 4349 | 14:24:04 INFO - PROCESS | 4349 | Cycle 1(1): loaded http://localhost:59659/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59659/tests/kraken/driver.html?testName=audio-oscillator) 14:24:04 INFO - PROCESS | 4349 | RSS: Main: 169062400 14:24:04 INFO - PROCESS | 4349 | 14:24:07 INFO - PROCESS | 4349 | Cycle 1(1): loaded http://localhost:59659/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59659/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:24:07 INFO - PROCESS | 4349 | RSS: Main: 169422848 14:24:07 INFO - PROCESS | 4349 | 14:24:10 INFO - PROCESS | 4349 | Cycle 1(1): loaded http://localhost:59659/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59659/tests/kraken/driver.html?testName=imaging-darkroom) 14:24:11 INFO - PROCESS | 4349 | RSS: Main: 170110976 14:24:11 INFO - PROCESS | 4349 | 14:24:14 INFO - PROCESS | 4349 | Cycle 1(1): loaded http://localhost:59659/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59659/tests/kraken/driver.html?testName=imaging-desaturate) 14:24:15 INFO - PROCESS | 4349 | RSS: Main: 166981632 14:24:15 INFO - PROCESS | 4349 | 14:24:18 INFO - PROCESS | 4349 | Cycle 1(1): loaded http://localhost:59659/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59659/tests/kraken/driver.html?testName=json-parse-financial) 14:24:19 INFO - PROCESS | 4349 | RSS: Main: 169066496 14:24:19 INFO - PROCESS | 4349 | 14:24:20 INFO - PROCESS | 4349 | Cycle 1(1): loaded http://localhost:59659/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59659/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:24:21 INFO - PROCESS | 4349 | RSS: Main: 169164800 14:24:21 INFO - PROCESS | 4349 | 14:24:23 INFO - PROCESS | 4349 | Cycle 1(1): loaded http://localhost:59659/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59659/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:24:23 INFO - PROCESS | 4349 | RSS: Main: 169472000 14:24:23 INFO - PROCESS | 4349 | 14:24:25 INFO - PROCESS | 4349 | Cycle 1(1): loaded http://localhost:59659/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59659/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:24:26 INFO - PROCESS | 4349 | RSS: Main: 170164224 14:24:26 INFO - PROCESS | 4349 | 14:24:29 INFO - PROCESS | 4349 | Cycle 1(1): loaded http://localhost:59659/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59659/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:24:29 INFO - PROCESS | 4349 | RSS: Main: 170139648 14:24:29 INFO - PROCESS | 4349 | 14:24:32 INFO - PROCESS | 4349 | Cycle 1(1): loaded http://localhost:59659/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59659/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:24:33 INFO - PROCESS | 4349 | RSS: Main: 169861120 14:24:33 INFO - PROCESS | 4349 | 14:24:34 INFO - PROCESS | 4349 | Cycle 1(1): loaded http://localhost:59659/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59659/tests/kraken/driver.html?testName=ai-astar) 14:24:35 INFO - PROCESS | 4349 | RSS: Main: 170299392 14:24:35 INFO - PROCESS | 4349 | 14:24:35 INFO - PROCESS | 4349 | __start_tp_report 14:24:35 INFO - PROCESS | 4349 | _x_x_mozilla_page_load 14:24:35 INFO - PROCESS | 4349 | _x_x_mozilla_page_load_details 14:24:35 INFO - PROCESS | 4349 | |i|pagename|runs| 14:24:35 INFO - PROCESS | 4349 | |0;ai-astar;107;113;106;113;113;114;115;112;112;113 14:24:35 INFO - PROCESS | 4349 | |1;audio-beat-detection;150;121;149;180;119;154;154;120;186;122 14:24:35 INFO - PROCESS | 4349 | |2;audio-dft;162;163;164;164;164;166;171;163;163;167 14:24:35 INFO - PROCESS | 4349 | |3;audio-fft;76;74;75;150;77;75;76;75;175;77 14:24:35 INFO - PROCESS | 4349 | |4;audio-oscillator;84;86;156;86;84;85;144;85;86;135 14:24:35 INFO - PROCESS | 4349 | |5;imaging-gaussian-blur;117;117;118;118;117;118;121;119;117;118 14:24:35 INFO - PROCESS | 4349 | |6;imaging-darkroom;149;147;147;147;148;150;146;148;147;148 14:24:35 INFO - PROCESS | 4349 | |7;imaging-desaturate;95;96;96;96;97;96;96;97;96;95 14:24:35 INFO - PROCESS | 4349 | |8;json-parse-financial;53;54;54;53;54;52;54;61;51;52 14:24:35 INFO - PROCESS | 4349 | |9;json-stringify-tinderbox;64;65;64;63;64;64;64;64;64;64 14:24:35 INFO - PROCESS | 4349 | |10;stanford-crypto-aes;77;79;78;77;77;77;77;77;82;82 14:24:35 INFO - PROCESS | 4349 | |11;stanford-crypto-ccm;124;130;132;131;138;134;137;132;169;129 14:24:35 INFO - PROCESS | 4349 | |12;stanford-crypto-pbkdf2;159;160;165;172;166;157;158;158;160;164 14:24:35 INFO - PROCESS | 4349 | |13;stanford-crypto-sha256-iterative;76;67;65;64;65;70;69;66;67;64 14:24:35 INFO - PROCESS | 4349 | __end_tp_report 14:24:35 INFO - PROCESS | 4349 | __start_cc_report 14:24:35 INFO - PROCESS | 4349 | _x_x_mozilla_cycle_collect,902 14:24:35 INFO - PROCESS | 4349 | __end_cc_report 14:24:35 INFO - PROCESS | 4349 | __startTimestamp1469049875166__endTimestamp 14:24:35 INFO - PROCESS | 4349 | 14:24:35 INFO - PROCESS | 4349 | ------- Summary: start ------- 14:24:35 INFO - PROCESS | 4349 | Number of tests: 14 14:24:35 INFO - PROCESS | 4349 | 14:24:35 INFO - PROCESS | 4349 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:2.94 (2.6%) stddev-sans-first:2.55 14:24:35 INFO - PROCESS | 4349 | Values: 107.0 113.0 106.0 113.0 113.0 114.0 115.0 112.0 112.0 113.0 14:24:35 INFO - PROCESS | 4349 | 14:24:35 INFO - PROCESS | 4349 | [#1] audio-beat-detection Cycles:10 Average:145.50 Median:152.00 stddev:24.75 (16.3%) stddev-sans-first:26.20 14:24:35 INFO - PROCESS | 4349 | Values: 150.0 121.0 149.0 180.0 119.0 154.0 154.0 120.0 186.0 122.0 14:24:35 INFO - PROCESS | 4349 | 14:24:35 INFO - PROCESS | 4349 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.00 stddev:2.67 (1.6%) stddev-sans-first:2.65 14:24:35 INFO - PROCESS | 4349 | Values: 162.0 163.0 164.0 164.0 164.0 166.0 171.0 163.0 163.0 167.0 14:24:35 INFO - PROCESS | 4349 | 14:24:35 INFO - PROCESS | 4349 | [#3] audio-fft Cycles:10 Average:93.00 Median:75.50 stddev:37.11 (49.2%) stddev-sans-first:38.85 14:24:35 INFO - PROCESS | 4349 | Values: 76.0 74.0 75.0 150.0 77.0 75.0 76.0 75.0 175.0 77.0 14:24:35 INFO - PROCESS | 4349 | 14:24:35 INFO - PROCESS | 4349 | [#4] audio-oscillator Cycles:10 Average:103.10 Median:85.00 stddev:29.35 (34.5%) stddev-sans-first:30.30 14:24:35 INFO - PROCESS | 4349 | Values: 84.0 86.0 156.0 86.0 84.0 85.0 144.0 85.0 86.0 135.0 14:24:35 INFO - PROCESS | 4349 | 14:24:35 INFO - PROCESS | 4349 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:1.25 (1.1%) stddev-sans-first:1.27 14:24:35 INFO - PROCESS | 4349 | Values: 117.0 117.0 118.0 118.0 117.0 118.0 121.0 119.0 117.0 118.0 14:24:35 INFO - PROCESS | 4349 | 14:24:35 INFO - PROCESS | 4349 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:1.16 (0.8%) stddev-sans-first:1.13 14:24:35 INFO - PROCESS | 4349 | Values: 149.0 147.0 147.0 147.0 148.0 150.0 146.0 148.0 147.0 148.0 14:24:35 INFO - PROCESS | 4349 | 14:24:35 INFO - PROCESS | 4349 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 14:24:35 INFO - PROCESS | 4349 | Values: 95.0 96.0 96.0 96.0 97.0 96.0 96.0 97.0 96.0 95.0 14:24:35 INFO - PROCESS | 4349 | 14:24:35 INFO - PROCESS | 4349 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:2.74 (5.1%) stddev-sans-first:2.89 14:24:35 INFO - PROCESS | 4349 | Values: 53.0 54.0 54.0 53.0 54.0 52.0 54.0 61.0 51.0 52.0 14:24:35 INFO - PROCESS | 4349 | 14:24:35 INFO - PROCESS | 4349 | [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 14:24:35 INFO - PROCESS | 4349 | Values: 64.0 65.0 64.0 63.0 64.0 64.0 64.0 64.0 64.0 64.0 14:24:35 INFO - PROCESS | 4349 | 14:24:35 INFO - PROCESS | 4349 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:77.50 stddev:2.06 (2.7%) stddev-sans-first:2.13 14:24:35 INFO - PROCESS | 4349 | Values: 77.0 79.0 78.0 77.0 77.0 77.0 77.0 77.0 82.0 82.0 14:24:35 INFO - PROCESS | 4349 | 14:24:35 INFO - PROCESS | 4349 | [#11] stanford-crypto-ccm Cycles:10 Average:135.60 Median:133.00 stddev:12.39 (9.3%) stddev-sans-first:12.41 14:24:35 INFO - PROCESS | 4349 | Values: 124.0 130.0 132.0 131.0 138.0 134.0 137.0 132.0 169.0 129.0 14:24:35 INFO - PROCESS | 4349 | 14:24:35 INFO - PROCESS | 4349 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.90 Median:162.00 stddev:4.75 (2.9%) stddev-sans-first:4.92 14:24:35 INFO - PROCESS | 4349 | Values: 159.0 160.0 165.0 172.0 166.0 157.0 158.0 158.0 160.0 164.0 14:24:35 INFO - PROCESS | 4349 | 14:24:35 INFO - PROCESS | 4349 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:3.65 (5.5%) stddev-sans-first:2.12 14:24:35 INFO - PROCESS | 4349 | Values: 76.0 67.0 65.0 64.0 65.0 70.0 69.0 66.0 67.0 64.0 14:24:35 INFO - PROCESS | 4349 | -------- Summary: end -------- 14:24:35 INFO - PROCESS | 4349 | 14:24:36 INFO - TEST-INFO | 4349: exit 0 14:24:36 INFO - TEST-OK | kraken | took 63216ms 14:24:36 INFO - SUITE-END | took 1176s 14:24:36 INFO - Completed test suite (00:19:37) 14:24:36 INFO - javascript benchmark 14:24:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7101.911257301397, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3022.1840103172144, 3037.98481007595, 3052.6031615889933, 3061.173483159547, 3061.5866857974165, 5287.841364759059, 5301.946980530199, 5344.064788661984, 5380.0046991306535, 5391.865203369918, 5231.398389185245, 5358.624896257264, 5404.864878378043, 5423.972880135604, 5429.294191755076, 4834.685745426554, 4899.779509922044, 4982.57648099912, 5037.118504261758, 5065.79736810529, 4868.415790105192, 5055.646104772667, 5058.570021548155, 5065.062963351773, 5078.390593128811, 4825.155597770394, 4847.903041939177, 4855.198892182786, 4921.261810728383, 4931.580815630676, 4943.604511639096, 4945.7774400152075, 4959.553640172366, 4963.106640804654, 4985.451600323961, 4856.198727210006, 4904.509549045102, 4909.852704418873, 4930.876728081791, 4974.054929563371, 5141.2545180948555, 5298.947010529922, 5346.385165705916, 5366.329208848894, 5473.863153421156, 5617.887642247173, 5708.457696518824, 5757.654540727528, 5785.450382213683, 5823.883522329572, 5793.971030144822, 5799.768009279624, 5802.187693722883, 5807.0998995155815, 5822.214001109881, 5158.74206289684, 5193.480651934777, 5256.369235691665, 5337.2527846101575, 5373.435789242151, 5755.366909639936, 5762.222100016528, 5766.875459285483, 5806.564507661942, 5818.8254352369495, 5518.641288316247, 5518.9238098571195, 5524.309461317335, 5546.057170281062, 5550.47270509301, 5592.664440133523, 5622.943770562242, 5662.801801936995, 5689.288838895138, 5744.971275143597, 5507.834764957058, 5603.6077474577205, 5736.082226843685, 5805.187273781674, 5821.592488525847, 5582.0, 5634.1830434586755, 5645.125005624135, 5656.462636049569, 5687.488126068591, 4295.72077814941, 4307.5261721210645, 4328.653707703376, 4344.674149438742, 4391.407160033355, 3873.3996230584303, 3895.4351619015083, 3897.337452633059, 3930.606939306104, 3951.8221680024467, 5455.290812194389, 5484.341878974548, 5488.506034456918, 5503.972480137573, 5507.366652834975, 5669.773209071674, 5789.8263052108505, 5813.6221145625395, 5824.854378640483, 5825.242718446575, 5423.538999185034, 5467.781288748405, 5470.152126420411, 5490.039243132436, 5511.3937466878615, 4918.827841025547, 4964.230544265644, 4965.106280869478, 4989.301497790312, 5017.89964200714, 5760.164776107525, 5913.881722365529, 5928.7332070056955, 5935.73289201987, 5967.701614919237, 5536.003519366553, 5548.91676624851, 5625.718714064362, 5669.6314739541795, 5724.484796368347, 5840.386759390203, 5841.970790146022, 5842.941570584239, 5851.502622277154, 5858.443447872445, 5522.475364840334, 5565.16522521625, 5580.888382232414, 5587.6088673794075, 5601.0, 5527.088030475087, 5696.829095127153, 5698.1737648041635, 5743.42565743439, 5822.359540450462, 5610.158476228598, 5648.519875810603, 5658.321001479849, 5659.151127330933, 5663.546916246608, 5549.916751248816, 5584.385717570983, 5614.29821272341, 5616.943830561642, 5617.4101719320515, 5438.809641662523, 5498.80754173602, 5546.057170281143, 5553.583481238842, 5574.219609254788, 5593.748281327432, 5630.971845140748, 5658.971705141448, 5663.9716801415725, 5674.687892165805, 5505.091659876236, 5505.532029777513, 5518.481895742108, 5534.335879694462, 5541.972290138524], "value": 5277.022775272742, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.1196741854636, 592.5851903667433, 598.8712426828231, 609.8963176260035, 627.1627377451102, 39483.80258098709, 43334.34998475025, 43338.34992475116, 43505.0, 43635.3454698179, 43244.78377608107, 43862.0, 43865.34201986973, 43877.78061109698, 43983.0, 8616.181462761027, 8772.078931712174, 8785.209331160195, 8817.16236957488, 8830.0, 8824.558772061404, 8906.910930890674, 8915.0, 8919.464832110061, 8919.687810926618, 8847.646094156225, 8867.201951824334, 8891.244244239248, 8896.06591307913, 8909.73270801877, 8855.158759917798, 8884.244839188677, 8902.554872256394, 8910.821783564325, 8953.865692014626, 8719.60761765722, 8744.562771861381, 8796.25231855293, 8798.912010879872, 8806.955965220197, 40634.79682601568, 40710.0, 40979.180416391806, 40994.590054099375, 41689.0, 3602.855885764566, 3702.37059699849, 3736.8878933632036, 3752.0, 3850.2299540092095, 32679.0, 33364.499532507034, 33413.164670883176, 33773.83113084443, 34732.82633586841, 4381.3208952612395, 4423.911521769579, 4465.441819772528, 4564.246899261618, 4616.0, 251505.0, 253845.0, 256042.0, 256072.0, 256161.0, 34640.82679586586, 35526.28947421089, 51859.74070129701, 52119.21821172685, 52169.73915130476, 36167.4574881377, 36547.0, 36799.264014719556, 36808.263834723155, 36970.81514592464, 14760.48338308154, 14777.0, 14847.2576371181, 14897.47858824936, 14930.776038359434, 13295.933520332337, 13410.597682069554, 13483.730325393633, 13515.729685406433, 13529.391177397041, 8104.432689711782, 8284.668613255402, 8314.127016663284, 8397.076321604618, 8409.789755256168, 3239.9146285994457, 3250.2524419383203, 3257.641659417462, 3330.317284956578, 3353.0, 994.2245048861755, 1055.1347894726405, 1058.2486434631344, 1072.469127781753, 1096.9177311701494, 32508.34983300321, 33225.0, 33262.50106248408, 33308.167295817315, 33679.15802104967, 1077.2997551591527, 1087.722630729159, 1168.415792103948, 1176.7117056321256, 1179.186361410624, 16973.321067157423, 17251.0, 17336.739948900777, 17535.210915508833, 17536.298548057934, 624644.0, 626042.0, 628162.0, 633021.0, 634383.0, 59102.70448647815, 59638.403615964155, 59815.40184598098, 59821.40178598245, 60149.0, 1347.2253454263837, 1392.6866455047737, 1400.0549629000384, 1411.422045115627, 1414.1373762005169, 30815.53776693396, 31399.372012560078, 31740.841295793372, 32424.0, 32517.512237315987, 51386.22920656268, 51594.484055158966, 51638.0, 51717.7414112927, 51721.189758358276, 476632.0, 479644.0, 479830.0, 482172.0, 482242.0, 27989.860050699615, 28288.43423131567, 28355.0, 28594.0, 28779.856100719364, 48625.270620940006, 49523.50476495333, 49679.503204967485, 49759.253611195134, 49908.500914990385, 41437.79281103575, 42308.15383692247, 42707.3593896098, 42813.57186428096, 44303.55696442995, 41130.0, 41231.381529276485, 41719.16561668689, 42567.0, 42720.0, 39674.2065158701, 40664.39003415011, 41451.1709765797, 41534.0, 41568.376474353514, 33358.66641333653, 37611.0, 38169.236615266986, 38314.0, 38788.224235514564, 28358.29104272327, 28542.14373568796, 28567.0, 28716.0, 29011.12966611005], "value": 18959.958782113772, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.96146904575016, 375.95488541375033, 387.12316602894447, 394.0, 400.69747340757726, 15648.217589120555, 17715.82284177158, 19292.0, 20221.59556808863, 20497.872617006058, 16398.426055088075, 16684.0, 18356.449306520826, 18781.060946952664, 18970.0, 5179.766910489027, 5217.843464696065, 5234.973825130888, 5284.550813180885, 5312.814051508198, 5230.084735171349, 5268.657537260085, 5272.736363181844, 5279.656822306538, 5282.577393808505, 5483.232347471358, 5591.9720401397935, 5597.44025597441, 5601.887962240753, 5620.747066382002, 5290.7354632268425, 5540.9168862467295, 5583.748731307081, 5593.049181639131, 5611.803586874481, 5417.891642167135, 5474.972625136849, 5487.341519017704, 5535.280413546254, 5548.667079975174, 21338.786612133834, 22082.668759968612, 22238.88880555603, 23210.41973950648, 24076.638850417257, 2278.8491811635186, 2286.16554957441, 2315.4211447138214, 2317.5133222023396, 2368.7631236876173, 9876.061774131445, 9988.550515226832, 10034.0, 10116.89883101167, 10179.796404071878, 1878.6994080946984, 1936.3706795291587, 1957.6378370001453, 1972.7928567500348, 2000.7198992141111, 82221.0, 85916.0, 86039.13960860374, 86319.0, 90450.09549904482, 10882.945585272022, 10884.29252098627, 11088.112950963903, 11088.33469991803, 11188.888111118784, 12574.748505029847, 15411.537653870178, 15480.767788483181, 15482.612934676723, 15497.5350739478, 7868.527888326718, 7888.723894663659, 8064.314533264621, 8120.918790812135, 8139.593020348959, 7718.53688778675, 7723.382129429632, 7802.843943121105, 7909.3277071449575, 8213.34293256538, 3945.585713500041, 4003.499562554681, 4122.445746871528, 4135.29699951009, 4184.5187803403, 1876.6715824730618, 1974.328728232408, 2041.8264447522126, 2051.7332746742827, 2060.8175473579263, 956.4739393333639, 968.2157452463528, 968.970930872075, 998.2164001258977, 1070.8072546941469, 20023.799762002483, 20081.497962551053, 20231.595368092556, 20317.593648126956, 20343.491412714506, 1016.339379403379, 1031.3554028732042, 1038.4703801061362, 1056.8626078609732, 1069.5614797932965, 10476.0, 11162.274452160584, 11186.664400068012, 11191.888081119085, 11234.606788762354, 460396.0, 462320.0, 463425.0, 485923.0, 486120.0, 57974.0, 81540.59229703814, 94001.0, 96564.0, 98820.0, 983.4492684096786, 1016.0804471952895, 1017.8066167428314, 1022.8005538919988, 1024.3751311699857, 17205.0, 17242.224099915282, 18110.5472363192, 18228.908855455637, 18340.72488912694, 36892.81553592215, 43799.34300985424, 43829.0, 43960.560394395645, 45439.0, 55819.72090139523, 56402.05185636966, 59163.0, 59937.400625994924, 66535.0, 12312.876871231172, 12606.936965315115, 12872.751991842857, 12958.157719748186, 12982.285974271506, 12332.876671233531, 12412.937935310627, 12926.289054102115, 13420.865791341961, 13446.865531344562, 7542.585157816373, 7648.923510764821, 7795.805104872424, 8204.138565450541, 11481.598144064918, 6775.322467753185, 7766.378689704697, 7950.3639708822, 7995.200479951958, 8192.918070819454, 7338.853222935405, 7813.531188128731, 7834.529928204098, 8010.9599452004695, 8159.061707903667, 12510.624681259576, 12526.561570344995, 12962.870371296167, 13087.345632718516, 13119.672008199872, 11629.360385178557, 11765.823512647488, 11889.0, 11919.82120268214, 12316.261024338568], "value": 9027.505579201545, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1458.496818597584, 1470.62499062739, 1591.4907229686498, 1748.4089478574492, 1776.618027124168, 6970.686319115639, 7678.462507624468, 7728.111267204274, 8135.837283254331, 8156.632951517181, 7751.341136003446, 7992.760217193479, 7996.840063198732, 8023.117457079717, 8026.43814932955, 2149.527104037113, 2170.251263314154, 2170.5007848194923, 2181.3455963211054, 2185.7814218578173, 2162.3296777998794, 2188.39819049761, 2224.277109939268, 2227.3429338345145, 2231.866088034715, 2182.388931099295, 2190.1786829938774, 2198.318521258415, 2204.2725900452892, 2214.0922221889027, 2139.935801925945, 2141.593097311506, 2143.0463443767453, 2158.57907707997, 2162.5782972320403, 2125.9255926042515, 2166.8266538677026, 2168.1435832846096, 2178.161407857986, 2184.2791878680155, 7963.203679631991, 7970.163132871023, 7978.920210797875, 7988.201179881965, 8047.597620118971, 4684.36761037259, 4885.926711099336, 4905.583025442842, 4955.1080805455, 4966.230234313687, 3118.0, 3167.7149056585017, 3177.9205519861957, 3207.1135977620097, 3217.8391080445886, 1044.1646682653848, 1084.8643919510062, 1095.6001059613263, 1114.8160553508742, 1132.5356603792488, 10684.358938463716, 10730.980556847087, 10754.784904301949, 10784.191185661186, 10819.945900270526, 4086.8160932758096, 4343.630791382768, 4355.3684715716045, 4368.672349573794, 4372.912541749147, 9297.72106836796, 9315.72052838416, 9345.719628411158, 9371.671991480265, 9408.576614052385, 4971.676841005323, 4973.378327709036, 4984.40187177541, 4992.650514464025, 5001.799928002912, 3952.4980507407, 4386.4736231652405, 4397.120575884772, 4553.2942393929, 4565.931511027337, 3530.3645343838357, 3561.415170249214, 3658.5243918290453, 3703.203811180609, 3744.7753134811455, 1161.866385365677, 1165.906727461801, 1167.1246565076192, 1176.8352430659716, 1198.1972078707113, 970.2092794372705, 971.5482300730195, 975.5609975511048, 984.8571957066329, 1009.5204777730667, 5461.808836690697, 5496.230527726121, 5634.774609015593, 5651.208830763697, 5694.0, 973.3916302311055, 980.7989362180735, 981.4847205217176, 994.1400688404478, 1009.0111690543162, 3885.1646895916947, 4007.779572123561, 4008.4588580541254, 4030.5364883038824, 4055.945454181934, 9020.503872286956, 9346.48594327305, 9358.953205234066, 9374.67188648394, 9416.387934784218, 8780.341474389446, 9082.137196966278, 9199.724008279762, 9432.952835235918, 9443.197328227041, 6957.304269573104, 7088.751893683696, 7200.099987501562, 7217.566945983258, 7290.125184977836, 5269.578433725216, 5488.368837583729, 5549.722513874371, 5566.471185237396, 5669.092945128759, 8754.824903502022, 8888.511131887808, 8894.243989260985, 8929.419587726778, 8954.059823718677, 8735.908011498563, 8880.73357799267, 8890.0, 8925.910740892508, 8980.910190898006, 6280.842978925563, 6599.274079851117, 6646.634435106115, 6755.695993680394, 7034.0, 7796.376289896682, 7816.84366312682, 7818.569978651229, 7851.607419628882, 7862.842743145219, 6932.549384290005, 6990.930090699231, 7055.788326350218, 7061.046758687511, 7097.716091356495, 6758.628275444898, 6785.2536221016635, 6799.796006119825, 6865.965670171817, 7023.859522809617, 6609.3060228675295, 6613.900791488035, 6635.834104147435, 6662.067310576426, 6663.600183988976, 4663.556962088596, 4689.953100469088, 4732.97633511844, 4770.117528257283, 4813.774587748017, 4804.567588917014, 4863.392075990501, 4879.194932836042, 4930.63329601786, 5053.974730126326], "value": 4291.145341074745, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.1281277887736, 304.8612881139081, 305.3328477277151, 307.96612372639004, 308.3309218994781, 5647.774089036438, 5715.685637289953, 5733.283339582557, 5753.108268218422, 5771.826845194641, 5476.726163691809, 5520.889582208353, 5620.156976453534, 5656.133475952936, 5662.810809729962, 4174.248635245654, 4203.4115223868685, 4277.4867015958125, 4343.0, 4358.5423530529315, 4329.761863097544, 4343.522212556616, 4344.674149438789, 4347.261095561785, 4347.500037495697, 4328.891777705551, 4345.913081738363, 4353.28170851809, 4368.301071828508, 4375.934360984587, 4249.893752656178, 4265.680073994447, 4298.0, 4318.611324980736, 4327.134573085364, 3800.37293846515, 3813.0, 3815.351390263634, 3819.2934307152987, 3823.9101855971194, 5483.341998960111, 5486.945130548684, 5522.0, 5522.889542209174, 5526.734039043973, 4887.437944636376, 4927.753612319406, 4927.753612319406, 4981.402231732179, 4993.275974983643, 5763.740631671585, 5783.248177736909, 5789.392113828029, 5889.0, 5893.44012318829, 4137.77242251676, 4170.082581831992, 4171.874843754692, 4174.3321068629175, 4175.979120104411, 5767.192593036978, 6058.606190597597, 6061.666433384692, 6066.75732970685, 6119.418655227746, 4161.875143745632, 4168.791560421967, 4169.81084930414, 4172.7913604319665, 4188.643965262987, 4241.257779888507, 4246.660267178619, 4248.723832950848, 4259.7231179973205, 4264.637505811978, 4779.02030083832, 4896.290037944549, 4904.283500774772, 4918.9178380756175, 4929.457759646436, 5842.649441033466, 5856.560757943172, 5884.440978107073, 5908.20239267702, 5963.910541341883, 1436.2244388030556, 1464.9598784862867, 1473.9336729846968, 1474.3144437836243, 1483.807105076333, 919.0, 931.8602209668468, 932.8927173375013, 938.8452203789377, 941.5904081724472, 4972.65191436596, 5006.923511444984, 5041.6470847040355, 5086.18621020635, 5108.208227724708, 5341.278927344836, 5375.892482150335, 5383.892322153535, 5389.790186023712, 5454.59090568209, 4760.285957106462, 5016.473270306566, 5041.269015992661, 5051.494850514919, 5058.367704036996, 2838.4748821468093, 2859.6997315281596, 2866.4123854609757, 2872.928176795555, 2876.554134109216, 5436.532136323171, 5473.044555939828, 5483.862903427446, 5512.889742205133, 5522.751476183501, 5231.816886409034, 5451.383335998743, 5455.380957613665, 5495.725213739377, 5501.559875210054, 5535.252740880011, 5543.780368318963, 5555.833325000256, 5573.804916827891, 5618.85952851182, 5068.22612085767, 5267.024865675372, 5317.893642127058, 5385.569154467555, 5477.603211181124, 5269.973650131725, 5297.841064768063, 5304.469553044664, 5319.627626066138, 5380.542653874464, 5377.0, 5427.511523962862, 5542.8337149885565, 5549.472800084147, 5586.720663966704, 3839.1937693084765, 3880.320943834874, 3907.866718651559, 3908.355121404936, 4195.888089656304, 5756.481916627524, 5992.580519363602, 5993.190919225849, 6022.04283607838, 6129.724162412613, 5718.255931940798, 5912.556558258062, 5925.288965324189, 5942.732577033958, 5955.791547295824, 5826.82519524415, 5897.764089436546, 5933.703314834154, 5966.582339236212, 5979.940200597938, 5697.0, 5811.186433899173, 5828.329742079545, 5852.882942341044, 5917.0828521577505, 5921.378255283305, 6002.849928751816, 6030.4572588467245, 6037.486813620892, 6055.757769689163, 5745.454181852718, 5828.912566311594, 5837.766489340549, 5864.648121112747, 5869.73586188614], "value": 4292.864930475422, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [758.4842307231088, 760.1258552664433, 781.6521647866698, 782.9295363417291, 805.569020573993, 15348.53954381369, 16787.91606041971, 16803.0758308293, 16828.74756878648, 16842.66314673707, 15191.54425367238, 15340.0, 15359.0, 15512.922435387836, 15517.53447396577, 794.1423262876094, 808.2281421242728, 816.7835523586255, 818.292177266663, 818.5088946632033, 659.4724220623506, 774.1832366852968, 807.7859367267679, 807.8828569857367, 808.030363563723, 838.3000194837318, 844.4975239732349, 851.7998270406449, 852.8166444214493, 854.5727136431784, 849.7663142635763, 853.3301358433631, 854.2525290370926, 856.1010938514535, 858.8282343531318, 629.937006299371, 629.9905501417483, 631.1321932343028, 631.1668597451365, 632.3139393757732, 15937.442189523312, 15941.963772354877, 15959.361625534964, 15997.120158391284, 16038.0, 16031.19844007795, 16117.838821611751, 16181.83818161815, 16279.104649244287, 16345.0, 12538.498460061586, 12562.685932851751, 12646.21815624201, 12769.0, 12879.613611591574, 3975.0857302820223, 3984.0, 3992.281389349916, 3997.7401468904427, 4151.5640857709805, 85134.0, 85854.0, 86465.0, 87845.99999999936, 89187.0, 12280.938595306967, 12328.630141095602, 12350.258984460961, 12411.0, 13081.476740930446, 23860.64209036866, 24003.63994540083, 24061.0, 24088.759112409003, 24112.0, 8772.626624698389, 8781.121887811169, 8981.46111233315, 9130.543472826332, 9513.952430237943, 4817.0, 4841.8547443576745, 4919.06537757832, 4926.408830940239, 5053.1157047516535, 3522.154682876091, 3590.5152804371596, 3599.0282623691455, 3634.636536346397, 3636.090977255686, 609.8780243951228, 618.3414663383483, 619.8357435279654, 621.6052806467925, 633.2021652717609, 652.4444356306058, 676.4182802789597, 731.7585196885121, 749.7375918428506, 768.3545821509958, 9153.542322883963, 9770.0, 9867.555959981819, 10039.297249192487, 10274.743131421774, 630.5334052800895, 639.8560323927079, 677.5866721300004, 701.7789396340137, 726.23019599225, 4693.55411235932, 4949.430815456197, 4998.0, 5003.874903127378, 5017.297578339036, 95635.0, 97345.0, 100285.49857250667, 114083.0, 131730.0, 65504.67247663827, 93611.0, 97461.51269243608, 98121.01878981262, 98994.0, 55602.721986389806, 86159.13840861636, 87839.56080219558, 90078.0, 91006.08993910109, 9678.903210967801, 9695.175910047725, 9713.174380177765, 9749.853752193865, 9863.21094312439, 48770.51229487802, 48997.75501122472, 49586.25620615766, 50326.0, 51020.0, 68636.31363686499, 68811.65594171998, 71674.0, 73605.26394735984, 74186.0, 13299.534516291884, 13359.666008349868, 13651.658708532366, 13843.377048033064, 14298.356573954405, 15423.151726655142, 15656.13891235993, 15763.369465221263, 15916.363345466514, 16595.004299742053, 13451.260180690157, 13668.65828354299, 13909.652258693613, 13949.232792196526, 14063.718725625635, 13114.770394596278, 13179.934100329438, 13378.13042152296, 13618.319084045559, 13754.518591849237, 13027.934860325639, 13310.201387916755, 13549.458021679417, 13587.388567514683, 13859.0, 11009.394483303495, 11281.605143819927, 11827.82258266144, 11891.405429728651, 12019.278843269432, 9622.711318660451, 10487.0, 10709.946450267698, 11572.884271157182, 11728.530858765555], "value": 7710.664173649829, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 113.0, 106.0, 113.0, 113.0, 114.0, 115.0, 112.0, 112.0, 113.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 121.0, 149.0, 180.0, 119.0, 154.0, 154.0, 120.0, 186.0, 122.0], "value": 145.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 164.0, 164.0, 164.0, 166.0, 171.0, 163.0, 163.0, 167.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 150.0, 77.0, 75.0, 76.0, 75.0, 175.0, 77.0], "value": 93.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 156.0, 86.0, 84.0, 85.0, 144.0, 85.0, 86.0, 135.0], "value": 103.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 121.0, 119.0, 117.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 147.0, 147.0, 148.0, 150.0, 146.0, 148.0, 147.0, 148.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 53.0, 54.0, 52.0, 54.0, 61.0, 51.0, 52.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 63.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 78.0, 77.0, 77.0, 77.0, 77.0, 77.0, 82.0, 82.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 130.0, 132.0, 131.0, 138.0, 134.0, 137.0, 132.0, 169.0, 129.0], "value": 135.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 165.0, 172.0, 166.0, 157.0, 158.0, 158.0, 160.0, 164.0], "value": 161.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 67.0, 65.0, 64.0, 65.0, 70.0, 69.0, 66.0, 67.0, 64.0], "value": 67.3, "unit": "score"}]}]} 14:24:36 INFO - Return code: 0 14:24:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:24:36 ERROR - # TBPL SUCCESS # 14:24:36 INFO - Running post-action listener: _resource_record_post_action 14:24:36 INFO - [mozharness: 2016-07-20 21:24:36.448531Z] Finished run-tests step (success) 14:24:36 INFO - Running post-run listener: _resource_record_post_run 14:24:36 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 462848; Write bytes: 310566912; Read time: 100; Write time: 265288 14:24:36 INFO - TinderboxPrint: CPU usage
13.4% 14:24:36 INFO - TinderboxPrint: I/O read bytes / time
462,848 / 100 14:24:36 INFO - TinderboxPrint: I/O write bytes / time
310,566,912 / 265,288 14:24:36 INFO - TinderboxPrint: CPU idle
8,245.6 (86.6%) 14:24:36 INFO - TinderboxPrint: CPU user
1,218.4 (12.8%) 14:24:36 INFO - TinderboxPrint: Swap in / out
0 / 0 14:24:36 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 19533824; Read time: 0; Write time: 24192 14:24:36 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 458752; Write bytes: 291033088; Read time: 84; Write time: 241096 14:24:37 INFO - Running post-run listener: _upload_blobber_files 14:24:37 INFO - Blob upload gear active. 14:24:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:24:37 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:24:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:24:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:24:37 INFO - (blobuploader) - INFO - Open directory for files ... 14:24:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:24:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:24:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:24:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:24:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:24:39 INFO - (blobuploader) - INFO - Done attempting. 14:24:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:24:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:24:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:24:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:24:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:24:57 INFO - (blobuploader) - INFO - Done attempting. 14:24:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:24:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:24:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:24:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:24:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:24:58 INFO - (blobuploader) - INFO - Done attempting. 14:24:58 INFO - (blobuploader) - INFO - Iteration through files over. 14:24:58 INFO - Return code: 0 14:24:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:24:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:24:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c298524e5b2bccf41d3316f4a164ea3082bc1da6b0833c894a4e2285126bc3a8f87d91ee181b8b6985ad6c48ebc50bccd224564adb739ac31151efaade4e3c56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ccee82484f261cfcd9f7d4347033ab712ed5c8ba4a9ccd757d01036afe30ab234e723b892c8d4cb5fd7bfe0effb3084a6858e6b03aa727462665ec07b1615ec2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3d63577867de28455657b9a655514f21dc327d843c2e3e8eea4e8e3280d0aad69535d8ad3c1835521d8bde0150e5738605a5c54f2564ab20a67cf6798a07953c"} 14:24:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:24:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:24:58 INFO - Contents: 14:24:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c298524e5b2bccf41d3316f4a164ea3082bc1da6b0833c894a4e2285126bc3a8f87d91ee181b8b6985ad6c48ebc50bccd224564adb739ac31151efaade4e3c56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ccee82484f261cfcd9f7d4347033ab712ed5c8ba4a9ccd757d01036afe30ab234e723b892c8d4cb5fd7bfe0effb3084a6858e6b03aa727462665ec07b1615ec2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3d63577867de28455657b9a655514f21dc327d843c2e3e8eea4e8e3280d0aad69535d8ad3c1835521d8bde0150e5738605a5c54f2564ab20a67cf6798a07953c"} 14:24:58 INFO - Running post-run listener: copy_logs_to_upload_dir 14:24:58 INFO - Copying logs to upload dir... 14:24:58 INFO - mkdir: /builds/slave/test/build/upload/logs 14:24:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.020717 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-20 14:24:58.096563) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 14:24:58.099677) ========= 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=52faae308a556c440401f8e5000001e8-1469048641.730910-1476768479 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/c298524e5b2bccf41d3316f4a164ea3082bc1da6b0833c894a4e2285126bc3a8f87d91ee181b8b6985ad6c48ebc50bccd224564adb739ac31151efaade4e3c56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ccee82484f261cfcd9f7d4347033ab712ed5c8ba4a9ccd757d01036afe30ab234e723b892c8d4cb5fd7bfe0effb3084a6858e6b03aa727462665ec07b1615ec2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3d63577867de28455657b9a655514f21dc327d843c2e3e8eea4e8e3280d0aad69535d8ad3c1835521d8bde0150e5738605a5c54f2564ab20a67cf6798a07953c"} build_url:https://queue.taskcluster.net/v1/task/IB9Gnhi1TSGb5x3jn7ENvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011177 build_url: 'https://queue.taskcluster.net/v1/task/IB9Gnhi1TSGb5x3jn7ENvg/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/c298524e5b2bccf41d3316f4a164ea3082bc1da6b0833c894a4e2285126bc3a8f87d91ee181b8b6985ad6c48ebc50bccd224564adb739ac31151efaade4e3c56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ccee82484f261cfcd9f7d4347033ab712ed5c8ba4a9ccd757d01036afe30ab234e723b892c8d4cb5fd7bfe0effb3084a6858e6b03aa727462665ec07b1615ec2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3d63577867de28455657b9a655514f21dc327d843c2e3e8eea4e8e3280d0aad69535d8ad3c1835521d8bde0150e5738605a5c54f2564ab20a67cf6798a07953c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 14:24:58.125048) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 14:24:58.125383) ========= 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=52faae308a556c440401f8e5000001e8-1469048641.730910-1476768479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004559 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 14:24:58.208277) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 14:24:58.208585) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 14:24:58.208886) ========= ========= Total master_lag: 0.14 =========