builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1469218846.38 results: success (0) buildid: 20160722083025 builduid: 90f9e25df22548d1a017b0ededf34064 revision: ff29f08b72c466b65dea5efa6f82f99add8f17ef ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-22 13:20:46.380603) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-22 13:20:46.381155) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-22 13:20:46.381506) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-22 13:20:46.594553) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 13:20:46.594894) ========= 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=31acecf42b6a79ec49471d4a000001bb-1469218845.556851-1471606210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-22 13:20:46-- 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% 225M=0s 2016-07-22 13:20:47 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166865 ========= master_lag: 0.13 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 13:20:46.888912) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 13:20:46.889222) ========= 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=31acecf42b6a79ec49471d4a000001bb-1469218845.556851-1471606210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018711 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 13:20:46.939193) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-22 13:20:46.939520) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ff29f08b72c466b65dea5efa6f82f99add8f17ef --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 ff29f08b72c466b65dea5efa6f82f99add8f17ef --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=31acecf42b6a79ec49471d4a000001bb-1469218845.556851-1471606210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-22 13:20:47,226 truncating revision to first 12 chars 2016-07-22 13:20:47,226 Setting DEBUG logging. 2016-07-22 13:20:47,226 attempt 1/10 2016-07-22 13:20:47,226 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ff29f08b72c4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-22 13:20:48,109 unpacking tar archive at: fx-team-ff29f08b72c4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.192135 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-22 13:20:48.163968) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-22 13:20:48.164293) ========= script_repo_revision: ff29f08b72c466b65dea5efa6f82f99add8f17ef ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-22 13:20:48.164695) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-22 13:20:48.164975) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-22 13:20:48.175757) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-22 13:20:48.176024) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1469218845.556851-1471606210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:20:48 INFO - MultiFileLogger online at 20160722 13:20:48 in /builds/slave/test 13:20:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 13:20:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:20:48 INFO - {'append_to_log': False, 13:20:48 INFO - 'base_work_dir': '/builds/slave/test', 13:20:48 INFO - 'blob_upload_branch': 'Fx-Team', 13:20:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:20:48 INFO - 'branch': 'Fx-Team', 13:20:48 INFO - 'buildbot_json_path': 'buildprops.json', 13:20:48 INFO - 'config_files': ('talos/linux_config.py',), 13:20:48 INFO - 'default_actions': ('clobber', 13:20:48 INFO - 'read-buildbot-config', 13:20:48 INFO - 'download-and-extract', 13:20:48 INFO - 'populate-webroot', 13:20:48 INFO - 'create-virtualenv', 13:20:48 INFO - 'install', 13:20:48 INFO - 'run-tests'), 13:20:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:20:48 INFO - 'download_minidump_stackwalk': True, 13:20:48 INFO - 'download_symbols': 'ondemand', 13:20:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:20:48 INFO - 'tooltool.py': '/tools/tooltool.py', 13:20:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:20:48 INFO - '/tools/misc-python/virtualenv.py')}, 13:20:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:20:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:20:48 INFO - 'installer_path': 'installer.exe', 13:20:48 INFO - 'log_level': 'info', 13:20:48 INFO - 'log_name': 'talos', 13:20:48 INFO - 'log_to_console': True, 13:20:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:20:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:20:48 INFO - 'opt_config_files': (), 13:20:48 INFO - 'pip_index': False, 13:20:48 INFO - 'sps_profile': False, 13:20:48 INFO - 'sps_profile_interval': 0, 13:20:48 INFO - 'suite': 'dromaeojs', 13:20:48 INFO - 'system_bits': '32', 13:20:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:20:48 INFO - 'title': 'talos-linux64-ix-014', 13:20:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:20:48 INFO - 'use_talos_json': True, 13:20:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:20:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:20:48 INFO - 'work_dir': 'build'} 13:20:48 INFO - [mozharness: 2016-07-22 20:20:48.536696Z] Running clobber step. 13:20:48 INFO - Running pre-action listener: _resource_record_pre_action 13:20:48 INFO - Running main action method: clobber 13:20:48 INFO - rmtree: /builds/slave/test/build 13:20:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:20:49 INFO - Running post-action listener: _resource_record_post_action 13:20:49 INFO - [mozharness: 2016-07-22 20:20:49.527333Z] Finished clobber step (success) 13:20:49 INFO - [mozharness: 2016-07-22 20:20:49.527436Z] Running read-buildbot-config step. 13:20:49 INFO - Running pre-action listener: _resource_record_pre_action 13:20:49 INFO - Running main action method: read_buildbot_config 13:20:49 INFO - Using buildbot properties: 13:20:49 INFO - { 13:20:49 INFO - "project": "", 13:20:49 INFO - "product": "firefox", 13:20:49 INFO - "script_repo_revision": "production", 13:20:49 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:20:49 INFO - "repository": "", 13:20:49 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 13:20:49 INFO - "buildid": "20160722083025", 13:20:49 INFO - "pgo_build": "True", 13:20:49 INFO - "basedir": "/builds/slave/test", 13:20:49 INFO - "buildnumber": 1349, 13:20:49 INFO - "slavename": "talos-linux64-ix-014", 13:20:49 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:20:49 INFO - "platform": "ubuntu64_hw", 13:20:49 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 13:20:49 INFO - "branch": "fx-team", 13:20:49 INFO - "repo_path": "integration/fx-team", 13:20:49 INFO - "revision": "ff29f08b72c466b65dea5efa6f82f99add8f17ef", 13:20:49 INFO - "stage_platform": "linux64-pgo", 13:20:49 INFO - "builduid": "90f9e25df22548d1a017b0ededf34064", 13:20:49 INFO - "slavebuilddir": "test" 13:20:49 INFO - } 13:20:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:20:49 INFO - Running post-action listener: _resource_record_post_action 13:20:49 INFO - [mozharness: 2016-07-22 20:20:49.529875Z] Finished read-buildbot-config step (success) 13:20:49 INFO - [mozharness: 2016-07-22 20:20:49.529965Z] Running download-and-extract step. 13:20:49 INFO - Running pre-action listener: _resource_record_pre_action 13:20:49 INFO - Running main action method: download_and_extract 13:20:49 INFO - mkdir: /builds/slave/test/build/tests 13:20:49 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')]} 13:20:49 INFO - https://queue.taskcluster.net/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:20:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:20:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:20:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/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 13:20:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/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 13:20:50 INFO - Downloaded 1361 bytes. 13:20:50 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:20:50 INFO - Using the following test package requirements: 13:20:50 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:20:50 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:20:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:20:50 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:20:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:20:50 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:20:50 INFO - u'jsshell-linux-x86_64.zip'], 13:20:50 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:20:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:20:50 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:20:50 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:20:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:20:50 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:20:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:20:50 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:20:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:20:50 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:20:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:20:50 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:20:50 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')]} 13:20:50 INFO - https://queue.taskcluster.net/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:20:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:20:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:20:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/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 13:20:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/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 13:20:51 INFO - Downloaded 24308968 bytes. 13:20:51 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'] 13:20:51 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 13:20:52 INFO - Return code: 0 13:20:52 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 13:20:52 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')]} 13:20:52 INFO - https://queue.taskcluster.net/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:20:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:20:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:20:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/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 13:20:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/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 13:20:54 INFO - Downloaded 24308968 bytes. 13:20:54 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'] 13:20:54 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 13:20:55 INFO - Return code: 0 13:20:55 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')]} 13:20:55 INFO - https://queue.taskcluster.net/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:20:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:20:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:20:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/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 13:20:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/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 13:20:56 INFO - Downloaded 14403289 bytes. 13:20:56 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'] 13:20:56 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 13:20:56 INFO - Return code: 0 13:20:56 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')]} 13:20:56 INFO - https://queue.taskcluster.net/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:20:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:20:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:20:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/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 13:20:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/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 13:20:58 INFO - Downloaded 60849208 bytes. 13:20:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:20:58 INFO - mkdir: /builds/slave/test/properties 13:20:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:20:58 INFO - Writing to file /builds/slave/test/properties/build_url 13:20:58 INFO - Contents: 13:20:58 INFO - build_url:https://queue.taskcluster.net/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:20:58 INFO - Running post-action listener: _resource_record_post_action 13:20:58 INFO - Running post-action listener: set_extra_try_arguments 13:20:58 INFO - [mozharness: 2016-07-22 20:20:58.905139Z] Finished download-and-extract step (success) 13:20:58 INFO - [mozharness: 2016-07-22 20:20:58.905375Z] Running populate-webroot step. 13:20:58 INFO - Running pre-action listener: _resource_record_pre_action 13:20:58 INFO - Running main action method: populate_webroot 13:20:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:20:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:20:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:20:58 INFO - '--tppagecycles', 13:20:58 INFO - '7'], 13:20:58 INFO - 'tests': ['tsvgm']}}, 13:20:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:20:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:20:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:20:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:20:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:20:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:20:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:20:58 INFO - 'talos_options': ['--disable-e10s'], 13:20:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:20:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:20:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:20:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:20:58 INFO - 'talos_options': ['--disable-e10s'], 13:20:58 INFO - 'tests': ['damp', 'tps']}, 13:20:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:20:58 INFO - 'tests': ['damp', 'tps']}, 13:20:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:20:58 INFO - 'tests': ['dromaeo_dom']}, 13:20:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:20:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:20:58 INFO - 'tests': ['basic_compositor_video']}, 13:20:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:20:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:20:58 INFO - 'tests': ['a11yr', 13:20:58 INFO - 'ts_paint', 13:20:58 INFO - 'tpaint', 13:20:58 INFO - 'sessionrestore', 13:20:58 INFO - 'sessionrestore_no_auto_restore', 13:20:58 INFO - 'tabpaint']}, 13:20:58 INFO - 'other-e10s': {'tests': ['a11yr', 13:20:58 INFO - 'ts_paint', 13:20:58 INFO - 'tpaint', 13:20:58 INFO - 'sessionrestore', 13:20:58 INFO - 'sessionrestore_no_auto_restore', 13:20:58 INFO - 'tabpaint']}, 13:20:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:20:58 INFO - 'ts_paint', 13:20:58 INFO - 'tpaint', 13:20:58 INFO - 'sessionrestore', 13:20:58 INFO - 'sessionrestore_no_auto_restore', 13:20:58 INFO - 'tabpaint']}, 13:20:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:20:58 INFO - 'ts_paint', 13:20:58 INFO - 'tpaint', 13:20:58 INFO - 'sessionrestore', 13:20:58 INFO - 'sessionrestore_no_auto_restore', 13:20:58 INFO - 'tabpaint']}, 13:20:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:20:58 INFO - 'tests': ['a11yr', 13:20:58 INFO - 'ts_paint', 13:20:58 INFO - 'tpaint', 13:20:58 INFO - 'sessionrestore', 13:20:58 INFO - 'sessionrestore_no_auto_restore', 13:20:58 INFO - 'tabpaint']}, 13:20:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:20:58 INFO - 'tests': ['a11yr', 13:20:58 INFO - 'ts_paint', 13:20:58 INFO - 'tpaint', 13:20:58 INFO - 'sessionrestore', 13:20:58 INFO - 'sessionrestore_no_auto_restore', 13:20:58 INFO - 'tabpaint']}, 13:20:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:20:58 INFO - 'tests': ['tsvgx', 13:20:58 INFO - 'tsvgr_opacity', 13:20:58 INFO - 'tart', 13:20:58 INFO - 'tscrollx', 13:20:58 INFO - 'cart']}, 13:20:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:20:58 INFO - 'tsvgr_opacity', 13:20:58 INFO - 'tart', 13:20:58 INFO - 'tscrollx', 13:20:58 INFO - 'cart']}, 13:20:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:20:58 INFO - 'talos_options': ['--disable-e10s'], 13:20:58 INFO - 'tests': ['tp5o']}, 13:20:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:20:58 INFO - 'tests': ['tp5o']}, 13:20:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:20:58 INFO - 'talos_options': ['--disable-e10s', 13:20:58 INFO - '--xperf_path', 13:20:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:20:58 INFO - 'tests': ['tp5n']}, 13:20:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:20:58 INFO - 'talos_options': ['--xperf_path', 13:20:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:20:58 INFO - 'tests': ['tp5n']}}, 13:20:58 INFO - 'talos.zip': {'path': '', 13:20:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:20:58 INFO - Running post-action listener: _resource_record_post_action 13:20:58 INFO - [mozharness: 2016-07-22 20:20:58.925522Z] Finished populate-webroot step (success) 13:20:58 INFO - [mozharness: 2016-07-22 20:20:58.925612Z] Running create-virtualenv step. 13:20:58 INFO - Running pre-action listener: _resource_record_pre_action 13:20:58 INFO - Running main action method: create_virtualenv 13:20:58 INFO - Creating virtualenv /builds/slave/test/build/venv 13:20:58 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 13:20:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:20:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:20:59 INFO - Using real prefix '/usr' 13:20:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:20:59 INFO - Installing distribute.............................................................................................................................................................................................done. 13:21:01 INFO - Installing pip.................done. 13:21:01 INFO - Return code: 0 13:21:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:21:01 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')]} 13:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:01 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')]} 13:21:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:01 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 0x1ad9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d983b0>, '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 0x1d992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d99740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469218845.556851-1471606210', '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 13:21:01 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 13:21:01 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 13:21:01 INFO - Using env: {'DISPLAY': ':0', 13:21:01 INFO - 'HOME': '/home/cltbld', 13:21:01 INFO - 'LANG': 'en_US.UTF-8', 13:21:01 INFO - 'LANGUAGE': 'en_US:en', 13:21:01 INFO - 'LOGNAME': 'cltbld', 13:21:01 INFO - 'MAIL': '/var/mail/cltbld', 13:21:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:01 INFO - 'MOZ_NO_REMOTE': '1', 13:21:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:01 INFO - 'NO_EM_RESTART': '1', 13:21:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:01 INFO - 'PWD': '/builds/slave/test', 13:21:01 INFO - 'SHELL': '/bin/bash', 13:21:01 INFO - 'SHLVL': '1', 13:21:01 INFO - 'TERM': 'linux', 13:21:01 INFO - 'TMOUT': '86400', 13:21:01 INFO - 'USER': 'cltbld', 13:21:01 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469218845.556851-1471606210', 13:21:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:01 INFO - '_': '/tools/buildbot/bin/python'} 13:21:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:01 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 13:21:01 INFO - Cleaning up... 13:21:01 INFO - Return code: 0 13:21:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:21:01 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')]} 13:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:01 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')]} 13:21:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:01 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 0x1ad9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d983b0>, '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 0x1d992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d99740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469218845.556851-1471606210', '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 13:21:01 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 13:21:01 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 13:21:01 INFO - Using env: {'DISPLAY': ':0', 13:21:01 INFO - 'HOME': '/home/cltbld', 13:21:01 INFO - 'LANG': 'en_US.UTF-8', 13:21:01 INFO - 'LANGUAGE': 'en_US:en', 13:21:01 INFO - 'LOGNAME': 'cltbld', 13:21:01 INFO - 'MAIL': '/var/mail/cltbld', 13:21:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:01 INFO - 'MOZ_NO_REMOTE': '1', 13:21:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:01 INFO - 'NO_EM_RESTART': '1', 13:21:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:01 INFO - 'PWD': '/builds/slave/test', 13:21:01 INFO - 'SHELL': '/bin/bash', 13:21:01 INFO - 'SHLVL': '1', 13:21:01 INFO - 'TERM': 'linux', 13:21:01 INFO - 'TMOUT': '86400', 13:21:01 INFO - 'USER': 'cltbld', 13:21:01 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469218845.556851-1471606210', 13:21:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:01 INFO - '_': '/tools/buildbot/bin/python'} 13:21:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:01 INFO - Downloading/unpacking psutil>=3.1.1 13:21:01 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 13:21:01 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 13:21:01 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 13:21:01 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 13:21:01 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 13:21:01 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 13:21:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:21:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:21:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:21:04 INFO - Installing collected packages: psutil 13:21:04 INFO - Running setup.py install for psutil 13:21:04 INFO - building 'psutil._psutil_linux' extension 13:21:04 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 13:21:04 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 13:21:04 INFO - building 'psutil._psutil_posix' extension 13:21:04 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 13:21:04 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 13:21:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:21:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:21:04 INFO - Successfully installed psutil 13:21:04 INFO - Cleaning up... 13:21:04 INFO - Return code: 0 13:21:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:21:04 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')]} 13:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:04 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')]} 13:21:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:04 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 0x1ad9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d983b0>, '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 0x1d992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d99740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469218845.556851-1471606210', '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 13:21:04 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 13:21:04 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 13:21:04 INFO - Using env: {'DISPLAY': ':0', 13:21:04 INFO - 'HOME': '/home/cltbld', 13:21:04 INFO - 'LANG': 'en_US.UTF-8', 13:21:04 INFO - 'LANGUAGE': 'en_US:en', 13:21:04 INFO - 'LOGNAME': 'cltbld', 13:21:04 INFO - 'MAIL': '/var/mail/cltbld', 13:21:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:04 INFO - 'MOZ_NO_REMOTE': '1', 13:21:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:04 INFO - 'NO_EM_RESTART': '1', 13:21:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:04 INFO - 'PWD': '/builds/slave/test', 13:21:04 INFO - 'SHELL': '/bin/bash', 13:21:04 INFO - 'SHLVL': '1', 13:21:04 INFO - 'TERM': 'linux', 13:21:04 INFO - 'TMOUT': '86400', 13:21:04 INFO - 'USER': 'cltbld', 13:21:04 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469218845.556851-1471606210', 13:21:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:04 INFO - '_': '/tools/buildbot/bin/python'} 13:21:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:21:04 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 13:21:04 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 13:21:04 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 13:21:04 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 13:21:04 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 13:21:04 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 13:21:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:21:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:21:06 INFO - Installing collected packages: mozsystemmonitor 13:21:06 INFO - Running setup.py install for mozsystemmonitor 13:21:06 INFO - Successfully installed mozsystemmonitor 13:21:06 INFO - Cleaning up... 13:21:06 INFO - Return code: 0 13:21:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:21:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:06 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 0x1ad9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d983b0>, '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 0x1d992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d99740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469218845.556851-1471606210', '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 13:21:06 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 13:21:06 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 13:21:06 INFO - Using env: {'DISPLAY': ':0', 13:21:06 INFO - 'HOME': '/home/cltbld', 13:21:06 INFO - 'LANG': 'en_US.UTF-8', 13:21:06 INFO - 'LANGUAGE': 'en_US:en', 13:21:06 INFO - 'LOGNAME': 'cltbld', 13:21:06 INFO - 'MAIL': '/var/mail/cltbld', 13:21:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:06 INFO - 'MOZ_NO_REMOTE': '1', 13:21:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:06 INFO - 'NO_EM_RESTART': '1', 13:21:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:06 INFO - 'PWD': '/builds/slave/test', 13:21:06 INFO - 'SHELL': '/bin/bash', 13:21:06 INFO - 'SHLVL': '1', 13:21:06 INFO - 'TERM': 'linux', 13:21:06 INFO - 'TMOUT': '86400', 13:21:06 INFO - 'USER': 'cltbld', 13:21:06 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469218845.556851-1471606210', 13:21:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:06 INFO - '_': '/tools/buildbot/bin/python'} 13:21:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:07 INFO - Downloading/unpacking jsonschema==2.5.1 13:21:07 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 13:21:07 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 13:21:07 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 13:21:07 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 13:21:07 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 13:21:07 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 13:21:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:21:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:21:08 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 13:21:08 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 13:21:08 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 13:21:08 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 13:21:08 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 13:21:08 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 13:21:09 INFO - Downloading functools32-3.2.3-2.tar.gz 13:21:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:21:09 INFO - warning: no files found matching '*.txt' 13:21:09 INFO - no previously-included directories found matching 'build' 13:21:09 INFO - no previously-included directories found matching 'dist' 13:21:09 INFO - no previously-included directories found matching '.git*' 13:21:09 INFO - Installing collected packages: jsonschema, functools32 13:21:09 INFO - Running setup.py install for functools32 13:21:09 INFO - warning: no files found matching '*.txt' 13:21:09 INFO - no previously-included directories found matching 'build' 13:21:09 INFO - no previously-included directories found matching 'dist' 13:21:09 INFO - no previously-included directories found matching '.git*' 13:21:09 INFO - Successfully installed jsonschema functools32 13:21:09 INFO - Cleaning up... 13:21:09 INFO - Return code: 0 13:21:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:21:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:21:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:09 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 0x1ad9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d983b0>, '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 0x1d992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d99740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469218845.556851-1471606210', '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 13:21:09 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 13:21:09 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 13:21:09 INFO - Using env: {'DISPLAY': ':0', 13:21:09 INFO - 'HOME': '/home/cltbld', 13:21:09 INFO - 'LANG': 'en_US.UTF-8', 13:21:09 INFO - 'LANGUAGE': 'en_US:en', 13:21:09 INFO - 'LOGNAME': 'cltbld', 13:21:09 INFO - 'MAIL': '/var/mail/cltbld', 13:21:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:09 INFO - 'MOZ_NO_REMOTE': '1', 13:21:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:09 INFO - 'NO_EM_RESTART': '1', 13:21:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:09 INFO - 'PWD': '/builds/slave/test', 13:21:09 INFO - 'SHELL': '/bin/bash', 13:21:09 INFO - 'SHLVL': '1', 13:21:09 INFO - 'TERM': 'linux', 13:21:09 INFO - 'TMOUT': '86400', 13:21:09 INFO - 'USER': 'cltbld', 13:21:09 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469218845.556851-1471606210', 13:21:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:09 INFO - '_': '/tools/buildbot/bin/python'} 13:21:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:09 INFO - Downloading/unpacking blobuploader==1.2.4 13:21:09 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 13:21:09 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 13:21:09 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 13:21:09 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 13:21:09 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 13:21:09 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 13:21:11 INFO - Downloading blobuploader-1.2.4.tar.gz 13:21:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:21:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:21:11 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 13:21:11 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 13:21:11 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 13:21:11 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 13:21:11 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 13:21:11 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 13:21:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:21:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:21:12 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 13:21:12 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 13:21:12 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 13:21:12 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 13:21:12 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 13:21:12 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 13:21:12 INFO - Downloading docopt-0.6.1.tar.gz 13:21:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:21:12 INFO - Installing collected packages: blobuploader, requests, docopt 13:21:12 INFO - Running setup.py install for blobuploader 13:21:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:21:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:21:12 INFO - Running setup.py install for requests 13:21:12 INFO - Running setup.py install for docopt 13:21:12 INFO - Successfully installed blobuploader requests docopt 13:21:12 INFO - Cleaning up... 13:21:12 INFO - Return code: 0 13:21:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:21:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:21:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:12 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 0x1ad9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d983b0>, '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 0x1d992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d99740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469218845.556851-1471606210', '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 13:21:12 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 13:21:12 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 13:21:12 INFO - Using env: {'DISPLAY': ':0', 13:21:12 INFO - 'HOME': '/home/cltbld', 13:21:12 INFO - 'LANG': 'en_US.UTF-8', 13:21:12 INFO - 'LANGUAGE': 'en_US:en', 13:21:12 INFO - 'LOGNAME': 'cltbld', 13:21:12 INFO - 'MAIL': '/var/mail/cltbld', 13:21:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:12 INFO - 'MOZ_NO_REMOTE': '1', 13:21:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:12 INFO - 'NO_EM_RESTART': '1', 13:21:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:12 INFO - 'PWD': '/builds/slave/test', 13:21:12 INFO - 'SHELL': '/bin/bash', 13:21:12 INFO - 'SHLVL': '1', 13:21:12 INFO - 'TERM': 'linux', 13:21:12 INFO - 'TMOUT': '86400', 13:21:12 INFO - 'USER': 'cltbld', 13:21:12 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469218845.556851-1471606210', 13:21:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:12 INFO - '_': '/tools/buildbot/bin/python'} 13:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:21:13 INFO - Running setup.py (path:/tmp/pip-qT3oQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:21:13 INFO - Running setup.py (path:/tmp/pip-5fUZa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:21:13 INFO - Running setup.py (path:/tmp/pip-iHOo7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:21:13 INFO - Running setup.py (path:/tmp/pip-emVP8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:21:13 INFO - Running setup.py (path:/tmp/pip-EwD1f9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:21:13 INFO - Running setup.py (path:/tmp/pip-C04eqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:21:13 INFO - Running setup.py (path:/tmp/pip-oi4qrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:21:13 INFO - Running setup.py (path:/tmp/pip-b2wzrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:21:13 INFO - Running setup.py (path:/tmp/pip-xW1l2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:21:13 INFO - Running setup.py (path:/tmp/pip-kThric-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:21:13 INFO - Running setup.py (path:/tmp/pip-82Ewhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:21:13 INFO - Running setup.py (path:/tmp/pip-NPg61Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:21:13 INFO - Running setup.py (path:/tmp/pip-YoLhSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:21:14 INFO - Running setup.py (path:/tmp/pip-SFA00j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:21:14 INFO - Running setup.py (path:/tmp/pip-0jgn3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:21:14 INFO - Running setup.py (path:/tmp/pip-Mamce0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:21:14 INFO - Running setup.py (path:/tmp/pip-deAIxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:21:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:21:14 INFO - Running setup.py install for manifestparser 13:21:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:21:14 INFO - Running setup.py install for mozcrash 13:21:14 INFO - Running setup.py install for mozdebug 13:21:14 INFO - Running setup.py install for mozdevice 13:21:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:21:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:21:14 INFO - Running setup.py install for mozfile 13:21:14 INFO - Running setup.py install for mozhttpd 13:21:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:21:14 INFO - Running setup.py install for mozinfo 13:21:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:21:15 INFO - Running setup.py install for mozInstall 13:21:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:21:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:21:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:21:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:21:15 INFO - Running setup.py install for mozleak 13:21:15 INFO - Running setup.py install for mozlog 13:21:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:21:15 INFO - Running setup.py install for moznetwork 13:21:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:21:15 INFO - Running setup.py install for mozprocess 13:21:15 INFO - Running setup.py install for mozprofile 13:21:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:21:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:21:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:21:15 INFO - Running setup.py install for mozrunner 13:21:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:21:15 INFO - Running setup.py install for mozscreenshot 13:21:15 INFO - Running setup.py install for moztest 13:21:16 INFO - Running setup.py install for mozversion 13:21:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:21:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:21:16 INFO - Cleaning up... 13:21:16 INFO - Return code: 0 13:21:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:21: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')]} 13:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21: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')]} 13:21:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:16 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 0x1ad9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d983b0>, '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 0x1d992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d99740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469218845.556851-1471606210', '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 13:21:16 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 13:21:16 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 13:21:16 INFO - Using env: {'DISPLAY': ':0', 13:21:16 INFO - 'HOME': '/home/cltbld', 13:21:16 INFO - 'LANG': 'en_US.UTF-8', 13:21:16 INFO - 'LANGUAGE': 'en_US:en', 13:21:16 INFO - 'LOGNAME': 'cltbld', 13:21:16 INFO - 'MAIL': '/var/mail/cltbld', 13:21:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:16 INFO - 'MOZ_NO_REMOTE': '1', 13:21:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:16 INFO - 'NO_EM_RESTART': '1', 13:21:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:16 INFO - 'PWD': '/builds/slave/test', 13:21:16 INFO - 'SHELL': '/bin/bash', 13:21:16 INFO - 'SHLVL': '1', 13:21:16 INFO - 'TERM': 'linux', 13:21:16 INFO - 'TMOUT': '86400', 13:21:16 INFO - 'USER': 'cltbld', 13:21:16 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469218845.556851-1471606210', 13:21:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:16 INFO - '_': '/tools/buildbot/bin/python'} 13:21:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:21:16 INFO - Running setup.py (path:/tmp/pip-JojVYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:21:16 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)) 13:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:21:16 INFO - Running setup.py (path:/tmp/pip-bC6Plq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:21:16 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)) 13:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:21:16 INFO - Running setup.py (path:/tmp/pip-HUSGPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:21:16 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)) 13:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:21:16 INFO - Running setup.py (path:/tmp/pip-K6D8UQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:21:16 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)) 13:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:21:16 INFO - Running setup.py (path:/tmp/pip-D8Esue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:21:16 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)) 13:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:21:16 INFO - Running setup.py (path:/tmp/pip-8CuUKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:21:16 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)) 13:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:21:16 INFO - Running setup.py (path:/tmp/pip-pifqVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:21:16 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)) 13:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:21:16 INFO - Running setup.py (path:/tmp/pip-KclCDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:21:16 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)) 13:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:21:16 INFO - Running setup.py (path:/tmp/pip-WE2eTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:21:16 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)) 13:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:21:17 INFO - Running setup.py (path:/tmp/pip-JYfOBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:21:17 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)) 13:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:21:17 INFO - Running setup.py (path:/tmp/pip-NWkCkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:21:17 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)) 13:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:21:17 INFO - Running setup.py (path:/tmp/pip-snAzP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:21:17 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)) 13:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:21:17 INFO - Running setup.py (path:/tmp/pip-TlE5od-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:21:17 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)) 13:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:21:17 INFO - Running setup.py (path:/tmp/pip-tYzVox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:21:17 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)) 13:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:21:17 INFO - Running setup.py (path:/tmp/pip-5wf9pB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:21:17 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)) 13:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:21:17 INFO - Running setup.py (path:/tmp/pip-xsVcx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:21:17 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)) 13:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:21:17 INFO - Running setup.py (path:/tmp/pip-HGayyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:21:17 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)) 13:21:17 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)) 13:21:17 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)) 13:21:17 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)) 13:21:17 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)) 13:21:17 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)) 13:21:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:21:17 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 13:21:17 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 13:21:17 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 13:21:17 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 13:21:17 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 13:21:17 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 13:21:19 INFO - Downloading blessings-1.6.tar.gz 13:21:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:21:19 INFO - Installing collected packages: blessings 13:21:19 INFO - Running setup.py install for blessings 13:21:19 INFO - Successfully installed blessings 13:21:19 INFO - Cleaning up... 13:21:19 INFO - Return code: 0 13:21:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:21:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:21:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:21:19 INFO - Reading from file tmpfile_stdout 13:21:19 INFO - Current package versions: 13:21:19 INFO - argparse == 1.2.1 13:21:19 INFO - blessings == 1.6 13:21:19 INFO - blobuploader == 1.2.4 13:21:19 INFO - docopt == 0.6.1 13:21:19 INFO - functools32 == 3.2.3-2 13:21:19 INFO - jsonschema == 2.5.1 13:21:19 INFO - manifestparser == 1.1 13:21:19 INFO - mozInstall == 1.12 13:21:19 INFO - mozcrash == 0.17 13:21:19 INFO - mozdebug == 0.1 13:21:19 INFO - mozdevice == 0.48 13:21:19 INFO - mozfile == 1.2 13:21:19 INFO - mozhttpd == 0.7 13:21:19 INFO - mozinfo == 0.9 13:21:19 INFO - mozleak == 0.1 13:21:19 INFO - mozlog == 3.3 13:21:19 INFO - moznetwork == 0.27 13:21:19 INFO - mozprocess == 0.23 13:21:19 INFO - mozprofile == 0.28 13:21:19 INFO - mozrunner == 6.12 13:21:19 INFO - mozscreenshot == 0.1 13:21:19 INFO - mozsystemmonitor == 0.3 13:21:19 INFO - moztest == 0.7 13:21:19 INFO - mozversion == 1.4 13:21:19 INFO - psutil == 3.1.1 13:21:19 INFO - requests == 1.2.3 13:21:19 INFO - wsgiref == 0.1.2 13:21:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:21:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:21:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:19 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 0x1ad9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d983b0>, '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 0x1d992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d99740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469218845.556851-1471606210', '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 13:21:19 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 13:21:19 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 13:21:19 INFO - Using env: {'DISPLAY': ':0', 13:21:19 INFO - 'HOME': '/home/cltbld', 13:21:19 INFO - 'LANG': 'en_US.UTF-8', 13:21:19 INFO - 'LANGUAGE': 'en_US:en', 13:21:19 INFO - 'LOGNAME': 'cltbld', 13:21:19 INFO - 'MAIL': '/var/mail/cltbld', 13:21:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:19 INFO - 'MOZ_NO_REMOTE': '1', 13:21:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:19 INFO - 'NO_EM_RESTART': '1', 13:21:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:19 INFO - 'PWD': '/builds/slave/test', 13:21:19 INFO - 'SHELL': '/bin/bash', 13:21:19 INFO - 'SHLVL': '1', 13:21:19 INFO - 'TERM': 'linux', 13:21:19 INFO - 'TMOUT': '86400', 13:21:19 INFO - 'USER': 'cltbld', 13:21:19 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469218845.556851-1471606210', 13:21:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:19 INFO - '_': '/tools/buildbot/bin/python'} 13:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:20 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)) 13:21:20 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)) 13:21:20 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)) 13:21:20 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)) 13:21:20 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)) 13:21:20 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)) 13:21:20 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)) 13:21:20 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)) 13:21:20 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)) 13:21:20 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)) 13:21:20 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)) 13:21:20 INFO - Cleaning up... 13:21:20 INFO - Return code: 0 13:21:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d983b0>, '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 0x1d992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d99740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469218845.556851-1471606210', '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 13:21:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:21:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:21:20 INFO - Using env: {'DISPLAY': ':0', 13:21:20 INFO - 'HOME': '/home/cltbld', 13:21:20 INFO - 'LANG': 'en_US.UTF-8', 13:21:20 INFO - 'LANGUAGE': 'en_US:en', 13:21:20 INFO - 'LOGNAME': 'cltbld', 13:21:20 INFO - 'MAIL': '/var/mail/cltbld', 13:21:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:20 INFO - 'MOZ_NO_REMOTE': '1', 13:21:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:20 INFO - 'NO_EM_RESTART': '1', 13:21:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:20 INFO - 'PWD': '/builds/slave/test', 13:21:20 INFO - 'SHELL': '/bin/bash', 13:21:20 INFO - 'SHLVL': '1', 13:21:20 INFO - 'TERM': 'linux', 13:21:20 INFO - 'TMOUT': '86400', 13:21:20 INFO - 'USER': 'cltbld', 13:21:20 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469218845.556851-1471606210', 13:21:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:20 INFO - '_': '/tools/buildbot/bin/python'} 13:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:21:20 INFO - Cleaning up... 13:21:20 INFO - Return code: 0 13:21:20 INFO - Running post-action listener: _resource_record_post_action 13:21:20 INFO - Running post-action listener: _start_resource_monitoring 13:21:20 INFO - Starting resource monitoring. 13:21:20 INFO - [mozharness: 2016-07-22 20:21:20.446777Z] Finished create-virtualenv step (success) 13:21:20 INFO - [mozharness: 2016-07-22 20:21:20.447211Z] Running install step. 13:21:20 INFO - Running pre-action listener: _resource_record_pre_action 13:21:20 INFO - Running main action method: install 13:21:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:21:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:21:20 INFO - Reading from file tmpfile_stdout 13:21:20 INFO - Detecting whether we're running mozinstall >=1.0... 13:21:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:21:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:21:20 INFO - Reading from file tmpfile_stdout 13:21:20 INFO - Output received: 13:21:20 INFO - Usage: mozinstall [options] installer 13:21:20 INFO - Options: 13:21:20 INFO - -h, --help show this help message and exit 13:21:20 INFO - -d DEST, --destination=DEST 13:21:20 INFO - Directory to install application into. [default: 13:21:20 INFO - "/builds/slave/test"] 13:21:20 INFO - --app=APP Application being installed. [default: firefox] 13:21:20 INFO - mkdir: /builds/slave/test/build/application 13:21:20 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'] 13:21:20 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 13:21:37 INFO - Reading from file tmpfile_stdout 13:21:37 INFO - Output received: 13:21:37 INFO - /builds/slave/test/build/application/firefox/firefox 13:21:37 INFO - Running post-action listener: _resource_record_post_action 13:21:37 INFO - [mozharness: 2016-07-22 20:21:37.949115Z] Finished install step (success) 13:21:37 INFO - [mozharness: 2016-07-22 20:21:37.949396Z] Running run-tests step. 13:21:37 INFO - Running pre-action listener: _resource_record_pre_action 13:21:37 INFO - Running main action method: run_tests 13:21:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:21:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:21:37 INFO - Python 2.7.3 13:21:37 INFO - Return code: 0 13:21:37 INFO - grabbing minidump binary from tooltool 13:21: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')]} 13:21:37 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 0x1d983b0>, '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 0x1d992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d99740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:21:37 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 13:21:37 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 13:21:37 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 13:21:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:21:38 INFO - Return code: 0 13:21:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:21:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:21:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:21:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:21:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:21:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:21:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:21:38 INFO - Using env: {'DISPLAY': ':0', 13:21:38 INFO - 'HOME': '/home/cltbld', 13:21:38 INFO - 'LANG': 'en_US.UTF-8', 13:21:38 INFO - 'LANGUAGE': 'en_US:en', 13:21:38 INFO - 'LOGNAME': 'cltbld', 13:21:38 INFO - 'MAIL': '/var/mail/cltbld', 13:21:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:21:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:21:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:38 INFO - 'MOZ_NO_REMOTE': '1', 13:21:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:21:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:38 INFO - 'NO_EM_RESTART': '1', 13:21:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:38 INFO - 'PWD': '/builds/slave/test', 13:21:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:21:38 INFO - 'SHELL': '/bin/bash', 13:21:38 INFO - 'SHLVL': '1', 13:21:38 INFO - 'TERM': 'linux', 13:21:38 INFO - 'TMOUT': '86400', 13:21:38 INFO - 'USER': 'cltbld', 13:21:38 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469218845.556851-1471606210', 13:21:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:38 INFO - '_': '/tools/buildbot/bin/python'} 13:21:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:21:38 INFO - mozversion application_buildid: 20160722083025 13:21:38 INFO - mozversion application_changeset: ff29f08b72c466b65dea5efa6f82f99add8f17ef 13:21:38 INFO - mozversion application_display_name: Nightly 13:21:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:21:38 INFO - mozversion application_name: Firefox 13:21:38 INFO - mozversion application_remotingname: firefox 13:21:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:21:38 INFO - mozversion application_vendor: Mozilla 13:21:38 INFO - mozversion application_version: 50.0a1 13:21:38 INFO - mozversion platform_buildid: 20160722083025 13:21:38 INFO - mozversion platform_changeset: ff29f08b72c466b65dea5efa6f82f99add8f17ef 13:21:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:21:38 INFO - mozversion platform_version: 50.0a1 13:21:38 INFO - using testdate: 1469218898 13:21:38 INFO - actual date: 1469218898 13:21:38 INFO - starting webserver on 'localhost:34487' 13:21:38 INFO - SUITE-START | Running 2 tests 13:21:38 INFO - TEST-START | dromaeo_css 13:21:38 INFO - operating with platform_type : linux_ 13:21:38 INFO - Initialising browser for dromaeo_css test... 13:21:38 INFO - TEST-INFO | started process 29200 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaNA1AV/profile http://localhost:34487/getInfo.html) 13:21:41 INFO - PROCESS | 29200 | JavaScript error: , line 0: uncaught exception: undefined 13:21:42 INFO - PROCESS | 29200 | __metrics Screen width/height:1600/1200 13:21:42 INFO - PROCESS | 29200 | colorDepth:24 13:21:42 INFO - PROCESS | 29200 | Browser inner width/height: 1024/697 13:21:42 INFO - PROCESS | 29200 | __metrics 13:21:42 INFO - PROCESS | 29200 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:21:42 INFO - PROCESS | 29200 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:21:43 INFO - PROCESS | 29200 | console.error: PushService: 13:21:43 INFO - PROCESS | 29200 | stateChangeProcessEnqueue: Error transitioning state 13:21:43 INFO - PROCESS | 29200 | UnknownError 13:21:43 INFO - TEST-INFO | 29200: exit 0 13:21:43 INFO - Browser initialized. 13:21:43 INFO - Running cycle 1/1 for dromaeo_css test... 13:21:43 INFO - TEST-INFO | started process 29286 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaNA1AV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:21:55 INFO - PROCESS | 29286 | RSS: Main: 157454336 13:21:55 INFO - PROCESS | 29286 | 13:22:46 INFO - PROCESS | 29286 | 1469218966968 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] 13:24:54 INFO - PROCESS | 29286 | Cycle 1(1): loaded http://localhost:34487/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34487/tests/dromaeo/cssquery-ext.html) 13:24:55 INFO - PROCESS | 29286 | RSS: Main: 271790080 13:24:55 INFO - PROCESS | 29286 | 13:27:58 INFO - PROCESS | 29286 | Cycle 1(1): loaded http://localhost:34487/tests/dromaeo/cssquery-ext.html (next: http://localhost:34487/tests/dromaeo/cssquery-jquery.html) 13:27:59 INFO - PROCESS | 29286 | RSS: Main: 235450368 13:27:59 INFO - PROCESS | 29286 | 13:31:01 INFO - PROCESS | 29286 | Cycle 1(1): loaded http://localhost:34487/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34487/tests/dromaeo/cssquery-mootools.html) 13:31:01 INFO - PROCESS | 29286 | RSS: Main: 213843968 13:31:01 INFO - PROCESS | 29286 | 13:34:03 INFO - PROCESS | 29286 | Cycle 1(1): loaded http://localhost:34487/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34487/tests/dromaeo/cssquery-prototype.html) 13:34:04 INFO - PROCESS | 29286 | RSS: Main: 236924928 13:34:04 INFO - PROCESS | 29286 | 13:37:06 INFO - PROCESS | 29286 | Cycle 1(1): loaded http://localhost:34487/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34487/tests/dromaeo/cssquery-yui.html) 13:37:07 INFO - PROCESS | 29286 | RSS: Main: 187289600 13:37:07 INFO - PROCESS | 29286 | 13:40:10 INFO - PROCESS | 29286 | Cycle 1(1): loaded http://localhost:34487/tests/dromaeo/cssquery-yui.html (next: http://localhost:34487/tests/dromaeo/cssquery-dojo.html) 13:40:10 INFO - PROCESS | 29286 | RSS: Main: 276439040 13:40:10 INFO - PROCESS | 29286 | 13:40:10 INFO - PROCESS | 29286 | __start_tp_report 13:40:10 INFO - PROCESS | 29286 | _x_x_mozilla_page_load 13:40:10 INFO - PROCESS | 29286 | _x_x_mozilla_page_load_details 13:40:10 INFO - PROCESS | 29286 | |i|pagename|runs| 13:40:10 INFO - PROCESS | 29286 | |0;dojo.html;3040.9543856842142;3060.5715199872006;3068.8925887593923;3078.1842811654915;3078.984605076973;5226.18994055921;5270.947290527093;5307.310049693544;5356.38401583818;5373.489518495747;5281.709505977179;5302.443243459439;5349.5720342372615;5389.326334208224;5407.702576358299;4776.28355746639;4845.927311090337;4866.489018653026;4876.366072410582;5059.696418214919;4947.529984651453;4977.676451030689;5006.299118123447;5022.146235140017;5027.069992051483;4714.717116972975;4762.642801789845;4774.498677638832;4804.75976201192;4940.25896115582;4817.253325734517;4822.95177048232;4827.831025914076;4839.201531747258;4950.0842344166085;4823.710577365369;4846.830360937385;4849.199882019462;4869.805207791684;4899.730514821684;5132.101882170605;5207.114790485626;5276.92084618731;5285.86785330366;5375.19372094189;5683.175939488751;5687.687177205252;5702.8289151325525;5704.857378565569;5713.971430142823;5736.282964629421;5749.741261643236;5753.827385178452;5757.740901659436;5760.913586296209;5217.2695822584865;5263.131583288753;5293.814716484904;5318.468153184651;5401.108817045222;5852.707364631751;5879.764809407661;5885.793997210163;5887.2052272943465;5888.646681199141;5636.154576813511;5642;5644.463775941279;5647.802326918538;5655.406182350876;5464.562834973192;5560.527355174774;5638.069718496484;5639.774409023593;5693.772249109989;5609.326880774333;5610.326760788732;5618.6628802272;5625.156226566048;5636.210930469738;5609.5792815539;5646.491815736604;5661.179129026351;5664.122061080539;5665.433456654301;4224.091820258598;4294.570542945743;4322.589354011364;4350.456192975878;4364.803583838735;3892.474515940312;3894.7857867816974;3895.2599006188734;3931.3709806430834;3944.5660977292473;5436.91844622331;5443.265159203536;5444.5916556258435;5446.754896029688;5490.396056433789;5613;5667.319921609351;5717.342505611908;5718.628289161191;5745.85635359111;5445.1832225166545;5447.046766815792;5450.427705090988;5456.836294911159;5465.426130256265;4964.90070198594;4972.651914366032;4974.17926042199;4977.576905963034;5021.974890125526;5711;5872.559558033165;5898.203742494794;5964.314103878023;5968.194293770285;5822.0684690449325;5824.359320474659;5824.970875145597;5826.271716035496;5864.413558644272;5963.135345374983;5970.134330521963;5977.551683623833;5979.910301345396;5980.252468441445;5481.698506582176;5547.0570003098765;5605;5609.523190528851;5657.60396772222;5713;5748.051571490824;5749.453801888814;5751.712414379181;5785.190073389813;5573.665580065209;5575.944240557543;5579.497845193952;5580.162975553537;5580.888382232414;5403.918941215807;5521.5306698931045;5585.218069470358;5594.356648985418;5598.552115830642;5575.498205161555;5578.86052848682;5580.330360356783;5582.106862901916;5616.269884914935;5659.462351076641;5660.094384898396;5688.14677798317;5698.1452782083015;5701.059325211294;5320.946790532045;5340.946590534045;5416.0521908666615;5497.945020549743;5532.1701744737 13:40:10 INFO - PROCESS | 29286 | |1;ext.html;570.6402148059873;583.5098517245515;608.23666298795;626.8495561065342;634.1185751804989;32124.518132228008;45539;45747.54252457475;45973.080538389215;46936;42999.785001075026;43661;46161.30758038624;46316;46551;8017.599120044004;8657.091005444432;8913.732588022369;8941.910580894173;9009.054049324825;10313.63902263421;10581.312214706059;10595.046445819875;10946.39794811285;10952.123830093573;10831.945840270788;10909.781804363947;10926.890731092666;10930.781384372307;10939.726506837353;10758.246922715412;10767;10805.675829725042;10816.837747433794;10820.13438924884;10615.31000484966;10659.253852230348;10674.09270212033;10706.732331691692;10708.946455267751;43831.561684383065;44031;44040.339394909104;44170.11659766787;44187;3332.350191712617;3378.729701623864;3379.8817041403677;3405.5062016007787;3467.809270490122;33580.49629255563;33927.83036084828;34315.48526772101;34423.48364774505;34463;4181.91636167278;4295.0847348219795;4330.610245077926;4365.3670217818235;4384.408104905829;366622;367710.1614491937;368295;369681;372218;59540.70229648824;60567.39432605617;60569.394306056376;60624.39375606276;60716;62064.68967655223;62471;62543.374566253755;62547.6872615634;62616;16760;17131.657366852593;17139.657206855794;17159.056251906015;17165.485035448706;13356.465741370237;13373.866261337456;13412.530561430303;13443.126196797177;13444.260565668787;16095.436659716854;16553.751693724604;16567.751483727512;16607.667846643;16638.75209359303;6556.328136325206;6659.2008958925235;6816.863662726718;6874.484413668894;6990.61551614666;1006.6023920551488;1025.7845852371086;1027.369932971595;1078.358376765823;1132.603588743933;33193.3361332772;33283.500747488804;33356.66643333584;33400.66599334024;33876.661233387844;981.2297346582898;1076.155218153761;1115.8828323026128;1145.4902568357002;1176.517627772609;17037.659246814994;17237.31050757981;17395.738553988154;17404.65190696179;17431.21559529799;510028;510367;511435;511846;513195;57107.42892571104;57227;57329;57395;57466.42533574694;1234.7160153164643;1264.7533730922567;1280.3918138883769;1359.320339830085;1395.7557427450156;28522.286942825765;34178.82910585431;34460.14177589866;36331;36537.45193822148;56227.43772562222;56499.71750141388;56867;56871.71564142153;56967.71516142393;496219;498364;499905;501264;501440;41837.37243941282;42696.93257668583;42785;43162.56837431585;43286.13427731491;49269.753651232946;50583.49416505788;50915.49084509107;51022.23466647929;52579.73710131425;41689.58310416857;42478;42615.36076958786;43009.354859677755;44852;41683.16633667249;41705.16589668129;41918.58081419147;42822.57177428186;43197.56802431936;36260.274794503435;43041.784791077094;43127.35308970305;45009.77495112635;46718;41478.585214147475;44565.331520027874;45706.54293457023;46585.53414465812;47264.05471890474;34075.829620851735;35391.64608353987;35490.46764298486;35537.1115722109;35733.64266357303 13:40:10 INFO - PROCESS | 29286 | |2;jquery.html;360.2345016839217;363.45481777334;384.1625256939871;390.2838291734667;400.0997755051135;15802.762958555631;17616.119194040293;19385.224591016377;20054.097565609547;20244;17572.472825815214;17877.91061044693;18395.172217250223;18435.631287374243;18437.723434148465;5800.593958422912;5832.270966129234;5959.52323814096;5963.403659634046;5974.701264936736;5749.195112684228;5844.123381492789;5848.532117430616;5850.122481627769;5855.092460668603;5723.971380143114;5760.827175184731;5786.537077033827;5813.273340832396;5839.708014599274;5683.914741278884;5802.12968054791;5814.040683287252;5814.5057670098095;5815.592908496407;4979.751012449363;5060.569851562622;5120.513551212629;5182.2485739567555;5190.32525771651;23969.640455393182;24050.759492405028;24129.396765080837;24170.274891753277;24323.87838060816;2413.855168689884;2505.962410563843;2777.3056735816044;3113.610798650146;3208.3904058228864;14485.899544565978;14676.266186690622;14711.63220919475;15044.473443429428;15061.472848450361;1956.7358406615067;1969.3796454116907;1970.8226259636701;2006.6388050150968;2055.6813693877475;82197.58901205515;82365;83915;85383;85401;9886.50567471638;10039.949800250952;10172.694819155437;10398.428086455318;11198;14225.502107426191;14225.715485690229;14235.217063061631;14236.644083897778;14260.429582816778;8096.959515202504;8333.66665333392;8349.4155409122;8546.401751877309;8595.18345757152;8313.625886835107;8329.37529685276;8378.958105209556;8493.44792588492;8604;6380.9361906380345;6403.679816009274;6413.262474815363;6548.148740663683;6616.4045235929;1779.5640068183377;1811.836934675859;1843.797182309945;1861.2554978008905;1880.990595047016;891.1266958380824;935.5930170375772;986.7039888033705;991.7223177510309;996.6063404955003;20078.598428031357;20164.798352016587;20255.493612659506;20311.79688203099;20354.491137721674;1030.721705139608;1038.2420832792104;1044.6709286574705;1053.1890444357803;1100.6037826382496;10692.251542391958;11404.144689148347;11523.193376463734;11553.768924621461;11559.537618495335;330376;490843;498322;504979;512746;79173.4089458297;81654.59172704218;93385;98012.50993745128;99595.50202249088;992.2359782967075;997.7904640025675;1037.0355569320604;1038.522279751323;1041.8020576090519;17601;17716;18494.907525462288;18852.811471885107;18924.243030279184;41540.79229603833;42123.57876421319;42333;42475.3628695576;42637.786811065744;58023;58290;59414.70292648509;59589;60869;8501.319894408309;8513.233808957224;8531.573421329032;8603.182697643713;8791.692290769792;11015.504302306255;12991.28547929873;13151.868481315447;13308.201507909556;13545.932270338586;10643.308184967953;10759.838602421127;11275.66173014811;11384.715382115182;11874.762504749684;11176.497057632589;11379.601713939972;11718.707032323919;11728.824067638821;11942.626597941347;11267;11386.316820990767;11693.649190524298;11964.820527692265;12315;7986.960065199637;8018.158093400109;8049.597520123853;8218.21926916942;8229.135940726137;8500.57497125129;10367.481625918825;11361.4887330072;11643.243189192675;11898.334233207184 13:40:10 INFO - PROCESS | 29286 | |3;mootools.html;1416.8087308213387;1465.4431316099883;1539.9153046582433;1723.2331612432472;1751.2819743904993;8550.828983420328;9131.634734610625;9147.039560846115;9148.313876459259;9150.039245879187;7606.581638009908;7845.411594130449;7851.92148078519;8037.517748935068;8955.865662015074;2309.4111001694587;2395.2335252719135;2401.231605886117;2411.4333131714034;2412.0713525292713;2358.1039205102124;2388.6178211486167;2393.760623937601;2395.209580838328;2404.759524047599;2366.3492539551676;2396.7243766966762;2397.30478161333;2401.9639705404434;2405.446747248125;2350.2714158610884;2359.4691194481275;2371.3004663624274;2371.4071482129466;2374.750651181627;2319.1419174905222;2323.3494621506006;2328.2665960222475;2330.3125577954543;2331.3239160643393;8908.554572271361;9035.367524273304;9043.819123617557;9045.502497362642;9060.229880460169;5276.393214780311;5408.945910540883;5421.701806400646;5439.782408703647;5459.099248623972;3393.355262500117;3442.431998720208;3604.459331100356;3610.0794297454245;3612.9277414451826;1138.402338772143;1144.2333636463507;1905.5998240369538;1914.15777058094;1943.0770384067455;12248.265104093784;12286.078544109228;12356.691082722913;12366.319852408114;12370.44333005017;4419.801108950105;4519.231730605805;4572.428446444194;4639.9536004640195;4641.396618439581;9390.295727820441;9392.436453812794;9407.106324899123;9422.71731848032;9426.434413935185;5191.97404012985;5192.92210616841;5196.298499702568;5197.272381866542;5198.6880787152895;4173.227952828736;4728.527147285313;4836.105320515716;4876.487968763229;4883.511648835088;3744;3769.2838360711926;3859.7877116758846;3885.9805700971315;3888.494495715539;1101.262154356583;1129.9774004519863;1134.2910680824484;1148.4143087025677;1157.1899670230873;824.4023083264585;919.866619340192;931.6180366050022;951.6288647427509;974.770928831724;5877.52979761618;5907.852303692442;6021.397860214031;6053.364396738279;6270.874582508324;956.6125719083643;983.8573406855966;1020.4489575629226;1034.1726618705006;1080.487317755149;3855.4024126260474;4025.2819432395586;4034.6887261640086;4119.423280740639;4167.374893765898;11069.778604427866;11240.662780116609;11286.7178320541;11362.03422709079;11460.02589779878;11269.154813388865;11299.887001130048;11300.378479183724;11312.830307545393;11314.660560183207;8389.07720150783;8498.150184981576;8525.914740852637;8536.146385361415;8536.829263414696;5863.472287494146;5901.409859014236;5980.970095149496;5988.071848863433;6077.058056001327;9824.508774561386;10303.227257955534;10309.690709278733;10334.121599663811;10481.266311358131;10311.587536498757;10536.051755342056;10539.104176145114;10663.040326370663;10663.200259980687;6491.1711544701775;7051.224365319708;7275.708971641075;7786.532808031537;7979.401544884041;7955.721549745731;8859.11408859109;8865.113488651341;8870.556472176495;8887.688930887389;7847.529148251123;7850.214978502333;7987.800304992422;8017.63920623585;8196.180381961994;7637.541747495168;7790.4936179150445;7813.3749300057;7820.687172513036;8156.918430815853;7014.088168538057;7149.53528020677;7153.2131465537705;7153.4277257820295;7158.06945097134;5083.66956147864;5133.281340612242;5151.175811870083;5197.818076367309;5397.298351214474;5003.77483013258;5207.6875387476875;5382.623216374816;5396.21754845553;5432.59255555827 13:40:10 INFO - PROCESS | 29286 | |4;prototype.html;300.3647285990132;317.53164082977594;328.82407911767194;332.96779982055625;335.3276680256086;5253.264542963988;5332.760240698906;5353.644396465553;5426.701531415775;5460.180972854074;5310.522053015228;5311.362636483617;5384.62692013537;5389.326334208224;5396.946030539693;4166.458360413142;4182.895427614303;4186.120914607936;4214.726042807223;4231.555686652903;3961.336238779719;4133.483314585676;4204.97897510512;4216.7680777557225;4220.9155816883795;4154.1483995780945;4165.229432554972;4169.082801783603;4170.791460426982;4175.749455032693;4148.274052040881;4153.7300075494995;4164.500779719298;4165.479315085614;4183.644390226835;3659.652333028358;3664.3770559005034;3675.3016926783826;3676.7793932364143;3687.2441149564274;5114.590832733373;5205.7397130143345;5230.790768369261;5261.605379596545;5287.41838397776;4689.39037925071;4704.553067458586;4710.222813235812;4714.740689262089;4728.69263497875;5463.480969307949;5515.917261241085;5545.528630066449;5557.527610153142;5575.804846830341;3915.530136383652;3926.9410958835642;3930.21395720857;3939.960600393988;4003.8398464061693;5473.890522189534;5660.462256085706;5779.190913272145;5836.766529338822;5852.590318677694;4032.2540330039037;4044.130511939947;4050.716449848482;4060.5127384713433;4063.512378514597;4090.3864420337186;4112.98463752759;4119.670426365884;4131.215069136854;4133.524644665842;4663.603593694506;4765.26138448541;4766.213574760195;4772.902232486547;4778.689385189951;5563.888722225533;5577.860553486114;5600.635958662755;5643.71781410936;5652.491275785199;1391.4364682303683;1407.9014468987073;1409.83082030155;1411.463643815364;1421.275149673674;855.7176131876466;900.2348004196512;906.9954650226707;923.704414587339;924.5931790012373;4766.809327626926;4830.203016502308;4836.661433699607;4847.660663753503;4873.9772994207715;5056.519630635084;5078.568321692624;5086.389633243961;5100.413452452941;5143.742812859342;4636.5131661175765;4836.540528649843;4848.95151048485;4857.344258525054;4872.73526737087;2706.9291991626424;2713.7516742298762;2722.469118521909;2724.809263351586;2743.629610002664;5232.090287045201;5238.594913306381;5259.815906443256;5270.288511051036;5279;4873.415190177201;5161.200013997836;5178.896422071537;5205.7917683293;5224.399194092728;5164.8192313268855;5178.585713143015;5187.766550505236;5202.505761952609;5209.765560549784;5017.84946451607;5134.512221338967;5142.64001519905;5173.611979101507;5241.764120614658;5083.745812709276;5329.1206950852675;5715.199872018004;5716.942830571641;5745.224394706661;5626.85932851682;5760.769569217352;5885.852853678693;5915;5919.704014799329;4066.6746660266517;4070.9389359160227;4098.323776576832;4100.958990410058;4119.134981653886;5779.162021506942;5843.772807710428;5846.766129354948;5849.298084229919;5854.443827836349;5558.082461550758;5570.273215303269;5585.961688272887;5599.468050535193;5603.1875378069135;5564.10974244119;5569.053260945568;5581.330240371181;5583.609147359646;5596.720163991866;5312.909060023683;5535.667859928417;5542.334919809648;5633.845061762411;5653.717314134195;5621.718914054362;5641.605087643826;5650.378458369658;5667.234923285304;5667.914981275367;5513.9448605513435;5544.3346798384455;5555.138953462219;5620.887582248414;5625.662460252398 13:40:10 INFO - PROCESS | 29286 | |5;yui.html;751.2825251884451;753.4951582439768;784.1648644193933;835.5529791561515;846.9322454203665;15745;16612.667746645075;16813.663726725474;16825.747613785803;16826.915865420655;13913.234772087531;13993.720125597507;13999.440022399092;14036;14060.156390616545;658.1969996604136;772.4361216312095;792.3581898662073;803.3412601666636;808.296781799835;802.7551596762985;811.4765975945542;812.7236739508566;812.959352032396;813.4427916876958;867.0505796153202;867.8134201146752;867.9609417576193;867.9913200868006;868.3443999780158;697.4037198195546;831.9708810191675;857.1899554920602;857.9270761985208;862.1077185113409;629.0972454527767;629.3014753623474;629.380060640269;629.5341447328989;629.7103332467025;14374.137551746928;14393.856061439355;14405.78391324131;14411.495597654137;14416.639584010483;14453.855461445357;14491.275436228252;14659.41362345505;14692.559223223321;14817.481388151364;12765;12889.742205155939;12928.547500837425;13152.63252614529;13556.86443135566;4460.50934397216;4507.616852567536;4556.54434556545;4556.612687921531;4758.61931045519;76350.23649763486;76609;77217;77312;78902.21097789006;11686.94156529212;11836.171467997157;11880.643580692593;11882.702932426586;12145.271283722828;21912.45218869509;21939.561208775736;21965.23121690733;21997.560048799256;22030.339089827332;7810.726624568113;8434.156584341517;8470.92462346729;8510.531920744295;8691.478511289342;4624.630029597624;4727.739974301447;4770.856874293708;4883.145449546315;4892.3884514435695;3570.696490798311;3697.648723371329;3702.777833330009;3704.629537046274;3707.5921648618632;552.71258945349;680.404645934807;683.8085336105898;685.0272612889709;685.8456847209338;629.4303655192059;717.2110678253983;733.7917045742662;749.0748775646645;756.9924300756921;9457.716268511957;9530.952345238367;9801.607935682636;9888.307818452784;9914.355566888129;718.7125149939961;732.2823632839846;741.6588369350052;758.5448730761609;763.5418748750816;5031.22016087507;5094.388673359146;5188.714620695898;5311.787528498817;5637.774489020393;121188;122423.55152896892;124332;126306;127975.36012319879;82306.58846705848;84977;86400;96358.51820740991;101134.4943275279;60097;86100.56949715212;87607.56196218978;89135.55432222797;90746.54626726825;9700.563474643517;10443.373397596168;10556.472176391304;10594.735131621772;10613.787724245318;53397.46602533925;54802.45197547974;54840.72579637076;55458;57118.42881571131;67112;67450;73738.26261737314;77619.2238077612;80520.19479805126;13783.724325513635;13872.4451021958;13991.300434978413;14292.142471451747;14317.64205894861;14366.13803171813;14394.712105758035;14531.247664086837;15399.923000384926;15453.459128930434;13703.109297895606;13757.656058598215;13840.377183026587;13974;14171.078879872775;14186.219757913414;14377.7843332348;14436.639084022563;14517;15200.239988000776;14480.565583032527;14571.271436428347;14622.488212912922;14731.631709207355;15204.695906082037;11280.60517881903;11349.432528373713;11397.259178153394;11529.250598711056;11602.477888495207;10977.506012229309;12193.12846990319;12630.494780208688;12644.936775316064;12678.239305641691 13:40:10 INFO - PROCESS | 29286 | __end_tp_report 13:40:10 INFO - PROCESS | 29286 | __start_cc_report 13:40:10 INFO - PROCESS | 29286 | _x_x_mozilla_cycle_collect,1135 13:40:10 INFO - PROCESS | 29286 | __end_cc_report 13:40:10 INFO - PROCESS | 29286 | __startTimestamp1469220010586__endTimestamp 13:40:10 INFO - PROCESS | 29286 | 13:40:10 INFO - PROCESS | 29286 | ------- Summary: start ------- 13:40:10 INFO - PROCESS | 29286 | Number of tests: 6 13:40:10 INFO - PROCESS | 29286 | 13:40:10 INFO - PROCESS | 29286 | [#0] dojo.html Cycles:165 Average:5307.15 Median:5521.53 stddev:606.24 (11.0%) stddev-sans-first:581.45 13:40:10 INFO - PROCESS | 29286 | Values: 3041.0 3060.6 3068.9 3078.2 3079.0 5226.2 5270.9 5307.3 5356.4 5373.5 5281.7 5302.4 5349.6 5389.3 5407.7 4776.3 4845.9 4866.5 4876.4 5059.7 4947.5 4977.7 5006.3 5022.1 5027.1 4714.7 4762.6 4774.5 4804.8 4940.3 4817.3 4823.0 4827.8 4839.2 4950.1 4823.7 4846.8 4849.2 4869.8 4899.7 5132.1 5207.1 5276.9 5285.9 5375.2 5683.2 5687.7 5702.8 5704.9 5714.0 5736.3 5749.7 5753.8 5757.7 5760.9 5217.3 5263.1 5293.8 5318.5 5401.1 5852.7 5879.8 5885.8 5887.2 5888.6 5636.2 5642.0 5644.5 5647.8 5655.4 5464.6 5560.5 5638.1 5639.8 5693.8 5609.3 5610.3 5618.7 5625.2 5636.2 5609.6 5646.5 5661.2 5664.1 5665.4 4224.1 4294.6 4322.6 4350.5 4364.8 3892.5 3894.8 3895.3 3931.4 3944.6 5436.9 5443.3 5444.6 5446.8 5490.4 5613.0 5667.3 5717.3 5718.6 5745.9 5445.2 5447.0 5450.4 5456.8 5465.4 4964.9 4972.7 4974.2 4977.6 5022.0 5711.0 5872.6 5898.2 5964.3 5968.2 5822.1 5824.4 5825.0 5826.3 5864.4 5963.1 5970.1 5977.6 5979.9 5980.3 5481.7 5547.1 5605.0 5609.5 5657.6 5713.0 5748.1 5749.5 5751.7 5785.2 5573.7 5575.9 5579.5 5580.2 5580.9 5403.9 5521.5 5585.2 5594.4 5598.6 5575.5 5578.9 5580.3 5582.1 5616.3 5659.5 5660.1 5688.1 5698.1 5701.1 5320.9 5340.9 5416.1 5497.9 5532.2 13:40:10 INFO - PROCESS | 29286 | 13:40:10 INFO - PROCESS | 29286 | [#1] ext.html Cycles:180 Average:63532.91 Median:23009.64 stddev:122810.21 (533.7%) stddev-sans-first:123063.74 13:40:10 INFO - PROCESS | 29286 | Values: 570.6 583.5 608.2 626.8 634.1 32124.5 45539.0 45747.5 45973.1 46936.0 42999.8 43661.0 46161.3 46316.0 46551.0 8017.6 8657.1 8913.7 8941.9 9009.1 10313.6 10581.3 10595.0 10946.4 10952.1 10831.9 10909.8 10926.9 10930.8 10939.7 10758.2 10767.0 10805.7 10816.8 10820.1 10615.3 10659.3 10674.1 10706.7 10708.9 43831.6 44031.0 44040.3 44170.1 44187.0 3332.4 3378.7 3379.9 3405.5 3467.8 33580.5 33927.8 34315.5 34423.5 34463.0 4181.9 4295.1 4330.6 4365.4 4384.4 366622.0 367710.2 368295.0 369681.0 372218.0 59540.7 60567.4 60569.4 60624.4 60716.0 62064.7 62471.0 62543.4 62547.7 62616.0 16760.0 17131.7 17139.7 17159.1 17165.5 13356.5 13373.9 13412.5 13443.1 13444.3 16095.4 16553.8 16567.8 16607.7 16638.8 6556.3 6659.2 6816.9 6874.5 6990.6 1006.6 1025.8 1027.4 1078.4 1132.6 33193.3 33283.5 33356.7 33400.7 33876.7 981.2 1076.2 1115.9 1145.5 1176.5 17037.7 17237.3 17395.7 17404.7 17431.2 510028.0 510367.0 511435.0 511846.0 513195.0 57107.4 57227.0 57329.0 57395.0 57466.4 1234.7 1264.8 1280.4 1359.3 1395.8 28522.3 34178.8 34460.1 36331.0 36537.5 56227.4 56499.7 56867.0 56871.7 56967.7 496219.0 498364.0 499905.0 501264.0 501440.0 41837.4 42696.9 42785.0 43162.6 43286.1 49269.8 50583.5 50915.5 51022.2 52579.7 41689.6 42478.0 42615.4 43009.4 44852.0 41683.2 41705.2 41918.6 42822.6 43197.6 36260.3 43041.8 43127.4 45009.8 46718.0 41478.6 44565.3 45706.5 46585.5 47264.1 34075.8 35391.6 35490.5 35537.1 35733.6 13:40:10 INFO - PROCESS | 29286 | 13:40:10 INFO - PROCESS | 29286 | [#2] jquery.html Cycles:180 Average:28604.96 Median:166792.20 stddev:78072.90 (46.8%) stddev-sans-first:78263.11 13:40:10 INFO - PROCESS | 29286 | Values: 360.2 363.5 384.2 390.3 400.1 15802.8 17616.1 19385.2 20054.1 20244.0 17572.5 17877.9 18395.2 18435.6 18437.7 5800.6 5832.3 5959.5 5963.4 5974.7 5749.2 5844.1 5848.5 5850.1 5855.1 5724.0 5760.8 5786.5 5813.3 5839.7 5683.9 5802.1 5814.0 5814.5 5815.6 4979.8 5060.6 5120.5 5182.2 5190.3 23969.6 24050.8 24129.4 24170.3 24323.9 2413.9 2506.0 2777.3 3113.6 3208.4 14485.9 14676.3 14711.6 15044.5 15061.5 1956.7 1969.4 1970.8 2006.6 2055.7 82197.6 82365.0 83915.0 85383.0 85401.0 9886.5 10039.9 10172.7 10398.4 11198.0 14225.5 14225.7 14235.2 14236.6 14260.4 8097.0 8333.7 8349.4 8546.4 8595.2 8313.6 8329.4 8379.0 8493.4 8604.0 6380.9 6403.7 6413.3 6548.1 6616.4 1779.6 1811.8 1843.8 1861.3 1881.0 891.1 935.6 986.7 991.7 996.6 20078.6 20164.8 20255.5 20311.8 20354.5 1030.7 1038.2 1044.7 1053.2 1100.6 10692.3 11404.1 11523.2 11553.8 11559.5 330376.0 490843.0 498322.0 504979.0 512746.0 79173.4 81654.6 93385.0 98012.5 99595.5 992.2 997.8 1037.0 1038.5 1041.8 17601.0 17716.0 18494.9 18852.8 18924.2 41540.8 42123.6 42333.0 42475.4 42637.8 58023.0 58290.0 59414.7 59589.0 60869.0 8501.3 8513.2 8531.6 8603.2 8791.7 11015.5 12991.3 13151.9 13308.2 13545.9 10643.3 10759.8 11275.7 11384.7 11874.8 11176.5 11379.6 11718.7 11728.8 11942.6 11267.0 11386.3 11693.6 11964.8 12315.0 7987.0 8018.2 8049.6 8218.2 8229.1 8500.6 10367.5 11361.5 11643.2 11898.3 13:40:10 INFO - PROCESS | 29286 | 13:40:10 INFO - PROCESS | 29286 | [#3] mootools.html Cycles:180 Average:5847.36 Median:4880.00 stddev:3311.15 (67.9%) stddev-sans-first:3303.70 13:40:10 INFO - PROCESS | 29286 | Values: 1416.8 1465.4 1539.9 1723.2 1751.3 8550.8 9131.6 9147.0 9148.3 9150.0 7606.6 7845.4 7851.9 8037.5 8955.9 2309.4 2395.2 2401.2 2411.4 2412.1 2358.1 2388.6 2393.8 2395.2 2404.8 2366.3 2396.7 2397.3 2402.0 2405.4 2350.3 2359.5 2371.3 2371.4 2374.8 2319.1 2323.3 2328.3 2330.3 2331.3 8908.6 9035.4 9043.8 9045.5 9060.2 5276.4 5408.9 5421.7 5439.8 5459.1 3393.4 3442.4 3604.5 3610.1 3612.9 1138.4 1144.2 1905.6 1914.2 1943.1 12248.3 12286.1 12356.7 12366.3 12370.4 4419.8 4519.2 4572.4 4640.0 4641.4 9390.3 9392.4 9407.1 9422.7 9426.4 5192.0 5192.9 5196.3 5197.3 5198.7 4173.2 4728.5 4836.1 4876.5 4883.5 3744.0 3769.3 3859.8 3886.0 3888.5 1101.3 1130.0 1134.3 1148.4 1157.2 824.4 919.9 931.6 951.6 974.8 5877.5 5907.9 6021.4 6053.4 6270.9 956.6 983.9 1020.4 1034.2 1080.5 3855.4 4025.3 4034.7 4119.4 4167.4 11069.8 11240.7 11286.7 11362.0 11460.0 11269.2 11299.9 11300.4 11312.8 11314.7 8389.1 8498.2 8525.9 8536.1 8536.8 5863.5 5901.4 5981.0 5988.1 6077.1 9824.5 10303.2 10309.7 10334.1 10481.3 10311.6 10536.1 10539.1 10663.0 10663.2 6491.2 7051.2 7275.7 7786.5 7979.4 7955.7 8859.1 8865.1 8870.6 8887.7 7847.5 7850.2 7987.8 8017.6 8196.2 7637.5 7790.5 7813.4 7820.7 8156.9 7014.1 7149.5 7153.2 7153.4 7158.1 5083.7 5133.3 5151.2 5197.8 5397.3 5003.8 5207.7 5382.6 5396.2 5432.6 13:40:10 INFO - PROCESS | 29286 | 13:40:10 INFO - PROCESS | 29286 | [#4] prototype.html Cycles:180 Average:4575.33 Median:5152.47 stddev:1334.83 (25.9%) stddev-sans-first:1299.44 13:40:10 INFO - PROCESS | 29286 | Values: 300.4 317.5 328.8 333.0 335.3 5253.3 5332.8 5353.6 5426.7 5460.2 5310.5 5311.4 5384.6 5389.3 5396.9 4166.5 4182.9 4186.1 4214.7 4231.6 3961.3 4133.5 4205.0 4216.8 4220.9 4154.1 4165.2 4169.1 4170.8 4175.7 4148.3 4153.7 4164.5 4165.5 4183.6 3659.7 3664.4 3675.3 3676.8 3687.2 5114.6 5205.7 5230.8 5261.6 5287.4 4689.4 4704.6 4710.2 4714.7 4728.7 5463.5 5515.9 5545.5 5557.5 5575.8 3915.5 3926.9 3930.2 3940.0 4003.8 5473.9 5660.5 5779.2 5836.8 5852.6 4032.3 4044.1 4050.7 4060.5 4063.5 4090.4 4113.0 4119.7 4131.2 4133.5 4663.6 4765.3 4766.2 4772.9 4778.7 5563.9 5577.9 5600.6 5643.7 5652.5 1391.4 1407.9 1409.8 1411.5 1421.3 855.7 900.2 907.0 923.7 924.6 4766.8 4830.2 4836.7 4847.7 4874.0 5056.5 5078.6 5086.4 5100.4 5143.7 4636.5 4836.5 4849.0 4857.3 4872.7 2706.9 2713.8 2722.5 2724.8 2743.6 5232.1 5238.6 5259.8 5270.3 5279.0 4873.4 5161.2 5178.9 5205.8 5224.4 5164.8 5178.6 5187.8 5202.5 5209.8 5017.8 5134.5 5142.6 5173.6 5241.8 5083.7 5329.1 5715.2 5716.9 5745.2 5626.9 5760.8 5885.9 5915.0 5919.7 4066.7 4070.9 4098.3 4101.0 4119.1 5779.2 5843.8 5846.8 5849.3 5854.4 5558.1 5570.3 5586.0 5599.5 5603.2 5564.1 5569.1 5581.3 5583.6 5596.7 5312.9 5535.7 5542.3 5633.8 5653.7 5621.7 5641.6 5650.4 5667.2 5667.9 5513.9 5544.3 5555.1 5620.9 5625.7 13:40:10 INFO - PROCESS | 29286 | 13:40:10 INFO - PROCESS | 29286 | [#5] yui.html Cycles:180 Average:21079.76 Median:4743.18 stddev:30105.94 (634.7%) stddev-sans-first:30151.70 13:40:10 INFO - PROCESS | 29286 | Values: 751.3 753.5 784.2 835.6 846.9 15745.0 16612.7 16813.7 16825.7 16826.9 13913.2 13993.7 13999.4 14036.0 14060.2 658.2 772.4 792.4 803.3 808.3 802.8 811.5 812.7 813.0 813.4 867.1 867.8 868.0 868.0 868.3 697.4 832.0 857.2 857.9 862.1 629.1 629.3 629.4 629.5 629.7 14374.1 14393.9 14405.8 14411.5 14416.6 14453.9 14491.3 14659.4 14692.6 14817.5 12765.0 12889.7 12928.5 13152.6 13556.9 4460.5 4507.6 4556.5 4556.6 4758.6 76350.2 76609.0 77217.0 77312.0 78902.2 11686.9 11836.2 11880.6 11882.7 12145.3 21912.5 21939.6 21965.2 21997.6 22030.3 7810.7 8434.2 8470.9 8510.5 8691.5 4624.6 4727.7 4770.9 4883.1 4892.4 3570.7 3697.6 3702.8 3704.6 3707.6 552.7 680.4 683.8 685.0 685.8 629.4 717.2 733.8 749.1 757.0 9457.7 9531.0 9801.6 9888.3 9914.4 718.7 732.3 741.7 758.5 763.5 5031.2 5094.4 5188.7 5311.8 5637.8 121188.0 122423.6 124332.0 126306.0 127975.4 82306.6 84977.0 86400.0 96358.5 101134.5 60097.0 86100.6 87607.6 89135.6 90746.5 9700.6 10443.4 10556.5 10594.7 10613.8 53397.5 54802.5 54840.7 55458.0 57118.4 67112.0 67450.0 73738.3 77619.2 80520.2 13783.7 13872.4 13991.3 14292.1 14317.6 14366.1 14394.7 14531.2 15399.9 15453.5 13703.1 13757.7 13840.4 13974.0 14171.1 14186.2 14377.8 14436.6 14517.0 15200.2 14480.6 14571.3 14622.5 14731.6 15204.7 11280.6 11349.4 11397.3 11529.3 11602.5 10977.5 12193.1 12630.5 12644.9 12678.2 13:40:10 INFO - PROCESS | 29286 | -------- Summary: end -------- 13:40:10 INFO - PROCESS | 29286 | 13:40:11 INFO - TEST-INFO | 29286: exit 0 13:40:11 INFO - TEST-OK | dromaeo_css | took 1113151ms 13:40:11 INFO - TEST-START | kraken 13:40:11 INFO - operating with platform_type : linux_ 13:40:11 INFO - Initialising browser for kraken test... 13:40:11 INFO - TEST-INFO | started process 29473 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppxVyF1/profile http://localhost:34487/getInfo.html) 13:40:14 INFO - PROCESS | 29473 | JavaScript error: , line 0: uncaught exception: undefined 13:40:15 INFO - PROCESS | 29473 | __metrics Screen width/height:1600/1200 13:40:15 INFO - PROCESS | 29473 | colorDepth:24 13:40:15 INFO - PROCESS | 29473 | Browser inner width/height: 1024/697 13:40:15 INFO - PROCESS | 29473 | __metrics 13:40:15 INFO - PROCESS | 29473 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:40:15 INFO - PROCESS | 29473 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:40:16 INFO - TEST-INFO | 29473: exit 0 13:40:16 INFO - Browser initialized. 13:40:16 INFO - Running cycle 1/1 for kraken test... 13:40:16 INFO - TEST-INFO | started process 29555 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppxVyF1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:40:28 INFO - PROCESS | 29555 | RSS: Main: 157126656 13:40:28 INFO - PROCESS | 29555 | 13:40:31 INFO - PROCESS | 29555 | Cycle 1(1): loaded http://localhost:34487/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34487/tests/kraken/driver.html?testName=audio-beat-detection) 13:40:32 INFO - PROCESS | 29555 | RSS: Main: 214081536 13:40:32 INFO - PROCESS | 29555 | 13:40:34 INFO - PROCESS | 29555 | Cycle 1(1): loaded http://localhost:34487/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34487/tests/kraken/driver.html?testName=audio-dft) 13:40:35 INFO - PROCESS | 29555 | RSS: Main: 187969536 13:40:35 INFO - PROCESS | 29555 | 13:40:38 INFO - PROCESS | 29555 | Cycle 1(1): loaded http://localhost:34487/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34487/tests/kraken/driver.html?testName=audio-fft) 13:40:39 INFO - PROCESS | 29555 | RSS: Main: 271093760 13:40:39 INFO - PROCESS | 29555 | 13:40:41 INFO - PROCESS | 29555 | Cycle 1(1): loaded http://localhost:34487/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34487/tests/kraken/driver.html?testName=audio-oscillator) 13:40:41 INFO - PROCESS | 29555 | RSS: Main: 180342784 13:40:41 INFO - PROCESS | 29555 | 13:40:44 INFO - PROCESS | 29555 | Cycle 1(1): loaded http://localhost:34487/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34487/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:40:44 INFO - PROCESS | 29555 | RSS: Main: 185139200 13:40:44 INFO - PROCESS | 29555 | 13:40:47 INFO - PROCESS | 29555 | Cycle 1(1): loaded http://localhost:34487/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34487/tests/kraken/driver.html?testName=imaging-darkroom) 13:40:48 INFO - PROCESS | 29555 | RSS: Main: 221978624 13:40:48 INFO - PROCESS | 29555 | 13:40:51 INFO - PROCESS | 29555 | Cycle 1(1): loaded http://localhost:34487/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34487/tests/kraken/driver.html?testName=imaging-desaturate) 13:40:52 INFO - PROCESS | 29555 | RSS: Main: 220921856 13:40:52 INFO - PROCESS | 29555 | 13:40:55 INFO - PROCESS | 29555 | Cycle 1(1): loaded http://localhost:34487/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34487/tests/kraken/driver.html?testName=json-parse-financial) 13:40:55 INFO - PROCESS | 29555 | RSS: Main: 221028352 13:40:55 INFO - PROCESS | 29555 | 13:40:57 INFO - PROCESS | 29555 | Cycle 1(1): loaded http://localhost:34487/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34487/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:40:57 INFO - PROCESS | 29555 | RSS: Main: 185290752 13:40:57 INFO - PROCESS | 29555 | 13:40:59 INFO - PROCESS | 29555 | Cycle 1(1): loaded http://localhost:34487/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34487/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:41:00 INFO - PROCESS | 29555 | RSS: Main: 190263296 13:41:00 INFO - PROCESS | 29555 | 13:41:02 INFO - PROCESS | 29555 | Cycle 1(1): loaded http://localhost:34487/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34487/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:41:02 INFO - PROCESS | 29555 | RSS: Main: 195469312 13:41:02 INFO - PROCESS | 29555 | 13:41:05 INFO - PROCESS | 29555 | Cycle 1(1): loaded http://localhost:34487/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34487/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:41:05 INFO - PROCESS | 29555 | RSS: Main: 189247488 13:41:05 INFO - PROCESS | 29555 | 13:41:08 INFO - PROCESS | 29555 | Cycle 1(1): loaded http://localhost:34487/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34487/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:41:09 INFO - PROCESS | 29555 | RSS: Main: 193855488 13:41:09 INFO - PROCESS | 29555 | 13:41:10 INFO - PROCESS | 29555 | Cycle 1(1): loaded http://localhost:34487/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34487/tests/kraken/driver.html?testName=ai-astar) 13:41:11 INFO - PROCESS | 29555 | RSS: Main: 243527680 13:41:11 INFO - PROCESS | 29555 | 13:41:11 INFO - PROCESS | 29555 | __start_tp_report 13:41:11 INFO - PROCESS | 29555 | _x_x_mozilla_page_load 13:41:11 INFO - PROCESS | 29555 | _x_x_mozilla_page_load_details 13:41:11 INFO - PROCESS | 29555 | |i|pagename|runs| 13:41:11 INFO - PROCESS | 29555 | |0;ai-astar;102;111;111;113;113;112;110;112;111;112 13:41:11 INFO - PROCESS | 29555 | |1;audio-beat-detection;152;118;120;181;118;119;145;120;150;122 13:41:11 INFO - PROCESS | 29555 | |2;audio-dft;160;160;160;159;162;160;159;161;160;160 13:41:11 INFO - PROCESS | 29555 | |3;audio-fft;77;75;74;107;75;75;74;75;101;75 13:41:11 INFO - PROCESS | 29555 | |4;audio-oscillator;85;84;117;84;84;85;123;84;84;130 13:41:11 INFO - PROCESS | 29555 | |5;imaging-gaussian-blur;116;117;116;116;117;117;117;116;117;116 13:41:11 INFO - PROCESS | 29555 | |6;imaging-darkroom;146;145;147;147;147;146;146;146;146;147 13:41:11 INFO - PROCESS | 29555 | |7;imaging-desaturate;95;94;95;95;95;94;95;95;95;95 13:41:11 INFO - PROCESS | 29555 | |8;json-parse-financial;55;54;53;54;54;54;53;53;54;53 13:41:11 INFO - PROCESS | 29555 | |9;json-stringify-tinderbox;60;61;60;60;62;61;61;61;61;61 13:41:11 INFO - PROCESS | 29555 | |10;stanford-crypto-aes;78;76;76;77;77;75;75;79;76;76 13:41:11 INFO - PROCESS | 29555 | |11;stanford-crypto-ccm;124;124;119;129;129;124;121;118;169;122 13:41:11 INFO - PROCESS | 29555 | |12;stanford-crypto-pbkdf2;159;160;157;157;159;153;159;156;159;155 13:41:11 INFO - PROCESS | 29555 | |13;stanford-crypto-sha256-iterative;62;62;62;65;61;63;63;62;63;62 13:41:11 INFO - PROCESS | 29555 | __end_tp_report 13:41:11 INFO - PROCESS | 29555 | __start_cc_report 13:41:11 INFO - PROCESS | 29555 | _x_x_mozilla_cycle_collect,1715 13:41:11 INFO - PROCESS | 29555 | __end_cc_report 13:41:11 INFO - PROCESS | 29555 | __startTimestamp1469220071109__endTimestamp 13:41:11 INFO - PROCESS | 29555 | 13:41:11 INFO - PROCESS | 29555 | ------- Summary: start ------- 13:41:11 INFO - PROCESS | 29555 | Number of tests: 14 13:41:11 INFO - PROCESS | 29555 | 13:41:11 INFO - PROCESS | 29555 | [#0] ai-astar Cycles:10 Average:110.70 Median:112.00 stddev:3.20 (2.9%) stddev-sans-first:1.00 13:41:11 INFO - PROCESS | 29555 | Values: 102.0 111.0 111.0 113.0 113.0 112.0 110.0 112.0 111.0 112.0 13:41:11 INFO - PROCESS | 29555 | 13:41:11 INFO - PROCESS | 29555 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:133.50 stddev:21.55 (16.1%) stddev-sans-first:21.91 13:41:11 INFO - PROCESS | 29555 | Values: 152.0 118.0 120.0 181.0 118.0 119.0 145.0 120.0 150.0 122.0 13:41:11 INFO - PROCESS | 29555 | 13:41:11 INFO - PROCESS | 29555 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 13:41:11 INFO - PROCESS | 29555 | Values: 160.0 160.0 160.0 159.0 162.0 160.0 159.0 161.0 160.0 160.0 13:41:11 INFO - PROCESS | 29555 | 13:41:11 INFO - PROCESS | 29555 | [#3] audio-fft Cycles:10 Average:80.80 Median:75.00 stddev:12.34 (16.4%) stddev-sans-first:13.01 13:41:11 INFO - PROCESS | 29555 | Values: 77.0 75.0 74.0 107.0 75.0 75.0 74.0 75.0 101.0 75.0 13:41:11 INFO - PROCESS | 29555 | 13:41:11 INFO - PROCESS | 29555 | [#4] audio-oscillator Cycles:10 Average:96.00 Median:84.00 stddev:19.11 (22.8%) stddev-sans-first:19.85 13:41:11 INFO - PROCESS | 29555 | Values: 85.0 84.0 117.0 84.0 84.0 85.0 123.0 84.0 84.0 130.0 13:41:11 INFO - PROCESS | 29555 | 13:41:11 INFO - PROCESS | 29555 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 13:41:11 INFO - PROCESS | 29555 | Values: 116.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 117.0 116.0 13:41:11 INFO - PROCESS | 29555 | 13:41:11 INFO - PROCESS | 29555 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 13:41:11 INFO - PROCESS | 29555 | Values: 146.0 145.0 147.0 147.0 147.0 146.0 146.0 146.0 146.0 147.0 13:41:11 INFO - PROCESS | 29555 | 13:41:11 INFO - PROCESS | 29555 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:41:11 INFO - PROCESS | 29555 | Values: 95.0 94.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 13:41:11 INFO - PROCESS | 29555 | 13:41:11 INFO - PROCESS | 29555 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:0.67 (1.2%) stddev-sans-first:0.53 13:41:11 INFO - PROCESS | 29555 | Values: 55.0 54.0 53.0 54.0 54.0 54.0 53.0 53.0 54.0 53.0 13:41:11 INFO - PROCESS | 29555 | 13:41:11 INFO - PROCESS | 29555 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 13:41:11 INFO - PROCESS | 29555 | Values: 60.0 61.0 60.0 60.0 62.0 61.0 61.0 61.0 61.0 61.0 13:41:11 INFO - PROCESS | 29555 | 13:41:11 INFO - PROCESS | 29555 | [#10] stanford-crypto-aes Cycles:10 Average:76.50 Median:76.50 stddev:1.27 (1.7%) stddev-sans-first:1.22 13:41:11 INFO - PROCESS | 29555 | Values: 78.0 76.0 76.0 77.0 77.0 75.0 75.0 79.0 76.0 76.0 13:41:11 INFO - PROCESS | 29555 | 13:41:11 INFO - PROCESS | 29555 | [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:124.00 stddev:14.90 (12.0%) stddev-sans-first:15.73 13:41:11 INFO - PROCESS | 29555 | Values: 124.0 124.0 119.0 129.0 129.0 124.0 121.0 118.0 169.0 122.0 13:41:11 INFO - PROCESS | 29555 | 13:41:11 INFO - PROCESS | 29555 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.40 Median:159.00 stddev:2.22 (1.4%) stddev-sans-first:2.28 13:41:11 INFO - PROCESS | 29555 | Values: 159.0 160.0 157.0 157.0 159.0 153.0 159.0 156.0 159.0 155.0 13:41:11 INFO - PROCESS | 29555 | 13:41:11 INFO - PROCESS | 29555 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:62.50 stddev:1.08 (1.7%) stddev-sans-first:1.13 13:41:11 INFO - PROCESS | 29555 | Values: 62.0 62.0 62.0 65.0 61.0 63.0 63.0 62.0 63.0 62.0 13:41:11 INFO - PROCESS | 29555 | -------- Summary: end -------- 13:41:11 INFO - PROCESS | 29555 | 13:41:12 INFO - TEST-INFO | 29555: exit 0 13:41:12 INFO - TEST-OK | kraken | took 60811ms 13:41:12 INFO - SUITE-END | took 1173s 13:41:12 INFO - Completed test suite (00:19:34) 13:41:12 INFO - javascript benchmark 13:41:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3040.9543856842142, 3060.5715199872006, 3068.8925887593923, 3078.1842811654915, 3078.984605076973, 5226.18994055921, 5270.947290527093, 5307.310049693544, 5356.38401583818, 5373.489518495747, 5281.709505977179, 5302.443243459439, 5349.5720342372615, 5389.326334208224, 5407.702576358299, 4776.28355746639, 4845.927311090337, 4866.489018653026, 4876.366072410582, 5059.696418214919, 4947.529984651453, 4977.676451030689, 5006.299118123447, 5022.146235140017, 5027.069992051483, 4714.717116972975, 4762.642801789845, 4774.498677638832, 4804.75976201192, 4940.25896115582, 4817.253325734517, 4822.95177048232, 4827.831025914076, 4839.201531747258, 4950.0842344166085, 4823.710577365369, 4846.830360937385, 4849.199882019462, 4869.805207791684, 4899.730514821684, 5132.101882170605, 5207.114790485626, 5276.92084618731, 5285.86785330366, 5375.19372094189, 5683.175939488751, 5687.687177205252, 5702.8289151325525, 5704.857378565569, 5713.971430142823, 5736.282964629421, 5749.741261643236, 5753.827385178452, 5757.740901659436, 5760.913586296209, 5217.2695822584865, 5263.131583288753, 5293.814716484904, 5318.468153184651, 5401.108817045222, 5852.707364631751, 5879.764809407661, 5885.793997210163, 5887.2052272943465, 5888.646681199141, 5636.154576813511, 5642.0, 5644.463775941279, 5647.802326918538, 5655.406182350876, 5464.562834973192, 5560.527355174774, 5638.069718496484, 5639.774409023593, 5693.772249109989, 5609.326880774333, 5610.326760788732, 5618.6628802272, 5625.156226566048, 5636.210930469738, 5609.5792815539, 5646.491815736604, 5661.179129026351, 5664.122061080539, 5665.433456654301, 4224.091820258598, 4294.570542945743, 4322.589354011364, 4350.456192975878, 4364.803583838735, 3892.474515940312, 3894.7857867816974, 3895.2599006188734, 3931.3709806430834, 3944.5660977292473, 5436.91844622331, 5443.265159203536, 5444.5916556258435, 5446.754896029688, 5490.396056433789, 5613.0, 5667.319921609351, 5717.342505611908, 5718.628289161191, 5745.85635359111, 5445.1832225166545, 5447.046766815792, 5450.427705090988, 5456.836294911159, 5465.426130256265, 4964.90070198594, 4972.651914366032, 4974.17926042199, 4977.576905963034, 5021.974890125526, 5711.0, 5872.559558033165, 5898.203742494794, 5964.314103878023, 5968.194293770285, 5822.0684690449325, 5824.359320474659, 5824.970875145597, 5826.271716035496, 5864.413558644272, 5963.135345374983, 5970.134330521963, 5977.551683623833, 5979.910301345396, 5980.252468441445, 5481.698506582176, 5547.0570003098765, 5605.0, 5609.523190528851, 5657.60396772222, 5713.0, 5748.051571490824, 5749.453801888814, 5751.712414379181, 5785.190073389813, 5573.665580065209, 5575.944240557543, 5579.497845193952, 5580.162975553537, 5580.888382232414, 5403.918941215807, 5521.5306698931045, 5585.218069470358, 5594.356648985418, 5598.552115830642, 5575.498205161555, 5578.86052848682, 5580.330360356783, 5582.106862901916, 5616.269884914935, 5659.462351076641, 5660.094384898396, 5688.14677798317, 5698.1452782083015, 5701.059325211294, 5320.946790532045, 5340.946590534045, 5416.0521908666615, 5497.945020549743, 5532.1701744737], "value": 5265.780335588728, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.6402148059873, 583.5098517245515, 608.23666298795, 626.8495561065342, 634.1185751804989, 32124.518132228008, 45539.0, 45747.54252457475, 45973.080538389215, 46936.0, 42999.785001075026, 43661.0, 46161.30758038624, 46316.0, 46551.0, 8017.599120044004, 8657.091005444432, 8913.732588022369, 8941.910580894173, 9009.054049324825, 10313.63902263421, 10581.312214706059, 10595.046445819875, 10946.39794811285, 10952.123830093573, 10831.945840270788, 10909.781804363947, 10926.890731092666, 10930.781384372307, 10939.726506837353, 10758.246922715412, 10767.0, 10805.675829725042, 10816.837747433794, 10820.13438924884, 10615.31000484966, 10659.253852230348, 10674.09270212033, 10706.732331691692, 10708.946455267751, 43831.561684383065, 44031.0, 44040.339394909104, 44170.11659766787, 44187.0, 3332.350191712617, 3378.729701623864, 3379.8817041403677, 3405.5062016007787, 3467.809270490122, 33580.49629255563, 33927.83036084828, 34315.48526772101, 34423.48364774505, 34463.0, 4181.91636167278, 4295.0847348219795, 4330.610245077926, 4365.3670217818235, 4384.408104905829, 366622.0, 367710.1614491937, 368295.0, 369681.0, 372218.0, 59540.70229648824, 60567.39432605617, 60569.394306056376, 60624.39375606276, 60716.0, 62064.68967655223, 62471.0, 62543.374566253755, 62547.6872615634, 62616.0, 16760.0, 17131.657366852593, 17139.657206855794, 17159.056251906015, 17165.485035448706, 13356.465741370237, 13373.866261337456, 13412.530561430303, 13443.126196797177, 13444.260565668787, 16095.436659716854, 16553.751693724604, 16567.751483727512, 16607.667846643, 16638.75209359303, 6556.328136325206, 6659.2008958925235, 6816.863662726718, 6874.484413668894, 6990.61551614666, 1006.6023920551488, 1025.7845852371086, 1027.369932971595, 1078.358376765823, 1132.603588743933, 33193.3361332772, 33283.500747488804, 33356.66643333584, 33400.66599334024, 33876.661233387844, 981.2297346582898, 1076.155218153761, 1115.8828323026128, 1145.4902568357002, 1176.517627772609, 17037.659246814994, 17237.31050757981, 17395.738553988154, 17404.65190696179, 17431.21559529799, 510028.0, 510367.0, 511435.0, 511846.0, 513195.0, 57107.42892571104, 57227.0, 57329.0, 57395.0, 57466.42533574694, 1234.7160153164643, 1264.7533730922567, 1280.3918138883769, 1359.320339830085, 1395.7557427450156, 28522.286942825765, 34178.82910585431, 34460.14177589866, 36331.0, 36537.45193822148, 56227.43772562222, 56499.71750141388, 56867.0, 56871.71564142153, 56967.71516142393, 496219.0, 498364.0, 499905.0, 501264.0, 501440.0, 41837.37243941282, 42696.93257668583, 42785.0, 43162.56837431585, 43286.13427731491, 49269.753651232946, 50583.49416505788, 50915.49084509107, 51022.23466647929, 52579.73710131425, 41689.58310416857, 42478.0, 42615.36076958786, 43009.354859677755, 44852.0, 41683.16633667249, 41705.16589668129, 41918.58081419147, 42822.57177428186, 43197.56802431936, 36260.274794503435, 43041.784791077094, 43127.35308970305, 45009.77495112635, 46718.0, 41478.585214147475, 44565.331520027874, 45706.54293457023, 46585.53414465812, 47264.05471890474, 34075.829620851735, 35391.64608353987, 35490.46764298486, 35537.1115722109, 35733.64266357303], "value": 21349.37548246733, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.2345016839217, 363.45481777334, 384.1625256939871, 390.2838291734667, 400.0997755051135, 15802.762958555631, 17616.119194040293, 19385.224591016377, 20054.097565609547, 20244.0, 17572.472825815214, 17877.91061044693, 18395.172217250223, 18435.631287374243, 18437.723434148465, 5800.593958422912, 5832.270966129234, 5959.52323814096, 5963.403659634046, 5974.701264936736, 5749.195112684228, 5844.123381492789, 5848.532117430616, 5850.122481627769, 5855.092460668603, 5723.971380143114, 5760.827175184731, 5786.537077033827, 5813.273340832396, 5839.708014599274, 5683.914741278884, 5802.12968054791, 5814.040683287252, 5814.5057670098095, 5815.592908496407, 4979.751012449363, 5060.569851562622, 5120.513551212629, 5182.2485739567555, 5190.32525771651, 23969.640455393182, 24050.759492405028, 24129.396765080837, 24170.274891753277, 24323.87838060816, 2413.855168689884, 2505.962410563843, 2777.3056735816044, 3113.610798650146, 3208.3904058228864, 14485.899544565978, 14676.266186690622, 14711.63220919475, 15044.473443429428, 15061.472848450361, 1956.7358406615067, 1969.3796454116907, 1970.8226259636701, 2006.6388050150968, 2055.6813693877475, 82197.58901205515, 82365.0, 83915.0, 85383.0, 85401.0, 9886.50567471638, 10039.949800250952, 10172.694819155437, 10398.428086455318, 11198.0, 14225.502107426191, 14225.715485690229, 14235.217063061631, 14236.644083897778, 14260.429582816778, 8096.959515202504, 8333.66665333392, 8349.4155409122, 8546.401751877309, 8595.18345757152, 8313.625886835107, 8329.37529685276, 8378.958105209556, 8493.44792588492, 8604.0, 6380.9361906380345, 6403.679816009274, 6413.262474815363, 6548.148740663683, 6616.4045235929, 1779.5640068183377, 1811.836934675859, 1843.797182309945, 1861.2554978008905, 1880.990595047016, 891.1266958380824, 935.5930170375772, 986.7039888033705, 991.7223177510309, 996.6063404955003, 20078.598428031357, 20164.798352016587, 20255.493612659506, 20311.79688203099, 20354.491137721674, 1030.721705139608, 1038.2420832792104, 1044.6709286574705, 1053.1890444357803, 1100.6037826382496, 10692.251542391958, 11404.144689148347, 11523.193376463734, 11553.768924621461, 11559.537618495335, 330376.0, 490843.0, 498322.0, 504979.0, 512746.0, 79173.4089458297, 81654.59172704218, 93385.0, 98012.50993745128, 99595.50202249088, 992.2359782967075, 997.7904640025675, 1037.0355569320604, 1038.522279751323, 1041.8020576090519, 17601.0, 17716.0, 18494.907525462288, 18852.811471885107, 18924.243030279184, 41540.79229603833, 42123.57876421319, 42333.0, 42475.3628695576, 42637.786811065744, 58023.0, 58290.0, 59414.70292648509, 59589.0, 60869.0, 8501.319894408309, 8513.233808957224, 8531.573421329032, 8603.182697643713, 8791.692290769792, 11015.504302306255, 12991.28547929873, 13151.868481315447, 13308.201507909556, 13545.932270338586, 10643.308184967953, 10759.838602421127, 11275.66173014811, 11384.715382115182, 11874.762504749684, 11176.497057632589, 11379.601713939972, 11718.707032323919, 11728.824067638821, 11942.626597941347, 11267.0, 11386.316820990767, 11693.649190524298, 11964.820527692265, 12315.0, 7986.960065199637, 8018.158093400109, 8049.597520123853, 8218.21926916942, 8229.135940726137, 8500.57497125129, 10367.481625918825, 11361.4887330072, 11643.243189192675, 11898.334233207184], "value": 9392.663356438467, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1416.8087308213387, 1465.4431316099883, 1539.9153046582433, 1723.2331612432472, 1751.2819743904993, 8550.828983420328, 9131.634734610625, 9147.039560846115, 9148.313876459259, 9150.039245879187, 7606.581638009908, 7845.411594130449, 7851.92148078519, 8037.517748935068, 8955.865662015074, 2309.4111001694587, 2395.2335252719135, 2401.231605886117, 2411.4333131714034, 2412.0713525292713, 2358.1039205102124, 2388.6178211486167, 2393.760623937601, 2395.209580838328, 2404.759524047599, 2366.3492539551676, 2396.7243766966762, 2397.30478161333, 2401.9639705404434, 2405.446747248125, 2350.2714158610884, 2359.4691194481275, 2371.3004663624274, 2371.4071482129466, 2374.750651181627, 2319.1419174905222, 2323.3494621506006, 2328.2665960222475, 2330.3125577954543, 2331.3239160643393, 8908.554572271361, 9035.367524273304, 9043.819123617557, 9045.502497362642, 9060.229880460169, 5276.393214780311, 5408.945910540883, 5421.701806400646, 5439.782408703647, 5459.099248623972, 3393.355262500117, 3442.431998720208, 3604.459331100356, 3610.0794297454245, 3612.9277414451826, 1138.402338772143, 1144.2333636463507, 1905.5998240369538, 1914.15777058094, 1943.0770384067455, 12248.265104093784, 12286.078544109228, 12356.691082722913, 12366.319852408114, 12370.44333005017, 4419.801108950105, 4519.231730605805, 4572.428446444194, 4639.9536004640195, 4641.396618439581, 9390.295727820441, 9392.436453812794, 9407.106324899123, 9422.71731848032, 9426.434413935185, 5191.97404012985, 5192.92210616841, 5196.298499702568, 5197.272381866542, 5198.6880787152895, 4173.227952828736, 4728.527147285313, 4836.105320515716, 4876.487968763229, 4883.511648835088, 3744.0, 3769.2838360711926, 3859.7877116758846, 3885.9805700971315, 3888.494495715539, 1101.262154356583, 1129.9774004519863, 1134.2910680824484, 1148.4143087025677, 1157.1899670230873, 824.4023083264585, 919.866619340192, 931.6180366050022, 951.6288647427509, 974.770928831724, 5877.52979761618, 5907.852303692442, 6021.397860214031, 6053.364396738279, 6270.874582508324, 956.6125719083643, 983.8573406855966, 1020.4489575629226, 1034.1726618705006, 1080.487317755149, 3855.4024126260474, 4025.2819432395586, 4034.6887261640086, 4119.423280740639, 4167.374893765898, 11069.778604427866, 11240.662780116609, 11286.7178320541, 11362.03422709079, 11460.02589779878, 11269.154813388865, 11299.887001130048, 11300.378479183724, 11312.830307545393, 11314.660560183207, 8389.07720150783, 8498.150184981576, 8525.914740852637, 8536.146385361415, 8536.829263414696, 5863.472287494146, 5901.409859014236, 5980.970095149496, 5988.071848863433, 6077.058056001327, 9824.508774561386, 10303.227257955534, 10309.690709278733, 10334.121599663811, 10481.266311358131, 10311.587536498757, 10536.051755342056, 10539.104176145114, 10663.040326370663, 10663.200259980687, 6491.1711544701775, 7051.224365319708, 7275.708971641075, 7786.532808031537, 7979.401544884041, 7955.721549745731, 8859.11408859109, 8865.113488651341, 8870.556472176495, 8887.688930887389, 7847.529148251123, 7850.214978502333, 7987.800304992422, 8017.63920623585, 8196.180381961994, 7637.541747495168, 7790.4936179150445, 7813.3749300057, 7820.687172513036, 8156.918430815853, 7014.088168538057, 7149.53528020677, 7153.2131465537705, 7153.4277257820295, 7158.06945097134, 5083.66956147864, 5133.281340612242, 5151.175811870083, 5197.818076367309, 5397.298351214474, 5003.77483013258, 5207.6875387476875, 5382.623216374816, 5396.21754845553, 5432.59255555827], "value": 4707.235085307614, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.3647285990132, 317.53164082977594, 328.82407911767194, 332.96779982055625, 335.3276680256086, 5253.264542963988, 5332.760240698906, 5353.644396465553, 5426.701531415775, 5460.180972854074, 5310.522053015228, 5311.362636483617, 5384.62692013537, 5389.326334208224, 5396.946030539693, 4166.458360413142, 4182.895427614303, 4186.120914607936, 4214.726042807223, 4231.555686652903, 3961.336238779719, 4133.483314585676, 4204.97897510512, 4216.7680777557225, 4220.9155816883795, 4154.1483995780945, 4165.229432554972, 4169.082801783603, 4170.791460426982, 4175.749455032693, 4148.274052040881, 4153.7300075494995, 4164.500779719298, 4165.479315085614, 4183.644390226835, 3659.652333028358, 3664.3770559005034, 3675.3016926783826, 3676.7793932364143, 3687.2441149564274, 5114.590832733373, 5205.7397130143345, 5230.790768369261, 5261.605379596545, 5287.41838397776, 4689.39037925071, 4704.553067458586, 4710.222813235812, 4714.740689262089, 4728.69263497875, 5463.480969307949, 5515.917261241085, 5545.528630066449, 5557.527610153142, 5575.804846830341, 3915.530136383652, 3926.9410958835642, 3930.21395720857, 3939.960600393988, 4003.8398464061693, 5473.890522189534, 5660.462256085706, 5779.190913272145, 5836.766529338822, 5852.590318677694, 4032.2540330039037, 4044.130511939947, 4050.716449848482, 4060.5127384713433, 4063.512378514597, 4090.3864420337186, 4112.98463752759, 4119.670426365884, 4131.215069136854, 4133.524644665842, 4663.603593694506, 4765.26138448541, 4766.213574760195, 4772.902232486547, 4778.689385189951, 5563.888722225533, 5577.860553486114, 5600.635958662755, 5643.71781410936, 5652.491275785199, 1391.4364682303683, 1407.9014468987073, 1409.83082030155, 1411.463643815364, 1421.275149673674, 855.7176131876466, 900.2348004196512, 906.9954650226707, 923.704414587339, 924.5931790012373, 4766.809327626926, 4830.203016502308, 4836.661433699607, 4847.660663753503, 4873.9772994207715, 5056.519630635084, 5078.568321692624, 5086.389633243961, 5100.413452452941, 5143.742812859342, 4636.5131661175765, 4836.540528649843, 4848.95151048485, 4857.344258525054, 4872.73526737087, 2706.9291991626424, 2713.7516742298762, 2722.469118521909, 2724.809263351586, 2743.629610002664, 5232.090287045201, 5238.594913306381, 5259.815906443256, 5270.288511051036, 5279.0, 4873.415190177201, 5161.200013997836, 5178.896422071537, 5205.7917683293, 5224.399194092728, 5164.8192313268855, 5178.585713143015, 5187.766550505236, 5202.505761952609, 5209.765560549784, 5017.84946451607, 5134.512221338967, 5142.64001519905, 5173.611979101507, 5241.764120614658, 5083.745812709276, 5329.1206950852675, 5715.199872018004, 5716.942830571641, 5745.224394706661, 5626.85932851682, 5760.769569217352, 5885.852853678693, 5915.0, 5919.704014799329, 4066.6746660266517, 4070.9389359160227, 4098.323776576832, 4100.958990410058, 4119.134981653886, 5779.162021506942, 5843.772807710428, 5846.766129354948, 5849.298084229919, 5854.443827836349, 5558.082461550758, 5570.273215303269, 5585.961688272887, 5599.468050535193, 5603.1875378069135, 5564.10974244119, 5569.053260945568, 5581.330240371181, 5583.609147359646, 5596.720163991866, 5312.909060023683, 5535.667859928417, 5542.334919809648, 5633.845061762411, 5653.717314134195, 5621.718914054362, 5641.605087643826, 5650.378458369658, 5667.234923285304, 5667.914981275367, 5513.9448605513435, 5544.3346798384455, 5555.138953462219, 5620.887582248414, 5625.662460252398], "value": 4146.583898217962, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [751.2825251884451, 753.4951582439768, 784.1648644193933, 835.5529791561515, 846.9322454203665, 15745.0, 16612.667746645075, 16813.663726725474, 16825.747613785803, 16826.915865420655, 13913.234772087531, 13993.720125597507, 13999.440022399092, 14036.0, 14060.156390616545, 658.1969996604136, 772.4361216312095, 792.3581898662073, 803.3412601666636, 808.296781799835, 802.7551596762985, 811.4765975945542, 812.7236739508566, 812.959352032396, 813.4427916876958, 867.0505796153202, 867.8134201146752, 867.9609417576193, 867.9913200868006, 868.3443999780158, 697.4037198195546, 831.9708810191675, 857.1899554920602, 857.9270761985208, 862.1077185113409, 629.0972454527767, 629.3014753623474, 629.380060640269, 629.5341447328989, 629.7103332467025, 14374.137551746928, 14393.856061439355, 14405.78391324131, 14411.495597654137, 14416.639584010483, 14453.855461445357, 14491.275436228252, 14659.41362345505, 14692.559223223321, 14817.481388151364, 12765.0, 12889.742205155939, 12928.547500837425, 13152.63252614529, 13556.86443135566, 4460.50934397216, 4507.616852567536, 4556.54434556545, 4556.612687921531, 4758.61931045519, 76350.23649763486, 76609.0, 77217.0, 77312.0, 78902.21097789006, 11686.94156529212, 11836.171467997157, 11880.643580692593, 11882.702932426586, 12145.271283722828, 21912.45218869509, 21939.561208775736, 21965.23121690733, 21997.560048799256, 22030.339089827332, 7810.726624568113, 8434.156584341517, 8470.92462346729, 8510.531920744295, 8691.478511289342, 4624.630029597624, 4727.739974301447, 4770.856874293708, 4883.145449546315, 4892.3884514435695, 3570.696490798311, 3697.648723371329, 3702.777833330009, 3704.629537046274, 3707.5921648618632, 552.71258945349, 680.404645934807, 683.8085336105898, 685.0272612889709, 685.8456847209338, 629.4303655192059, 717.2110678253983, 733.7917045742662, 749.0748775646645, 756.9924300756921, 9457.716268511957, 9530.952345238367, 9801.607935682636, 9888.307818452784, 9914.355566888129, 718.7125149939961, 732.2823632839846, 741.6588369350052, 758.5448730761609, 763.5418748750816, 5031.22016087507, 5094.388673359146, 5188.714620695898, 5311.787528498817, 5637.774489020393, 121188.0, 122423.55152896892, 124332.0, 126306.0, 127975.36012319879, 82306.58846705848, 84977.0, 86400.0, 96358.51820740991, 101134.4943275279, 60097.0, 86100.56949715212, 87607.56196218978, 89135.55432222797, 90746.54626726825, 9700.563474643517, 10443.373397596168, 10556.472176391304, 10594.735131621772, 10613.787724245318, 53397.46602533925, 54802.45197547974, 54840.72579637076, 55458.0, 57118.42881571131, 67112.0, 67450.0, 73738.26261737314, 77619.2238077612, 80520.19479805126, 13783.724325513635, 13872.4451021958, 13991.300434978413, 14292.142471451747, 14317.64205894861, 14366.13803171813, 14394.712105758035, 14531.247664086837, 15399.923000384926, 15453.459128930434, 13703.109297895606, 13757.656058598215, 13840.377183026587, 13974.0, 14171.078879872775, 14186.219757913414, 14377.7843332348, 14436.639084022563, 14517.0, 15200.239988000776, 14480.565583032527, 14571.271436428347, 14622.488212912922, 14731.631709207355, 15204.695906082037, 11280.60517881903, 11349.432528373713, 11397.259178153394, 11529.250598711056, 11602.477888495207, 10977.506012229309, 12193.12846990319, 12630.494780208688, 12644.936775316064, 12678.239305641691], "value": 7776.388794571448, "unit": "score"}], "name": "dromaeo_css", "value": 7370.323547572664, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 111.0, 113.0, 113.0, 112.0, 110.0, 112.0, 111.0, 112.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 118.0, 120.0, 181.0, 118.0, 119.0, 145.0, 120.0, 150.0, 122.0], "value": 134.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 159.0, 162.0, 160.0, 159.0, 161.0, 160.0, 160.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 74.0, 107.0, 75.0, 75.0, 74.0, 75.0, 101.0, 75.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 117.0, 84.0, 84.0, 85.0, 123.0, 84.0, 84.0, 130.0], "value": 96.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 54.0, 54.0, 54.0, 53.0, 53.0, 54.0, 53.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 60.0, 62.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 76.0, 77.0, 77.0, 75.0, 75.0, 79.0, 76.0, 76.0], "value": 76.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 124.0, 119.0, 129.0, 129.0, 124.0, 121.0, 118.0, 169.0, 122.0], "value": 127.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 157.0, 157.0, 159.0, 153.0, 159.0, 156.0, 159.0, 155.0], "value": 157.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 65.0, 61.0, 63.0, 63.0, 62.0, 63.0, 62.0], "value": 62.5, "unit": "score"}], "name": "kraken", "value": 1478.5, "alertThreshold": 2.0}]} 13:41:12 INFO - Return code: 0 13:41:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:41:12 INFO - # TBPL SUCCESS # 13:41:12 INFO - Running post-action listener: _resource_record_post_action 13:41:12 INFO - [mozharness: 2016-07-22 20:41:12.428067Z] Finished run-tests step (success) 13:41:12 INFO - Running post-run listener: _resource_record_post_run 13:41:12 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 557817856; Read time: 0; Write time: 422820 13:41:12 INFO - TinderboxPrint: CPU usage
13.0% 13:41:12 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 13:41:12 INFO - TinderboxPrint: I/O write bytes / time
557,817,856 / 422,820 13:41:12 INFO - TinderboxPrint: CPU idle
8,264.6 (86.9%) 13:41:12 INFO - TinderboxPrint: CPU user
1,197.0 (12.6%) 13:41:12 INFO - TinderboxPrint: Swap in / out
0 / 0 13:41:12 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 260063232; Read time: 0; Write time: 241808 13:41:12 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 297422848; Read time: 0; Write time: 180968 13:41:13 INFO - Running post-run listener: _upload_blobber_files 13:41:13 INFO - Blob upload gear active. 13:41:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:41:13 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 13:41:13 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'] 13:41:13 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 13:41:13 INFO - (blobuploader) - INFO - Open directory for files ... 13:41:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:41:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:41:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:41:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:41:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:41:14 INFO - (blobuploader) - INFO - Done attempting. 13:41:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:41:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:41:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:41:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:41:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:41:30 INFO - (blobuploader) - INFO - Done attempting. 13:41:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:41:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:41:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:41:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:41:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:41:31 INFO - (blobuploader) - INFO - Done attempting. 13:41:31 INFO - (blobuploader) - INFO - Iteration through files over. 13:41:31 INFO - Return code: 0 13:41:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:41:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:41:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/07bea232fd34adc47a3ec4d77e6514b2dc2e5281983bb56bdd0c47ef947bffd5190372e432de4e805e2b6cc52a5eb3c1edcd7c829bda325fa5995a6a36248b0f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cdd6e927baa57ed8c05819625f631bfc5c1f5a6148d2d3bc7e44735feb04c1f4054b37dba87da744f3182524de02151954694a6d449779997f2b897198b26cd3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/02a96fc5f54fedf068304958e01f43c7b1771086fd20b98e26f2655242be0d103711ed4a9fa84eabfe976bb42595b797a44290229abd1a6997c0a482f9e71415"} 13:41:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:41:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:41:31 INFO - Contents: 13:41:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/07bea232fd34adc47a3ec4d77e6514b2dc2e5281983bb56bdd0c47ef947bffd5190372e432de4e805e2b6cc52a5eb3c1edcd7c829bda325fa5995a6a36248b0f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cdd6e927baa57ed8c05819625f631bfc5c1f5a6148d2d3bc7e44735feb04c1f4054b37dba87da744f3182524de02151954694a6d449779997f2b897198b26cd3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/02a96fc5f54fedf068304958e01f43c7b1771086fd20b98e26f2655242be0d103711ed4a9fa84eabfe976bb42595b797a44290229abd1a6997c0a482f9e71415"} 13:41:31 INFO - Running post-run listener: copy_logs_to_upload_dir 13:41:31 INFO - Copying logs to upload dir... 13:41:31 INFO - mkdir: /builds/slave/test/build/upload/logs 13:41:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.059064 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-22 13:41:31.265925) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-22 13:41:31.271765) ========= 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=31acecf42b6a79ec49471d4a000001bb-1469218845.556851-1471606210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/07bea232fd34adc47a3ec4d77e6514b2dc2e5281983bb56bdd0c47ef947bffd5190372e432de4e805e2b6cc52a5eb3c1edcd7c829bda325fa5995a6a36248b0f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cdd6e927baa57ed8c05819625f631bfc5c1f5a6148d2d3bc7e44735feb04c1f4054b37dba87da744f3182524de02151954694a6d449779997f2b897198b26cd3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/02a96fc5f54fedf068304958e01f43c7b1771086fd20b98e26f2655242be0d103711ed4a9fa84eabfe976bb42595b797a44290229abd1a6997c0a482f9e71415"} build_url:https://queue.taskcluster.net/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011401 build_url: 'https://queue.taskcluster.net/v1/task/BbRSFxU7RfKrg4iXB4Rgyg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/07bea232fd34adc47a3ec4d77e6514b2dc2e5281983bb56bdd0c47ef947bffd5190372e432de4e805e2b6cc52a5eb3c1edcd7c829bda325fa5995a6a36248b0f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cdd6e927baa57ed8c05819625f631bfc5c1f5a6148d2d3bc7e44735feb04c1f4054b37dba87da744f3182524de02151954694a6d449779997f2b897198b26cd3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/02a96fc5f54fedf068304958e01f43c7b1771086fd20b98e26f2655242be0d103711ed4a9fa84eabfe976bb42595b797a44290229abd1a6997c0a482f9e71415"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-22 13:41:31.296521) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 13:41:31.296821) ========= 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=31acecf42b6a79ec49471d4a000001bb-1469218845.556851-1471606210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 13:41:31.380131) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-22 13:41:31.383505) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-22 13:41:31.383846) ========= ========= Total master_lag: 0.31 =========