builder: autoland_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-038 starttime: 1471536351.04 results: success (0) buildid: 20160818063002 builduid: 9600628d3255445a89095925756efb96 revision: 0552273a68a16a14ff4f7c0b6400f6f11fd8cf6e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 09:05:51.037098) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 09:05:51.037620) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 09:05:51.037923) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 09:05:51.052873) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 09:05:51.053292) ========= 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=8783db0840cc980e80bb0bd400000236-1471536350.459580-1956736234 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-18 09:05:51-- 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% 214M=0s 2016-08-18 09:05:51 (214 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.171396 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 09:05:51.239420) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 09:05:51.239748) ========= 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=8783db0840cc980e80bb0bd400000236-1471536350.459580-1956736234 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015200 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 09:05:51.289116) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 09:05:51.289483) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 0552273a68a16a14ff4f7c0b6400f6f11fd8cf6e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 0552273a68a16a14ff4f7c0b6400f6f11fd8cf6e --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=8783db0840cc980e80bb0bd400000236-1471536350.459580-1956736234 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-18 09:05:51,537 truncating revision to first 12 chars 2016-08-18 09:05:51,537 Setting DEBUG logging. 2016-08-18 09:05:51,538 attempt 1/10 2016-08-18 09:05:51,538 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/0552273a68a1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-18 09:05:51,838 unpacking tar archive at: autoland-0552273a68a1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.680732 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 09:05:51.985856) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 09:05:51.986210) ========= script_repo_revision: 0552273a68a16a14ff4f7c0b6400f6f11fd8cf6e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 09:05:51.986676) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 09:05:51.986964) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 09:05:51.997615) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-08-18 09:05:51.998019) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=8783db0840cc980e80bb0bd400000236-1471536350.459580-1956736234 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:05:52 INFO - MultiFileLogger online at 20160818 09:05:52 in /builds/slave/test 09:05:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 09:05:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:05:52 INFO - {'append_to_log': False, 09:05:52 INFO - 'base_work_dir': '/builds/slave/test', 09:05:52 INFO - 'blob_upload_branch': 'Autoland', 09:05:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:05:52 INFO - 'branch': 'Autoland', 09:05:52 INFO - 'buildbot_json_path': 'buildprops.json', 09:05:52 INFO - 'config_files': ('talos/linux_config.py',), 09:05:52 INFO - 'default_actions': ('clobber', 09:05:52 INFO - 'read-buildbot-config', 09:05:52 INFO - 'download-and-extract', 09:05:52 INFO - 'populate-webroot', 09:05:52 INFO - 'create-virtualenv', 09:05:52 INFO - 'install', 09:05:52 INFO - 'run-tests'), 09:05:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:05:52 INFO - 'download_minidump_stackwalk': True, 09:05:52 INFO - 'download_symbols': 'ondemand', 09:05:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:05:52 INFO - 'tooltool.py': '/tools/tooltool.py', 09:05:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:05:52 INFO - '/tools/misc-python/virtualenv.py')}, 09:05:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:05:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:05:52 INFO - 'installer_path': 'installer.exe', 09:05:52 INFO - 'log_level': 'info', 09:05:52 INFO - 'log_name': 'talos', 09:05:52 INFO - 'log_to_console': True, 09:05:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:05:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:05:52 INFO - 'opt_config_files': (), 09:05:52 INFO - 'pip_index': False, 09:05:52 INFO - 'sps_profile': False, 09:05:52 INFO - 'sps_profile_interval': 0, 09:05:52 INFO - 'suite': 'dromaeojs-e10s', 09:05:52 INFO - 'system_bits': '32', 09:05:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:05:52 INFO - 'title': 'talos-linux64-ix-038', 09:05:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:05:52 INFO - 'use_talos_json': True, 09:05:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:05:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:05:52 INFO - 'work_dir': 'build'} 09:05:52 INFO - [mozharness: 2016-08-18 16:05:52.334872Z] Running clobber step. 09:05:52 INFO - Running pre-action listener: _resource_record_pre_action 09:05:52 INFO - Running main action method: clobber 09:05:52 INFO - rmtree: /builds/slave/test/build 09:05:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:05:53 INFO - Running post-action listener: _resource_record_post_action 09:05:53 INFO - [mozharness: 2016-08-18 16:05:53.322149Z] Finished clobber step (success) 09:05:53 INFO - [mozharness: 2016-08-18 16:05:53.322251Z] Running read-buildbot-config step. 09:05:53 INFO - Running pre-action listener: _resource_record_pre_action 09:05:53 INFO - Running main action method: read_buildbot_config 09:05:53 INFO - Using buildbot properties: 09:05:53 INFO - { 09:05:53 INFO - "project": "", 09:05:53 INFO - "product": "firefox", 09:05:53 INFO - "script_repo_revision": "production", 09:05:53 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 09:05:53 INFO - "repository": "", 09:05:53 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs-e10s", 09:05:53 INFO - "buildid": "20160818063002", 09:05:53 INFO - "pgo_build": "True", 09:05:53 INFO - "basedir": "/builds/slave/test", 09:05:53 INFO - "buildnumber": 126, 09:05:53 INFO - "slavename": "talos-linux64-ix-038", 09:05:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:05:53 INFO - "platform": "ubuntu64_hw", 09:05:53 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 09:05:53 INFO - "branch": "autoland", 09:05:53 INFO - "repo_path": "integration/autoland", 09:05:53 INFO - "revision": "0552273a68a16a14ff4f7c0b6400f6f11fd8cf6e", 09:05:53 INFO - "stage_platform": "linux64-pgo", 09:05:53 INFO - "builduid": "9600628d3255445a89095925756efb96", 09:05:53 INFO - "slavebuilddir": "test" 09:05:53 INFO - } 09:05:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/QC_jBdDBQJaM4E7h_9NnWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 09:05:53 INFO - Running post-action listener: _resource_record_post_action 09:05:53 INFO - [mozharness: 2016-08-18 16:05:53.324698Z] Finished read-buildbot-config step (success) 09:05:53 INFO - [mozharness: 2016-08-18 16:05:53.324786Z] Running download-and-extract step. 09:05:53 INFO - Running pre-action listener: _resource_record_pre_action 09:05:53 INFO - Running main action method: download_and_extract 09:05:53 INFO - mkdir: /builds/slave/test/build/tests 09:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:53 INFO - trying https://queue.taskcluster.net/v1/task/QC_jBdDBQJaM4E7h_9NnWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:05:53 INFO - Downloading https://queue.taskcluster.net/v1/task/QC_jBdDBQJaM4E7h_9NnWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:05:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QC_jBdDBQJaM4E7h_9NnWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:05:53 INFO - Downloaded 1361 bytes. 09:05:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:05:53 INFO - Using the following test package requirements: 09:05:53 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 09:05:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:05:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:05:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:53 INFO - u'jsshell-linux-x86_64.zip'], 09:05:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:05:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 09:05:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:05:53 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:05:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:05:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:05:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:53 INFO - trying https://queue.taskcluster.net/v1/task/QC_jBdDBQJaM4E7h_9NnWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:05:53 INFO - Downloading https://queue.taskcluster.net/v1/task/QC_jBdDBQJaM4E7h_9NnWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:05:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QC_jBdDBQJaM4E7h_9NnWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:05:54 INFO - Downloaded 21907645 bytes. 09:05:54 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 09:05:59 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:59 INFO - trying https://queue.taskcluster.net/v1/task/QC_jBdDBQJaM4E7h_9NnWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:05:59 INFO - Downloading https://queue.taskcluster.net/v1/task/QC_jBdDBQJaM4E7h_9NnWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:05:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QC_jBdDBQJaM4E7h_9NnWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:06:00 INFO - Downloaded 21907645 bytes. 09:06:00 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 09:06: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:04 INFO - trying https://queue.taskcluster.net/v1/task/QC_jBdDBQJaM4E7h_9NnWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 09:06:04 INFO - Downloading https://queue.taskcluster.net/v1/task/QC_jBdDBQJaM4E7h_9NnWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 09:06:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QC_jBdDBQJaM4E7h_9NnWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:06:05 INFO - Downloaded 14413981 bytes. 09:06:05 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 09:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:05 INFO - trying https://queue.taskcluster.net/v1/task/QC_jBdDBQJaM4E7h_9NnWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:06:05 INFO - Downloading https://queue.taskcluster.net/v1/task/QC_jBdDBQJaM4E7h_9NnWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:06:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QC_jBdDBQJaM4E7h_9NnWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:06:07 INFO - Downloaded 59621576 bytes. 09:06:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QC_jBdDBQJaM4E7h_9NnWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:06:07 INFO - mkdir: /builds/slave/test/properties 09:06:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:06:07 INFO - Writing to file /builds/slave/test/properties/build_url 09:06:07 INFO - Contents: 09:06:07 INFO - build_url:https://queue.taskcluster.net/v1/task/QC_jBdDBQJaM4E7h_9NnWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:06:07 INFO - Running post-action listener: _resource_record_post_action 09:06:07 INFO - Running post-action listener: set_extra_try_arguments 09:06:07 INFO - [mozharness: 2016-08-18 16:06:07.973623Z] Finished download-and-extract step (success) 09:06:07 INFO - [mozharness: 2016-08-18 16:06:07.973851Z] Running populate-webroot step. 09:06:07 INFO - Running pre-action listener: _resource_record_pre_action 09:06:07 INFO - Running main action method: populate_webroot 09:06:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:06:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:06:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:06:07 INFO - '--tppagecycles', 09:06:07 INFO - '7'], 09:06:07 INFO - 'tests': ['tsvgm']}}, 09:06:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:06:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:06:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:06:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:06:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:06:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:06:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:07 INFO - 'talos_options': ['--disable-e10s'], 09:06:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:06:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:06:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:07 INFO - 'talos_options': ['--disable-e10s'], 09:06:07 INFO - 'tests': ['damp', 'tps']}, 09:06:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:07 INFO - 'tests': ['damp', 'tps']}, 09:06:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:06:07 INFO - 'tests': ['dromaeo_dom']}, 09:06:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:06:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:06:07 INFO - 'tests': ['basic_compositor_video']}, 09:06:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:06:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:06:07 INFO - 'tests': ['a11yr', 09:06:07 INFO - 'ts_paint', 09:06:07 INFO - 'tpaint', 09:06:07 INFO - 'sessionrestore', 09:06:07 INFO - 'sessionrestore_no_auto_restore', 09:06:07 INFO - 'tabpaint']}, 09:06:07 INFO - 'other-e10s': {'tests': ['a11yr', 09:06:07 INFO - 'ts_paint', 09:06:07 INFO - 'tpaint', 09:06:07 INFO - 'sessionrestore', 09:06:07 INFO - 'sessionrestore_no_auto_restore', 09:06:07 INFO - 'tabpaint']}, 09:06:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:06:07 INFO - 'ts_paint', 09:06:07 INFO - 'tpaint', 09:06:07 INFO - 'sessionrestore', 09:06:07 INFO - 'sessionrestore_no_auto_restore', 09:06:07 INFO - 'tabpaint']}, 09:06:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:06:07 INFO - 'ts_paint', 09:06:07 INFO - 'tpaint', 09:06:07 INFO - 'sessionrestore', 09:06:07 INFO - 'sessionrestore_no_auto_restore', 09:06:07 INFO - 'tabpaint']}, 09:06:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:06:07 INFO - 'tests': ['a11yr', 09:06:07 INFO - 'ts_paint', 09:06:07 INFO - 'tpaint', 09:06:07 INFO - 'sessionrestore', 09:06:07 INFO - 'sessionrestore_no_auto_restore', 09:06:07 INFO - 'tabpaint']}, 09:06:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:06:07 INFO - 'tests': ['a11yr', 09:06:07 INFO - 'ts_paint', 09:06:07 INFO - 'tpaint', 09:06:07 INFO - 'sessionrestore', 09:06:07 INFO - 'sessionrestore_no_auto_restore', 09:06:07 INFO - 'tabpaint']}, 09:06:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:06:07 INFO - 'tests': ['tsvgx', 09:06:07 INFO - 'tsvgr_opacity', 09:06:07 INFO - 'tart', 09:06:07 INFO - 'tscrollx', 09:06:07 INFO - 'cart']}, 09:06:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:06:07 INFO - 'tsvgr_opacity', 09:06:07 INFO - 'tart', 09:06:07 INFO - 'tscrollx', 09:06:07 INFO - 'cart']}, 09:06:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:07 INFO - 'talos_options': ['--disable-e10s'], 09:06:07 INFO - 'tests': ['tp5o']}, 09:06:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:07 INFO - 'tests': ['tp5o']}, 09:06:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:07 INFO - 'talos_options': ['--disable-e10s', 09:06:07 INFO - '--xperf_path', 09:06:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:06:07 INFO - 'tests': ['tp5n']}, 09:06:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:07 INFO - 'talos_options': ['--xperf_path', 09:06:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:06:07 INFO - 'tests': ['tp5n']}}, 09:06:07 INFO - 'talos.zip': {'path': '', 09:06:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:06:07 INFO - Running post-action listener: _resource_record_post_action 09:06:07 INFO - [mozharness: 2016-08-18 16:06:07.991120Z] Finished populate-webroot step (success) 09:06:07 INFO - [mozharness: 2016-08-18 16:06:07.991208Z] Running create-virtualenv step. 09:06:07 INFO - Running pre-action listener: _resource_record_pre_action 09:06:07 INFO - Running main action method: create_virtualenv 09:06:07 INFO - Creating virtualenv /builds/slave/test/build/venv 09:06:07 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 09:06:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:06:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:06:08 INFO - Using real prefix '/usr' 09:06:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:06:08 INFO - Installing distribute.............................................................................................................................................................................................done. 09:06:10 INFO - Installing pip.................done. 09:06:10 INFO - Return code: 0 09:06:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:10 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 0x7fba19c74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fc370>, '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 0x21ff8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ffd80>, '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': '8783db0840cc980e80bb0bd400000236-1471536350.459580-1956736234', '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 09:06:10 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 09:06:10 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 09:06:10 INFO - Using env: {'DISPLAY': ':0', 09:06:10 INFO - 'HOME': '/home/cltbld', 09:06:10 INFO - 'LANG': 'en_US.UTF-8', 09:06:10 INFO - 'LANGUAGE': 'en_US:en', 09:06:10 INFO - 'LOGNAME': 'cltbld', 09:06:10 INFO - 'MAIL': '/var/mail/cltbld', 09:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:10 INFO - 'MOZ_NO_REMOTE': '1', 09:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:10 INFO - 'NO_EM_RESTART': '1', 09:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:10 INFO - 'PWD': '/builds/slave/test', 09:06:10 INFO - 'SHELL': '/bin/bash', 09:06:10 INFO - 'SHLVL': '1', 09:06:10 INFO - 'TERM': 'linux', 09:06:10 INFO - 'TMOUT': '86400', 09:06:10 INFO - 'USER': 'cltbld', 09:06:10 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1471536350.459580-1956736234', 09:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:10 INFO - '_': '/tools/buildbot/bin/python'} 09:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:10 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 09:06:10 INFO - Cleaning up... 09:06:10 INFO - Return code: 0 09:06:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:10 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 0x7fba19c74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fc370>, '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 0x21ff8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ffd80>, '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': '8783db0840cc980e80bb0bd400000236-1471536350.459580-1956736234', '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 09:06:10 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 09:06:10 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 09:06:10 INFO - Using env: {'DISPLAY': ':0', 09:06:10 INFO - 'HOME': '/home/cltbld', 09:06:10 INFO - 'LANG': 'en_US.UTF-8', 09:06:10 INFO - 'LANGUAGE': 'en_US:en', 09:06:10 INFO - 'LOGNAME': 'cltbld', 09:06:10 INFO - 'MAIL': '/var/mail/cltbld', 09:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:10 INFO - 'MOZ_NO_REMOTE': '1', 09:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:10 INFO - 'NO_EM_RESTART': '1', 09:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:10 INFO - 'PWD': '/builds/slave/test', 09:06:10 INFO - 'SHELL': '/bin/bash', 09:06:10 INFO - 'SHLVL': '1', 09:06:10 INFO - 'TERM': 'linux', 09:06:10 INFO - 'TMOUT': '86400', 09:06:10 INFO - 'USER': 'cltbld', 09:06:10 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1471536350.459580-1956736234', 09:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:10 INFO - '_': '/tools/buildbot/bin/python'} 09:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:10 INFO - Downloading/unpacking psutil>=3.1.1 09:06:10 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 09:06:10 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 09:06:10 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 09:06:10 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 09:06:10 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 09:06:10 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 09:06:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:06:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:06:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:06:13 INFO - Installing collected packages: psutil 09:06:13 INFO - Running setup.py install for psutil 09:06:13 INFO - building 'psutil._psutil_linux' extension 09:06:13 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 09:06:13 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 09:06:13 INFO - building 'psutil._psutil_posix' extension 09:06:13 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 09:06:13 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 09:06:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:06:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:06:13 INFO - Successfully installed psutil 09:06:13 INFO - Cleaning up... 09:06:13 INFO - Return code: 0 09:06:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:13 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 0x7fba19c74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fc370>, '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 0x21ff8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ffd80>, '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': '8783db0840cc980e80bb0bd400000236-1471536350.459580-1956736234', '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 09:06:13 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 09:06:13 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 09:06:13 INFO - Using env: {'DISPLAY': ':0', 09:06:13 INFO - 'HOME': '/home/cltbld', 09:06:13 INFO - 'LANG': 'en_US.UTF-8', 09:06:13 INFO - 'LANGUAGE': 'en_US:en', 09:06:13 INFO - 'LOGNAME': 'cltbld', 09:06:13 INFO - 'MAIL': '/var/mail/cltbld', 09:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:13 INFO - 'MOZ_NO_REMOTE': '1', 09:06:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:13 INFO - 'NO_EM_RESTART': '1', 09:06:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:13 INFO - 'PWD': '/builds/slave/test', 09:06:13 INFO - 'SHELL': '/bin/bash', 09:06:13 INFO - 'SHLVL': '1', 09:06:13 INFO - 'TERM': 'linux', 09:06:13 INFO - 'TMOUT': '86400', 09:06:13 INFO - 'USER': 'cltbld', 09:06:13 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1471536350.459580-1956736234', 09:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:13 INFO - '_': '/tools/buildbot/bin/python'} 09:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:06:13 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 09:06:13 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 09:06:13 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 09:06:13 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 09:06:13 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 09:06:13 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 09:06:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:06:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:06:15 INFO - Installing collected packages: mozsystemmonitor 09:06:15 INFO - Running setup.py install for mozsystemmonitor 09:06:15 INFO - Successfully installed mozsystemmonitor 09:06:15 INFO - Cleaning up... 09:06:15 INFO - Return code: 0 09:06:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:15 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 0x7fba19c74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fc370>, '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 0x21ff8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ffd80>, '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': '8783db0840cc980e80bb0bd400000236-1471536350.459580-1956736234', '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 09:06:15 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 09:06:15 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 09:06:15 INFO - Using env: {'DISPLAY': ':0', 09:06:15 INFO - 'HOME': '/home/cltbld', 09:06:15 INFO - 'LANG': 'en_US.UTF-8', 09:06:15 INFO - 'LANGUAGE': 'en_US:en', 09:06:15 INFO - 'LOGNAME': 'cltbld', 09:06:15 INFO - 'MAIL': '/var/mail/cltbld', 09:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:15 INFO - 'MOZ_NO_REMOTE': '1', 09:06:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:15 INFO - 'NO_EM_RESTART': '1', 09:06:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:15 INFO - 'PWD': '/builds/slave/test', 09:06:15 INFO - 'SHELL': '/bin/bash', 09:06:15 INFO - 'SHLVL': '1', 09:06:15 INFO - 'TERM': 'linux', 09:06:15 INFO - 'TMOUT': '86400', 09:06:15 INFO - 'USER': 'cltbld', 09:06:15 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1471536350.459580-1956736234', 09:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:15 INFO - '_': '/tools/buildbot/bin/python'} 09:06:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:16 INFO - Downloading/unpacking jsonschema==2.5.1 09:06:16 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 09:06:16 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 09:06:16 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 09:06:16 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 09:06:16 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 09:06:16 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 09:06:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:06:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:06: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 09:06: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 09:06: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 09:06: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 09:06: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 09:06: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 09:06:18 INFO - Downloading functools32-3.2.3-2.tar.gz 09:06:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:06:18 INFO - warning: no files found matching '*.txt' 09:06:18 INFO - no previously-included directories found matching 'build' 09:06:18 INFO - no previously-included directories found matching 'dist' 09:06:18 INFO - no previously-included directories found matching '.git*' 09:06:18 INFO - Installing collected packages: jsonschema, functools32 09:06:18 INFO - Running setup.py install for functools32 09:06:18 INFO - warning: no files found matching '*.txt' 09:06:18 INFO - no previously-included directories found matching 'build' 09:06:18 INFO - no previously-included directories found matching 'dist' 09:06:18 INFO - no previously-included directories found matching '.git*' 09:06:18 INFO - Successfully installed jsonschema functools32 09:06:18 INFO - Cleaning up... 09:06:18 INFO - Return code: 0 09:06:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba19c74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fc370>, '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 0x21ff8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ffd80>, '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': '8783db0840cc980e80bb0bd400000236-1471536350.459580-1956736234', '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 09:06:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:06:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:06:18 INFO - Using env: {'DISPLAY': ':0', 09:06:18 INFO - 'HOME': '/home/cltbld', 09:06:18 INFO - 'LANG': 'en_US.UTF-8', 09:06:18 INFO - 'LANGUAGE': 'en_US:en', 09:06:18 INFO - 'LOGNAME': 'cltbld', 09:06:18 INFO - 'MAIL': '/var/mail/cltbld', 09:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:18 INFO - 'MOZ_NO_REMOTE': '1', 09:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:18 INFO - 'NO_EM_RESTART': '1', 09:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:18 INFO - 'PWD': '/builds/slave/test', 09:06:18 INFO - 'SHELL': '/bin/bash', 09:06:18 INFO - 'SHLVL': '1', 09:06:18 INFO - 'TERM': 'linux', 09:06:18 INFO - 'TMOUT': '86400', 09:06:18 INFO - 'USER': 'cltbld', 09:06:18 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1471536350.459580-1956736234', 09:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:18 INFO - '_': '/tools/buildbot/bin/python'} 09:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:06:18 INFO - Cleaning up... 09:06:18 INFO - Return code: 0 09:06:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:18 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 0x7fba19c74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fc370>, '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 0x21ff8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ffd80>, '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': '8783db0840cc980e80bb0bd400000236-1471536350.459580-1956736234', '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 09:06:18 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 09:06:18 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 09:06:18 INFO - Using env: {'DISPLAY': ':0', 09:06:18 INFO - 'HOME': '/home/cltbld', 09:06:18 INFO - 'LANG': 'en_US.UTF-8', 09:06:18 INFO - 'LANGUAGE': 'en_US:en', 09:06:18 INFO - 'LOGNAME': 'cltbld', 09:06:18 INFO - 'MAIL': '/var/mail/cltbld', 09:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:18 INFO - 'MOZ_NO_REMOTE': '1', 09:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:18 INFO - 'NO_EM_RESTART': '1', 09:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:18 INFO - 'PWD': '/builds/slave/test', 09:06:18 INFO - 'SHELL': '/bin/bash', 09:06:18 INFO - 'SHLVL': '1', 09:06:18 INFO - 'TERM': 'linux', 09:06:18 INFO - 'TMOUT': '86400', 09:06:18 INFO - 'USER': 'cltbld', 09:06:18 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1471536350.459580-1956736234', 09:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:18 INFO - '_': '/tools/buildbot/bin/python'} 09:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:18 INFO - Downloading/unpacking blobuploader==1.2.4 09:06:18 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 09:06:18 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 09:06:18 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 09:06:18 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 09:06:18 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 09:06:18 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 09:06:20 INFO - Downloading blobuploader-1.2.4.tar.gz 09:06:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:06:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:06:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:06:21 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 09:06:21 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 09:06:21 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 09:06:21 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 09:06:21 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 09:06:21 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 09:06:21 INFO - Downloading docopt-0.6.1.tar.gz 09:06:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:06:21 INFO - Installing collected packages: blobuploader, requests, docopt 09:06:21 INFO - Running setup.py install for blobuploader 09:06:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:06:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:06:21 INFO - Running setup.py install for requests 09:06:21 INFO - Running setup.py install for docopt 09:06:22 INFO - Successfully installed blobuploader requests docopt 09:06:22 INFO - Cleaning up... 09:06:22 INFO - Return code: 0 09:06:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:22 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 0x7fba19c74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fc370>, '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 0x21ff8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ffd80>, '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': '8783db0840cc980e80bb0bd400000236-1471536350.459580-1956736234', '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 09:06:22 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 09:06:22 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 09:06:22 INFO - Using env: {'DISPLAY': ':0', 09:06:22 INFO - 'HOME': '/home/cltbld', 09:06:22 INFO - 'LANG': 'en_US.UTF-8', 09:06:22 INFO - 'LANGUAGE': 'en_US:en', 09:06:22 INFO - 'LOGNAME': 'cltbld', 09:06:22 INFO - 'MAIL': '/var/mail/cltbld', 09:06:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:22 INFO - 'MOZ_NO_REMOTE': '1', 09:06:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:22 INFO - 'NO_EM_RESTART': '1', 09:06:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:22 INFO - 'PWD': '/builds/slave/test', 09:06:22 INFO - 'SHELL': '/bin/bash', 09:06:22 INFO - 'SHLVL': '1', 09:06:22 INFO - 'TERM': 'linux', 09:06:22 INFO - 'TMOUT': '86400', 09:06:22 INFO - 'USER': 'cltbld', 09:06:22 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1471536350.459580-1956736234', 09:06:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:22 INFO - '_': '/tools/buildbot/bin/python'} 09:06:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:06:22 INFO - Running setup.py (path:/tmp/pip-_WVzQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:06:22 INFO - Running setup.py (path:/tmp/pip-E23gmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:06:22 INFO - Running setup.py (path:/tmp/pip-mVPhBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:06:22 INFO - Running setup.py (path:/tmp/pip-hjfw7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:06:22 INFO - Running setup.py (path:/tmp/pip-yrzxFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:06:22 INFO - Running setup.py (path:/tmp/pip-qygh2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:06:22 INFO - Running setup.py (path:/tmp/pip-GSnmuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:06:22 INFO - Running setup.py (path:/tmp/pip-j2z9wz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:06:22 INFO - Running setup.py (path:/tmp/pip-23zt0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:06:22 INFO - Running setup.py (path:/tmp/pip-cX8VLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:06:23 INFO - Running setup.py (path:/tmp/pip-zeFfow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:06:23 INFO - Running setup.py (path:/tmp/pip-k24sd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:06:23 INFO - Running setup.py (path:/tmp/pip-l1L4Yx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:06:23 INFO - Running setup.py (path:/tmp/pip-nLyk80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:06:23 INFO - Running setup.py (path:/tmp/pip-vKl9ox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:06:23 INFO - Running setup.py (path:/tmp/pip-9jYK8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:06:23 INFO - Running setup.py (path:/tmp/pip-nnC0tz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:06:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:06:23 INFO - Running setup.py install for manifestparser 09:06:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:06:23 INFO - Running setup.py install for mozcrash 09:06:23 INFO - Running setup.py install for mozdebug 09:06:23 INFO - Running setup.py install for mozdevice 09:06:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:06:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:06:23 INFO - Running setup.py install for mozfile 09:06:24 INFO - Running setup.py install for mozhttpd 09:06:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:06:24 INFO - Running setup.py install for mozinfo 09:06:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:06:24 INFO - Running setup.py install for mozInstall 09:06:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:06:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:06:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:06:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:06:24 INFO - Running setup.py install for mozleak 09:06:24 INFO - Running setup.py install for mozlog 09:06:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:06:24 INFO - Running setup.py install for moznetwork 09:06:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:06:24 INFO - Running setup.py install for mozprocess 09:06:24 INFO - Running setup.py install for mozprofile 09:06:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:06:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:06:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:06:24 INFO - Running setup.py install for mozrunner 09:06:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:06:24 INFO - Running setup.py install for mozscreenshot 09:06:25 INFO - Running setup.py install for moztest 09:06:25 INFO - Running setup.py install for mozversion 09:06:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:06:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:06:25 INFO - Cleaning up... 09:06:25 INFO - Return code: 0 09:06:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:06:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:25 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 0x7fba19c74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fc370>, '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 0x21ff8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ffd80>, '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': '8783db0840cc980e80bb0bd400000236-1471536350.459580-1956736234', '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 09:06:25 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 09:06:25 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 09:06:25 INFO - Using env: {'DISPLAY': ':0', 09:06:25 INFO - 'HOME': '/home/cltbld', 09:06:25 INFO - 'LANG': 'en_US.UTF-8', 09:06:25 INFO - 'LANGUAGE': 'en_US:en', 09:06:25 INFO - 'LOGNAME': 'cltbld', 09:06:25 INFO - 'MAIL': '/var/mail/cltbld', 09:06:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:25 INFO - 'MOZ_NO_REMOTE': '1', 09:06:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:25 INFO - 'NO_EM_RESTART': '1', 09:06:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:25 INFO - 'PWD': '/builds/slave/test', 09:06:25 INFO - 'SHELL': '/bin/bash', 09:06:25 INFO - 'SHLVL': '1', 09:06:25 INFO - 'TERM': 'linux', 09:06:25 INFO - 'TMOUT': '86400', 09:06:25 INFO - 'USER': 'cltbld', 09:06:25 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1471536350.459580-1956736234', 09:06:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:25 INFO - '_': '/tools/buildbot/bin/python'} 09:06:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:06:25 INFO - Running setup.py (path:/tmp/pip-ROEz5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:06:25 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)) 09:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:06:25 INFO - Running setup.py (path:/tmp/pip-f9EDx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:06:25 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)) 09:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:06:25 INFO - Running setup.py (path:/tmp/pip-0MpoVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:06:25 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)) 09:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:06:25 INFO - Running setup.py (path:/tmp/pip-Oq7Mrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:06:25 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)) 09:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:06:25 INFO - Running setup.py (path:/tmp/pip-oZoTy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:06:25 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)) 09:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:06:25 INFO - Running setup.py (path:/tmp/pip-CipjQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:06:25 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)) 09:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:06:25 INFO - Running setup.py (path:/tmp/pip-wqP3wi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:06:26 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)) 09:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:06:26 INFO - Running setup.py (path:/tmp/pip-CmLyRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:06:26 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)) 09:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:06:26 INFO - Running setup.py (path:/tmp/pip-1uPwQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:06:26 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)) 09:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:06:26 INFO - Running setup.py (path:/tmp/pip-VVoCPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:06:26 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)) 09:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:06:26 INFO - Running setup.py (path:/tmp/pip-ZdIfOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:06:26 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)) 09:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:06:26 INFO - Running setup.py (path:/tmp/pip-N7sQRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:06:26 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)) 09:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:06:26 INFO - Running setup.py (path:/tmp/pip-1WiNDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:06:26 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)) 09:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:06:26 INFO - Running setup.py (path:/tmp/pip-fGwr80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:06:26 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)) 09:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:06:26 INFO - Running setup.py (path:/tmp/pip-tEeFm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:06:26 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)) 09:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:06:26 INFO - Running setup.py (path:/tmp/pip-1qRPGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:06:26 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)) 09:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:06:26 INFO - Running setup.py (path:/tmp/pip-hUW6Mo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:06:26 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)) 09:06:26 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)) 09:06:26 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)) 09:06:26 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)) 09:06:26 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)) 09:06:26 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)) 09:06:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:28 INFO - Downloading blessings-1.6.tar.gz 09:06:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:06:28 INFO - Installing collected packages: blessings 09:06:28 INFO - Running setup.py install for blessings 09:06:28 INFO - Successfully installed blessings 09:06:28 INFO - Cleaning up... 09:06:29 INFO - Return code: 0 09:06:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:06:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:06:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:06:29 INFO - Reading from file tmpfile_stdout 09:06:29 INFO - Current package versions: 09:06:29 INFO - argparse == 1.2.1 09:06:29 INFO - blessings == 1.6 09:06:29 INFO - blobuploader == 1.2.4 09:06:29 INFO - docopt == 0.6.1 09:06:29 INFO - functools32 == 3.2.3-2 09:06:29 INFO - jsonschema == 2.5.1 09:06:29 INFO - manifestparser == 1.1 09:06:29 INFO - mozInstall == 1.12 09:06:29 INFO - mozcrash == 0.17 09:06:29 INFO - mozdebug == 0.1 09:06:29 INFO - mozdevice == 0.48 09:06:29 INFO - mozfile == 1.2 09:06:29 INFO - mozhttpd == 0.7 09:06:29 INFO - mozinfo == 0.9 09:06:29 INFO - mozleak == 0.1 09:06:29 INFO - mozlog == 3.3 09:06:29 INFO - moznetwork == 0.27 09:06:29 INFO - mozprocess == 0.23 09:06:29 INFO - mozprofile == 0.28 09:06:29 INFO - mozrunner == 6.12 09:06:29 INFO - mozscreenshot == 0.1 09:06:29 INFO - mozsystemmonitor == 0.3 09:06:29 INFO - moztest == 0.7 09:06:29 INFO - mozversion == 1.4 09:06:29 INFO - psutil == 3.1.1 09:06:29 INFO - requests == 1.2.3 09:06:29 INFO - wsgiref == 0.1.2 09:06:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:29 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 0x7fba19c74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fc370>, '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 0x21ff8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ffd80>, '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': '8783db0840cc980e80bb0bd400000236-1471536350.459580-1956736234', '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 09:06:29 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 09:06:29 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 09:06:29 INFO - Using env: {'DISPLAY': ':0', 09:06:29 INFO - 'HOME': '/home/cltbld', 09:06:29 INFO - 'LANG': 'en_US.UTF-8', 09:06:29 INFO - 'LANGUAGE': 'en_US:en', 09:06:29 INFO - 'LOGNAME': 'cltbld', 09:06:29 INFO - 'MAIL': '/var/mail/cltbld', 09:06:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:29 INFO - 'MOZ_NO_REMOTE': '1', 09:06:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:29 INFO - 'NO_EM_RESTART': '1', 09:06:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:29 INFO - 'PWD': '/builds/slave/test', 09:06:29 INFO - 'SHELL': '/bin/bash', 09:06:29 INFO - 'SHLVL': '1', 09:06:29 INFO - 'TERM': 'linux', 09:06:29 INFO - 'TMOUT': '86400', 09:06:29 INFO - 'USER': 'cltbld', 09:06:29 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1471536350.459580-1956736234', 09:06:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:29 INFO - '_': '/tools/buildbot/bin/python'} 09:06:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:29 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)) 09:06:29 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)) 09:06:29 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)) 09:06:29 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)) 09:06:29 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)) 09:06:29 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)) 09:06:29 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)) 09:06:29 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)) 09:06:29 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)) 09:06:29 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)) 09:06:29 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)) 09:06:29 INFO - Cleaning up... 09:06:29 INFO - Return code: 0 09:06:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba19c74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fc370>, '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 0x21ff8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ffd80>, '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': '8783db0840cc980e80bb0bd400000236-1471536350.459580-1956736234', '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 09:06:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:06:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:06:29 INFO - Using env: {'DISPLAY': ':0', 09:06:29 INFO - 'HOME': '/home/cltbld', 09:06:29 INFO - 'LANG': 'en_US.UTF-8', 09:06:29 INFO - 'LANGUAGE': 'en_US:en', 09:06:29 INFO - 'LOGNAME': 'cltbld', 09:06:29 INFO - 'MAIL': '/var/mail/cltbld', 09:06:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:29 INFO - 'MOZ_NO_REMOTE': '1', 09:06:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:29 INFO - 'NO_EM_RESTART': '1', 09:06:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:29 INFO - 'PWD': '/builds/slave/test', 09:06:29 INFO - 'SHELL': '/bin/bash', 09:06:29 INFO - 'SHLVL': '1', 09:06:29 INFO - 'TERM': 'linux', 09:06:29 INFO - 'TMOUT': '86400', 09:06:29 INFO - 'USER': 'cltbld', 09:06:29 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1471536350.459580-1956736234', 09:06:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:29 INFO - '_': '/tools/buildbot/bin/python'} 09:06:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:06:29 INFO - Cleaning up... 09:06:29 INFO - Return code: 0 09:06:29 INFO - Running post-action listener: _resource_record_post_action 09:06:29 INFO - Running post-action listener: _start_resource_monitoring 09:06:29 INFO - Starting resource monitoring. 09:06:29 INFO - [mozharness: 2016-08-18 16:06:29.809041Z] Finished create-virtualenv step (success) 09:06:29 INFO - [mozharness: 2016-08-18 16:06:29.809503Z] Running install step. 09:06:29 INFO - Running pre-action listener: _resource_record_pre_action 09:06:29 INFO - Running main action method: install 09:06:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:06:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:06:30 INFO - Reading from file tmpfile_stdout 09:06:30 INFO - Detecting whether we're running mozinstall >=1.0... 09:06:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:06:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:06:30 INFO - Reading from file tmpfile_stdout 09:06:30 INFO - Output received: 09:06:30 INFO - Usage: mozinstall [options] installer 09:06:30 INFO - Options: 09:06:30 INFO - -h, --help show this help message and exit 09:06:30 INFO - -d DEST, --destination=DEST 09:06:30 INFO - Directory to install application into. [default: 09:06:30 INFO - "/builds/slave/test"] 09:06:30 INFO - --app=APP Application being installed. [default: firefox] 09:06:30 INFO - mkdir: /builds/slave/test/build/application 09:06:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:06:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:06:47 INFO - Reading from file tmpfile_stdout 09:06:47 INFO - Output received: 09:06:47 INFO - /builds/slave/test/build/application/firefox/firefox 09:06:47 INFO - Running post-action listener: _resource_record_post_action 09:06:47 INFO - [mozharness: 2016-08-18 16:06:47.073624Z] Finished install step (success) 09:06:47 INFO - [mozharness: 2016-08-18 16:06:47.073873Z] Running run-tests step. 09:06:47 INFO - Running pre-action listener: _resource_record_pre_action 09:06:47 INFO - Running main action method: run_tests 09:06:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:06:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:06:47 INFO - Python 2.7.3 09:06:47 INFO - Return code: 0 09:06:47 INFO - grabbing minidump binary from tooltool 09:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:47 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 0x21fc370>, '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 0x21ff8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ffd80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:06:47 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 09:06:47 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 09:06:47 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 09:06:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:06:47 INFO - Return code: 0 09:06:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:06:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:06:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:06:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:06:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:06:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QC_jBdDBQJaM4E7h_9NnWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:06:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QC_jBdDBQJaM4E7h_9NnWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:06:47 INFO - Using env: {'DISPLAY': ':0', 09:06:47 INFO - 'HOME': '/home/cltbld', 09:06:47 INFO - 'LANG': 'en_US.UTF-8', 09:06:47 INFO - 'LANGUAGE': 'en_US:en', 09:06:47 INFO - 'LOGNAME': 'cltbld', 09:06:47 INFO - 'MAIL': '/var/mail/cltbld', 09:06:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:06:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:47 INFO - 'MOZ_NO_REMOTE': '1', 09:06:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:06:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:47 INFO - 'NO_EM_RESTART': '1', 09:06:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:47 INFO - 'PWD': '/builds/slave/test', 09:06:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:06:47 INFO - 'SHELL': '/bin/bash', 09:06:47 INFO - 'SHLVL': '1', 09:06:47 INFO - 'TERM': 'linux', 09:06:47 INFO - 'TMOUT': '86400', 09:06:47 INFO - 'USER': 'cltbld', 09:06:47 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1471536350.459580-1956736234', 09:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:47 INFO - '_': '/tools/buildbot/bin/python'} 09:06:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QC_jBdDBQJaM4E7h_9NnWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:06:47 INFO - mozversion application_buildid: 20160818063002 09:06:47 INFO - mozversion application_changeset: 0552273a68a16a14ff4f7c0b6400f6f11fd8cf6e 09:06:47 INFO - mozversion application_display_name: Nightly 09:06:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:06:47 INFO - mozversion application_name: Firefox 09:06:47 INFO - mozversion application_remotingname: firefox 09:06:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 09:06:47 INFO - mozversion application_vendor: Mozilla 09:06:47 INFO - mozversion application_version: 51.0a1 09:06:47 INFO - mozversion platform_buildid: 20160818063002 09:06:47 INFO - mozversion platform_changeset: 0552273a68a16a14ff4f7c0b6400f6f11fd8cf6e 09:06:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 09:06:47 INFO - mozversion platform_version: 51.0a1 09:06:47 INFO - using testdate: 1471536407 09:06:47 INFO - actual date: 1471536407 09:06:47 INFO - starting webserver on 'localhost:60976' 09:06:47 INFO - SUITE-START | Running 2 tests 09:06:47 INFO - TEST-START | dromaeo_css 09:06:47 INFO - operating with platform_type : linux_ 09:06:47 INFO - Initialising browser for dromaeo_css test... 09:06:47 INFO - TEST-INFO | started process 8494 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeTEvIa/profile http://localhost:60976/getInfo.html) 09:06:52 INFO - PROCESS | 8494 | __metrics Screen width/height:1600/1200 09:06:52 INFO - PROCESS | 8494 | colorDepth:24 09:06:52 INFO - PROCESS | 8494 | Browser inner width/height: 1024/697 09:06:52 INFO - PROCESS | 8494 | __metrics 09:06:52 ERROR - PROCESS | 8494 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 09:06:53 INFO - TEST-INFO | 8494: exit 0 09:06:53 INFO - Browser initialized. 09:06:53 INFO - Running cycle 1/1 for dromaeo_css test... 09:06:53 INFO - TEST-INFO | started process 8614 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeTEvIa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:07:05 INFO - PROCESS | 8614 | RSS: Main: 163160064 09:07:05 INFO - PROCESS | 8614 | 09:07:55 INFO - PROCESS | 8614 | 1471536475258 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] 09:10:04 INFO - PROCESS | 8614 | Cycle 1(1): loaded http://localhost:60976/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60976/tests/dromaeo/cssquery-ext.html) 09:10:06 INFO - PROCESS | 8614 | RSS: Main: 165371904 09:10:06 INFO - PROCESS | 8614 | 09:13:08 INFO - PROCESS | 8614 | Cycle 1(1): loaded http://localhost:60976/tests/dromaeo/cssquery-ext.html (next: http://localhost:60976/tests/dromaeo/cssquery-jquery.html) 09:13:08 INFO - PROCESS | 8614 | RSS: Main: 165605376 09:13:08 INFO - PROCESS | 8614 | 09:16:10 INFO - PROCESS | 8614 | Cycle 1(1): loaded http://localhost:60976/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60976/tests/dromaeo/cssquery-mootools.html) 09:16:11 INFO - PROCESS | 8614 | RSS: Main: 166150144 09:16:11 INFO - PROCESS | 8614 | 09:19:13 INFO - PROCESS | 8614 | Cycle 1(1): loaded http://localhost:60976/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60976/tests/dromaeo/cssquery-prototype.html) 09:19:13 INFO - PROCESS | 8614 | RSS: Main: 163426304 09:19:13 INFO - PROCESS | 8614 | 09:22:16 INFO - PROCESS | 8614 | Cycle 1(1): loaded http://localhost:60976/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60976/tests/dromaeo/cssquery-yui.html) 09:22:17 INFO - PROCESS | 8614 | RSS: Main: 166813696 09:22:17 INFO - PROCESS | 8614 | 09:25:19 INFO - PROCESS | 8614 | Cycle 1(1): loaded http://localhost:60976/tests/dromaeo/cssquery-yui.html (next: http://localhost:60976/tests/dromaeo/cssquery-dojo.html) 09:25:19 INFO - PROCESS | 8614 | RSS: Main: 166289408 09:25:19 INFO - PROCESS | 8614 | 09:25:19 INFO - PROCESS | 8614 | __start_tp_report 09:25:19 INFO - PROCESS | 8614 | _x_x_mozilla_page_load 09:25:19 INFO - PROCESS | 8614 | _x_x_mozilla_page_load_details 09:25:19 INFO - PROCESS | 8614 | |i|pagename|runs| 09:25:19 INFO - PROCESS | 8614 | |0;dojo.html;3087.274490494734;3095.659477457479;3101.6278046634407;3119.2357872321286;3130.9373812523736;5310.176922576997;5338.439463856297;5355.250264962909;5377.677339359636;5450.100733378998;5314.335708036496;5337.359516857982;5350.30446042014;5376.569874410038;5399.811006614769;4757.072370887687;4859.07677541266;4872.707637541759;4894.947586268951;4927.901441971158;4837.201861692816;4921.089598424285;4942.5304596063315;4962.330085438456;5001.699898006132;4757.072370887661;4787.712737235777;4833.2266837306215;4850.369451971256;4925.753712314406;4834.661573689843;4840.806367745321;4844.612431005511;4847.394075740533;4865.902681946377;4757.595604373632;4814.1334559779225;4826.396700412449;4829.855104346875;4835.806567737286;5217.58259339252;5237.502437268454;5298.814541491068;5315.309009828737;5319.148936170194;5704.372519022904;5721.370649228623;5729.570282228808;5776.393478684761;5791.3629500755305;5767.077267637158;5820.621659592155;5829.795957141522;5831.737571809236;5835.562332825013;5350.224217488442;5379.031774280628;5388.892222155574;5418.160185171305;5427.240186373911;5885.970570147122;5908.763649454059;5941.465268125803;5953.1070339449425;5955.13650520672;5547.8890422192135;5636.633618814764;5704.030314846486;5715.514181294553;5720.799772007959;5609.887802244014;5756.769729210869;5817.418258174149;5851.034579294454;5868.119782032644;5568.693721845257;5657.717114144359;5686.943130568641;5710.914336284959;5712.80005199816;5708.743106560215;5732.197492351074;5733.254676891977;5741.1388291756575;5745.683987380734;4320.2223599751715;4403;4429.512753597101;4432.135733531994;4486.1924853526025;3930.9017274568364;3940.3498422760495;3940.3498422760495;3998.5801490843623;3998.9400158997637;5529.612927095065;5535.861603459945;5540.2243685884005;5542.722863856791;5549.611527193058;5661.348944871393;5669.348024977098;5686.289213848269;5703.54371650267;5779.930712818142;5448.291722076184;5449.073657478239;5450.291462109901;5459.2902922619805;5460.726963651801;4843.782029808667;4884.438289596742;4885.609151267961;4890.144224760653;4936.086823937583;5796.62321949072;5912.054071348563;5989.071693887455;5994.400559944058;6069.150318955261;5816.41835816415;5818;5820.185174075717;5821.330546986981;5829.737661805314;6022.45797878193;6026.246719160105;6027.186329845415;6029.849253768515;6032.3967603239325;5527.419620939743;5649.858753531194;5676.148577713376;5692;5715.142728590745;5723.370429252862;5740.282464691913;5750.971245143747;5754.05058165398;5760.798372056958;5562.137868630369;5571.331440227199;5582.7766889323975;5584.944150558443;5585.748641311232;5393.514583687487;5516.200150978166;5635.830925072254;5649.293838270216;5675.716214189191;5664.235328230801;5667.801626943037;5673.631213971079;5676.545876329801;5679.545636349165;5561.805336813192;5674.602777805679;5690.061139911868;5720.11338242573;5720.771169153354;5485.286912701324;5515.586331025109;5549.028919939075;5603.719814009201;5637.295338082739 09:25:19 INFO - PROCESS | 8614 | |1;ext.html;547.9263398127017;588.4703766610053;591.8697886464978;619.9535034872384;642.8714257148572;36897.44653830191;41230.17539649205;41262.38106428398;41318.38022429666;41322.58677413225;41905.161896762045;42258.154836903246;42423;42434;42491;8803.471791692487;8905.866412003825;8963;8973.46159230445;9013.909860901373;8891.244244239248;8938.597763100675;8946.686865959693;8950.283977281802;8966.910330896706;8773.385862989593;8790.780230494256;8797.120287971216;8800.823983520326;8820.955895220546;8895.154960278764;8898.911010889873;8924.241439477652;8942.284617230638;8945.910540894572;8815.294776417872;8880.73357799267;8884.067172946812;8888.911110888874;8891.377603567753;40213;40905.181896362206;40912.38631420531;41022.79488602568;41052.79473602643;3250.3499300140065;3590.3896337622405;4037.9905023744063;4193.287141186006;4316.956830431687;30849.38301233963;31890;32028.359432811212;32107;32124.03627891167;4082;4157.605027522381;4186.84861663042;4231.449911511515;4381.934270985906;328877;334746.99999999756;335327;335581;337884;56375.15437268444;56392.718036409555;56669.71665141648;56734;56900.430995689516;59254.70372648195;59303;59335.40664593385;59466;59556;14399.712005759826;14457.421703131968;14471.348789304297;14471.782923255949;14490.130592164503;11844.28934263947;11852.70368240801;11860.10238361858;11870.584529541424;11870.703232419259;14867.256637168315;15460.591819666246;15507.224638768017;15516.224188790515;15999;6542.387616730194;6675.299093595103;6719.395254427125;6725.932740672629;6762.154730658668;854.6624083487112;956.1251454918671;959.4195511715451;989.0949780950493;1052.315994603514;27246;28722.569161462594;28875.133745987652;29257.414851702848;29800.552991705143;1038.9220808439397;1040.838670006135;1066.6373433032807;1074.033369967036;1090.7927493776158;14133.222672753098;14964.625884352761;14979.325930333162;15112;15237.695246095016;517351;518227;519512;519804;520427;58477.415225847195;58580.7070964651;58814.705926470946;58815;58893;1329.308759445083;1337.5987203838808;1370.0615078671142;1374.6357215337944;1383.5503461375092;27199.86400067987;27903;27960.720392796626;28845.27886802847;28904;51253.48746512636;51803.481965181374;52063;52174.21738673847;52193.217101742746;447605;448438;449086;449093;452121;28057.579136312565;28103.032787704666;28636.57045144283;28731.42537149287;29012;46430.767846160554;47309.76345118252;47412;47805.76097119492;48578.27132592943;40705.79647101746;41027.025405680506;41419.792901035304;41534.79232603818;42405.36391954185;41249.79375103105;41519.37720934128;41849.16301673889;41949.37075943924;42551.574484254765;34746.13134671653;35070;35153.1211719709;35479;35603.82198088993;34974.65025349714;36435.98806197054;36502.33450975325;37241.81379093087;37702;24718.25845224646;24720.752792471845;24792.504149916538;25024.49951001006;25234.87382563149 09:25:19 INFO - PROCESS | 8614 | |2;jquery.html;385.7608282864624;389.11088163546304;397.9263836190305;403.8647053237166;416.6583401610679;13548.45806167752;18712.251509939604;18973.14620842062;20381.388558343257;20405.285814996478;19566.31517896874;19959.201631934742;20054.49863753407;20611.587768244663;20637.142657160854;5733.827985160452;5789.39211382805;5829.795957141501;5867.031939729939;5904.350521442638;5829.067349224125;5829.154772557977;5876.294844618652;5881.7353219105025;5900.055991041434;5656.717164141776;5755.654660720349;5812.709364531777;5846.619969701977;5884.4703976642095;5807.767689292423;5807.970960145214;5815.883682326351;5850.151727999459;5869.50109240715;5075.467075957045;5213.713245771481;5225.895482090375;5233.398159211663;5246.134387826004;24082;24208.515829683485;24404.14585489517;24583.754162458325;24781.62827557588;2314.780095890888;2415.879206039691;2462.4090218347646;2494.064725727852;2686.31498967762;10438.32150910196;10731.35611863283;12424.254544727346;13674.589762307147;15522.593997930338;1963.7054441833695;1995.4113536506766;2034.8982550872545;2066.4317312738967;2067.3487851326936;82952.58523707344;92688.53655731745;93261.53369233178;94647;95398;10084.092431681038;10431.269811113301;10497.475126243657;10612.310199836986;10778.676639700821;14197.78703319451;14208.07647502909;14255.21596312192;14255.92872035654;14288.21414822174;7354.96322518384;7666;7752.069751629728;7831.099423566363;7845.411594130463;7305.269473052758;7459;7520.398368130536;7655.020086274666;7754.806129846799;4261.190373828963;4272.87181384559;4340.457442819647;4370.169667763115;4476.127155204704;1935.9739338150803;2017.778044415113;2022.6763717805081;2078.646630072861;2108.736407949006;894.3873446689039;933.1741408853078;939.8449255872705;960.6253561111172;983.7844834882494;17526.824731752775;18577.814221857607;18830.152643131092;18887.905560472384;18908.43274701761;934.5887809363858;981.1905178227847;982.543117450389;1019.5420499049429;1021.8927012663563;8472.576371181416;9915.851262231072;10548.947255263827;10598.682039538826;10615.469226538642;457595;462563;473964;475451;476102;52226.477735222164;58660;86691.56654216815;99195;99580.50209749049;1002.0330381182195;1012.1295685710284;1055.4195192644015;1073.4096247064083;1073.9946300268605;15791.447299344467;15797.813579401238;15965.840341596435;16939.49181524556;17225.655486890442;42184;42543.1491370177;43475.347869782614;43488.13023739571;43853;54830.45169548413;59023;60276.698616506634;60856;61856.38143618506;8878.158989123676;11926.701832453911;12775.488980440678;13195.406206720529;13373.331333433483;13679.247641379421;13800.309984500534;13923.323126926312;14895.62760930942;14927.253637318308;11364.034057105238;11582.768344633228;11989.64031079069;12149.149559530748;12176.39118044112;12089;12385.071119665881;12641.683957901127;12652.17760845542;13249.668758281121;11945.283283003047;11974.46114924813;12083.51665933388;12278.938605306916;12602.306873121699;12838.871611283768;12979.805302920275;13038.869611303766;13051.477940882258;13077.607671769862;7763.184865589032;8015.919840801517;8017.919820801717;8126.5936703163425;11720.886515780987 09:25:19 INFO - PROCESS | 8614 | |3;mootools.html;1484.7921291019256;1502.4666243483564;1652.5538104711727;1749.7812773403325;1764.9117544122792;7587.848243035136;8410.831783364336;8511.957440212806;9014.774630634238;9021.233195178409;8582.527960962145;8871.37900346976;8949.194572488475;8950.23922966547;8985.236254918324;2394.724606670238;2397.7841994220516;2411.433313171412;2414.637804329347;2425.9272221833285;2383.976160238393;2386.0575072846214;2456.631505274205;2461.8645974471397;2465.839720418167;2414.5050264695783;2422.757724227572;2437.1591800828774;2455.533448644752;2458.311672731629;2370.1467471710343;2378.0487804878103;2379.5716770981303;2392.270357540949;2414.794742446894;2321.303608917318;2325.3256555599023;2328.4528135888054;2332.440214348544;2340.5903966805913;8936.195742383152;9023.503707296097;9091.681791137345;9144.54277286133;9174.770630734218;5280.3663560372615;5394.1908713692865;5396.217548455491;5403.83788486346;5434.728263586844;3265.96734032659;3291.210109573709;3311.4536101543217;3331.7001469867587;3361.5798025246845;1026.271347343387;1032.3960483117385;1046.23102020016;1052.9684109476727;1059.2426415113232;12701.872981270253;12763.192097738483;12768.170068945488;12800.231986080866;12818.743625127538;4535.795889184995;4639.512851150648;4857.6599638025;4876.805182730253;4912.533309335608;10598.258121931545;10680.946595266974;10713.089387402159;10715.785684286271;10730.892691073146;5423.403425623178;5460.426655201226;5460.481254280837;5471.753771080311;5474.616776825584;4286.742795432284;4746.786394612251;4809.951900480951;4827.734474603931;4979.676321039121;3999.5400528938962;4075.144219713893;4152.584741525884;4160.334346504545;4161.417401563784;1312.7440149171011;1329.6476433745065;1332;1351.8310211223597;1358.898082643786;834.5576844272546;951.7620594851287;965.2856885904521;973.571628483465;982.5529384130203;5529.917051244234;5797.956367853827;5824.854378640483;5858.912116318259;5943.514121469632;455.3647661512238;459.33396574966434;475.7264572870544;477.56302982770376;478.9856304310876;3790.8294126764363;3832.137769002008;3869.9613003870163;3907.628775266345;3948.545917219499;10949.781004380027;11270.887291127148;11307.095432365391;11349.262297950607;11384.658460246206;11156.16328775345;11179.776404471864;11183.092395977104;11199.72000699989;11214.775704485864;8273.917260827435;8313.750587482386;8356.791080222922;8371.58142092893;8462.323014158976;5723.713814309184;5765.250517432707;5825.563082768725;6002.219711437485;6033.698315084141;10140.746481338025;10152.137068349273;10171.542280597243;10316.587336506456;10397.53211105487;9885.555150018123;10243.436610986468;10523.894761052292;10541.998510141524;10583.5237414315;7105;7626.656800443882;7838.3337416320255;7893.210678932291;7978.082520509984;8675.479471231747;8715.825683486422;8802.38383313162;8828.470291782256;8844.425112367675;7730.613469326624;7823.178566250689;7943.523388596703;7962.840743184988;8059.43583949118;7677.61611919413;7760.3403710685225;7789.454738168274;7863.764087077397;7888.84222315539;6675.365840245169;6733.225679046972;6739.157605299338;6740.494462915203;6741.1910570731825;5104.897902042013;5152;5232.293640358503;5261.552768014609;5363.410024897336;5228.555572776357;5245.475452454877;5251.212318152155;5275.8681032972945;5518.889622207453 09:25:19 INFO - PROCESS | 8614 | |4;prototype.html;318.6383454778827;324.1830586920959;332.30548154357405;336.30720715326424;338.17822690861226;5399.19012148178;5451.318585176853;5596.944030559694;5650.9717451412735;5652.378238393773;5391.73041347933;5406.324209473816;5429.511343979041;5450.482204190605;5455.290812194409;4274.636655884254;4281.223292333678;4291.742495450283;4302.182585308797;4311;4210.59999300066;4219.472565929259;4268.719384184732;4293.914121717564;4335.501417336999;4217.198732240864;4225.915481690365;4227.196832601796;4230.873073807791;4247.787610619456;4235.851745188935;4252.957470425303;4260.339647354649;4273.9358909616385;4284.485861696617;3620.71034317254;3797.9240415191543;3802.2205447883116;3808.638179372955;3811.8094095295123;5365.558670804774;5369.597280203961;5389.38318504451;5402.108652072403;5410.08028635129;4917.950820491785;4946.777395017233;4959.70241785494;4979.751012449363;4984.87537811554;5549.833504994856;5750.65496070233;5759.942400575983;5764.443600227957;5804.854878628026;4166.187708346879;4172.144710334404;4180.372944058385;4181.247375472413;4183.807614829759;5974.103884417329;6008.75964961401;6011.458968692838;6033.637981721155;6035.577509574332;4113.259613269581;4265.805574439162;4285.485741711014;4297.851074462768;4309.84915527955;4285.7642829644665;4291.699581029298;4303.935440968388;4304.246756817544;4310.396544483775;4916.778744956486;4919.483454237254;4920.975395123073;4952.90094198114;4996.200607902718;5639.182318563785;5868.2077919480325;5868.7088840455035;5875.797690258819;5879.617824841457;1458.5478501664518;1488.0848278308763;1490.7316682996948;1491.455618699167;1491.4854375240525;908.8227795579799;957.593022965237;957.6552441121191;973.3040875773855;978.7308490165119;4871.537203965618;4894.828680996148;4909.22628714775;4914.434839993375;4962.330085438492;5109.540141387293;5240.633155679066;5266.236395722599;5268.9736551317;5284.5772338212855;4619.815207391734;4851.749327950281;4860.392450943632;4868.9756551217015;4926.984507626273;2736.698963114056;2774.375765452757;2778.861056947185;2798.432877588557;2799.468101060792;5280.9207861882105;5290.92063619046;5315.176147697113;5320.893582128336;5347.545458635982;5099.184130539096;5159.0040283304725;5276.604254680838;5314.601404894648;5350.057468392369;5434.130539113723;5437.34751829783;5437.619366644297;5439.864003399867;5441.483059109379;5219.556337711337;5221.399539052905;5245.606579506629;5264.578833693219;5288.471152884681;4899.799549110491;5188.922166167586;5190.480951904779;5201.76592053366;5233.770064035025;5369.4093649697725;5371.946280537301;5372.946270537401;5397.730113494231;5423.83728488146;3867.767933923861;3974.900627484336;4125.463689720317;4206.801061697402;4243.68172387066;5893.263342082239;5920.082387229814;5934.9109763354445;5956;5966.525106170372;5633.324001119892;5806.709664516842;5819.970900145472;5871.412858714094;5899.882002360015;5634.267545219095;5721.57088218377;5742.277316804858;5746.9712651436475;5750.367459579359;5733.799317023884;5735.684537350486;5752.539796816328;5775.33583637887;5788.884222315614;5570.749316280858;5775.133729940375;5819.621724587888;5880.882382352414;5920.467157955804;5723.761100400583;5729.71351432435;5763.164341170591;5788.507976822018;5793.507551858139 09:25:19 INFO - PROCESS | 8614 | |5;yui.html;628.9433950944416;696.9546979446336;707.6554546361912;732.8570928668912;743.6281859070466;14849.554513364603;15801.446949356774;15850.682986340265;15893.920530397332;15944.840551594494;13197.406116724747;13264.668383290398;13270.270135142564;13278.800817987738;13301.600951971432;769.8190925132617;779.8791187365968;815.1115284340098;819.2708489444399;821.7781199076246;816.0248503038871;817.7546735979212;817.8936738224053;818.3698552114868;818.8812622169781;861.0227391910196;862.5988915154452;862.8533149364623;864.4035615425367;866.5710473315718;855.7090589199639;857.1813917708573;858.5535521528833;860.3504354212561;860.6772460327377;620.4385031546458;623.8783437229743;624.5284809968445;624.8687775567091;625.337142628815;14710.411583536647;14717.70564588713;14732.96869219155;14749.188794616291;14767.778483322758;13869.729502788876;14173.149611023371;14383.640408989755;14408.423663053465;14424.423023079064;11893.345865977368;11964.70088247792;12010.69973250667;12022.15844890858;12266.693332666666;3788.2234142000825;3838.692904567628;3859.4982652255026;3884.941725874114;4010.83956641734;85448.14551854464;86712.56643716805;86800;87577;87767.56116219441;9811.411315321104;10091.646792362231;10172.694819155437;10223.59105635781;10303.175745940307;18683.252669893052;18716.812831871506;18754.343597974006;18760.530986725167;18852.528686782665;6949.235584085746;7032.542884712478;7068.5758854468895;7086;7256.0567126273245;4359.193549193409;4485.529019452975;4497.415336006298;4550.362949187116;4651.930221046687;3424.8972530824117;3516.6483351665142;3553.1117220694828;3557.7509574329547;3560.2167523145386;585.6632436349116;597.7818096394784;605.893968555501;615.0865964043392;625.6340041076021;619.7799781077742;621.8165641135876;678.4606238040769;684.6542496039468;715.5635062611907;8976.596053177622;9645.662401815904;9879.604815807432;9932.751681208028;10221.897781022095;543.4375421438792;627.3525721455444;644.680882962927;657.431321906557;706.2125729811223;4363.323684828857;4623;4688.97655511727;4692.131955588227;4695.694779839299;75092.62453687696;76085;76184;97448.51275743576;100718;63171.68414157992;94609;100208.98119169309;100392;102852;75355.24644753592;76936;88419;89638;92081.99999999866;9511.904880951379;9848;9943.751406214902;10069.748256293358;10076.345037572535;47783;52315.73842130765;52363;53388.46611533835;54693;52237.7388113057;66457.66771166114;67723.66138169277;68345.65827170832;69588.30411695818;12261.87738122643;12405.813912791496;12515.4368053436;12558.434870431036;12761.298128603015;14090.295485225493;14162.221077840817;14240.216788076756;14296.142231466145;14528.927355363156;12703.555375561811;13282;13687.520936767165;13773.862261377259;14490.058146220463;13147.802782958071;13215.405306761026;13292.468301267842;13915.443382264595;14105;12695.682607934506;12707.426398685531;13246.668833279246;13313.46746130144;13444.327783610976;10098.899011009797;10137.847932280874;10357;10457.372557646566;10883.074938629989;8548.135715142209;9543.76140596463;10336.810136665814;10466.947665261625;10686.145108391465 09:25:19 INFO - PROCESS | 8614 | __end_tp_report 09:25:19 INFO - PROCESS | 8614 | __start_cc_report 09:25:19 INFO - PROCESS | 8614 | _x_x_mozilla_cycle_collect,342 09:25:19 INFO - PROCESS | 8614 | __end_cc_report 09:25:19 INFO - PROCESS | 8614 | __startTimestamp1471537519883__endTimestamp 09:25:19 INFO - PROCESS | 8614 | 09:25:19 INFO - PROCESS | 8614 | ------- Summary: start ------- 09:25:19 INFO - PROCESS | 8614 | Number of tests: 6 09:25:19 INFO - PROCESS | 8614 | 09:25:19 INFO - PROCESS | 8614 | [#0] dojo.html Cycles:165 Average:5343.41 Median:5561.81 stddev:614.97 (11.1%) stddev-sans-first:590.83 09:25:19 INFO - PROCESS | 8614 | Values: 3087.3 3095.7 3101.6 3119.2 3130.9 5310.2 5338.4 5355.3 5377.7 5450.1 5314.3 5337.4 5350.3 5376.6 5399.8 4757.1 4859.1 4872.7 4894.9 4927.9 4837.2 4921.1 4942.5 4962.3 5001.7 4757.1 4787.7 4833.2 4850.4 4925.8 4834.7 4840.8 4844.6 4847.4 4865.9 4757.6 4814.1 4826.4 4829.9 4835.8 5217.6 5237.5 5298.8 5315.3 5319.1 5704.4 5721.4 5729.6 5776.4 5791.4 5767.1 5820.6 5829.8 5831.7 5835.6 5350.2 5379.0 5388.9 5418.2 5427.2 5886.0 5908.8 5941.5 5953.1 5955.1 5547.9 5636.6 5704.0 5715.5 5720.8 5609.9 5756.8 5817.4 5851.0 5868.1 5568.7 5657.7 5686.9 5710.9 5712.8 5708.7 5732.2 5733.3 5741.1 5745.7 4320.2 4403.0 4429.5 4432.1 4486.2 3930.9 3940.3 3940.3 3998.6 3998.9 5529.6 5535.9 5540.2 5542.7 5549.6 5661.3 5669.3 5686.3 5703.5 5779.9 5448.3 5449.1 5450.3 5459.3 5460.7 4843.8 4884.4 4885.6 4890.1 4936.1 5796.6 5912.1 5989.1 5994.4 6069.2 5816.4 5818.0 5820.2 5821.3 5829.7 6022.5 6026.2 6027.2 6029.8 6032.4 5527.4 5649.9 5676.1 5692.0 5715.1 5723.4 5740.3 5751.0 5754.1 5760.8 5562.1 5571.3 5582.8 5584.9 5585.7 5393.5 5516.2 5635.8 5649.3 5675.7 5664.2 5667.8 5673.6 5676.5 5679.5 5561.8 5674.6 5690.1 5720.1 5720.8 5485.3 5515.6 5549.0 5603.7 5637.3 09:25:19 INFO - PROCESS | 8614 | 09:25:19 INFO - PROCESS | 8614 | [#1] ext.html Cycles:180 Average:58820.10 Median:22846.20 stddev:117019.41 (512.2%) stddev-sans-first:117265.89 09:25:19 INFO - PROCESS | 8614 | Values: 547.9 588.5 591.9 620.0 642.9 36897.4 41230.2 41262.4 41318.4 41322.6 41905.2 42258.2 42423.0 42434.0 42491.0 8803.5 8905.9 8963.0 8973.5 9013.9 8891.2 8938.6 8946.7 8950.3 8966.9 8773.4 8790.8 8797.1 8800.8 8821.0 8895.2 8898.9 8924.2 8942.3 8945.9 8815.3 8880.7 8884.1 8888.9 8891.4 40213.0 40905.2 40912.4 41022.8 41052.8 3250.3 3590.4 4038.0 4193.3 4317.0 30849.4 31890.0 32028.4 32107.0 32124.0 4082.0 4157.6 4186.8 4231.4 4381.9 328877.0 334747.0 335327.0 335581.0 337884.0 56375.2 56392.7 56669.7 56734.0 56900.4 59254.7 59303.0 59335.4 59466.0 59556.0 14399.7 14457.4 14471.3 14471.8 14490.1 11844.3 11852.7 11860.1 11870.6 11870.7 14867.3 15460.6 15507.2 15516.2 15999.0 6542.4 6675.3 6719.4 6725.9 6762.2 854.7 956.1 959.4 989.1 1052.3 27246.0 28722.6 28875.1 29257.4 29800.6 1038.9 1040.8 1066.6 1074.0 1090.8 14133.2 14964.6 14979.3 15112.0 15237.7 517351.0 518227.0 519512.0 519804.0 520427.0 58477.4 58580.7 58814.7 58815.0 58893.0 1329.3 1337.6 1370.1 1374.6 1383.6 27199.9 27903.0 27960.7 28845.3 28904.0 51253.5 51803.5 52063.0 52174.2 52193.2 447605.0 448438.0 449086.0 449093.0 452121.0 28057.6 28103.0 28636.6 28731.4 29012.0 46430.8 47309.8 47412.0 47805.8 48578.3 40705.8 41027.0 41419.8 41534.8 42405.4 41249.8 41519.4 41849.2 41949.4 42551.6 34746.1 35070.0 35153.1 35479.0 35603.8 34974.7 36436.0 36502.3 37241.8 37702.0 24718.3 24720.8 24792.5 25024.5 25234.9 09:25:19 INFO - PROCESS | 8614 | 09:25:19 INFO - PROCESS | 8614 | [#2] jquery.html Cycles:180 Average:28624.33 Median:13523.08 stddev:77507.96 (573.2%) stddev-sans-first:77696.39 09:25:19 INFO - PROCESS | 8614 | Values: 385.8 389.1 397.9 403.9 416.7 13548.5 18712.3 18973.1 20381.4 20405.3 19566.3 19959.2 20054.5 20611.6 20637.1 5733.8 5789.4 5829.8 5867.0 5904.4 5829.1 5829.2 5876.3 5881.7 5900.1 5656.7 5755.7 5812.7 5846.6 5884.5 5807.8 5808.0 5815.9 5850.2 5869.5 5075.5 5213.7 5225.9 5233.4 5246.1 24082.0 24208.5 24404.1 24583.8 24781.6 2314.8 2415.9 2462.4 2494.1 2686.3 10438.3 10731.4 12424.3 13674.6 15522.6 1963.7 1995.4 2034.9 2066.4 2067.3 82952.6 92688.5 93261.5 94647.0 95398.0 10084.1 10431.3 10497.5 10612.3 10778.7 14197.8 14208.1 14255.2 14255.9 14288.2 7355.0 7666.0 7752.1 7831.1 7845.4 7305.3 7459.0 7520.4 7655.0 7754.8 4261.2 4272.9 4340.5 4370.2 4476.1 1936.0 2017.8 2022.7 2078.6 2108.7 894.4 933.2 939.8 960.6 983.8 17526.8 18577.8 18830.2 18887.9 18908.4 934.6 981.2 982.5 1019.5 1021.9 8472.6 9915.9 10548.9 10598.7 10615.5 457595.0 462563.0 473964.0 475451.0 476102.0 52226.5 58660.0 86691.6 99195.0 99580.5 1002.0 1012.1 1055.4 1073.4 1074.0 15791.4 15797.8 15965.8 16939.5 17225.7 42184.0 42543.1 43475.3 43488.1 43853.0 54830.5 59023.0 60276.7 60856.0 61856.4 8878.2 11926.7 12775.5 13195.4 13373.3 13679.2 13800.3 13923.3 14895.6 14927.3 11364.0 11582.8 11989.6 12149.1 12176.4 12089.0 12385.1 12641.7 12652.2 13249.7 11945.3 11974.5 12083.5 12278.9 12602.3 12838.9 12979.8 13038.9 13051.5 13077.6 7763.2 8015.9 8017.9 8126.6 11720.9 09:25:19 INFO - PROCESS | 8614 | 09:25:19 INFO - PROCESS | 8614 | [#3] mootools.html Cycles:180 Average:5872.61 Median:476.64 stddev:3398.56 (713.0%) stddev-sans-first:3392.10 09:25:19 INFO - PROCESS | 8614 | Values: 1484.8 1502.5 1652.6 1749.8 1764.9 7587.8 8410.8 8512.0 9014.8 9021.2 8582.5 8871.4 8949.2 8950.2 8985.2 2394.7 2397.8 2411.4 2414.6 2425.9 2384.0 2386.1 2456.6 2461.9 2465.8 2414.5 2422.8 2437.2 2455.5 2458.3 2370.1 2378.0 2379.6 2392.3 2414.8 2321.3 2325.3 2328.5 2332.4 2340.6 8936.2 9023.5 9091.7 9144.5 9174.8 5280.4 5394.2 5396.2 5403.8 5434.7 3266.0 3291.2 3311.5 3331.7 3361.6 1026.3 1032.4 1046.2 1053.0 1059.2 12701.9 12763.2 12768.2 12800.2 12818.7 4535.8 4639.5 4857.7 4876.8 4912.5 10598.3 10680.9 10713.1 10715.8 10730.9 5423.4 5460.4 5460.5 5471.8 5474.6 4286.7 4746.8 4810.0 4827.7 4979.7 3999.5 4075.1 4152.6 4160.3 4161.4 1312.7 1329.6 1332.0 1351.8 1358.9 834.6 951.8 965.3 973.6 982.6 5529.9 5798.0 5824.9 5858.9 5943.5 455.4 459.3 475.7 477.6 479.0 3790.8 3832.1 3870.0 3907.6 3948.5 10949.8 11270.9 11307.1 11349.3 11384.7 11156.2 11179.8 11183.1 11199.7 11214.8 8273.9 8313.8 8356.8 8371.6 8462.3 5723.7 5765.3 5825.6 6002.2 6033.7 10140.7 10152.1 10171.5 10316.6 10397.5 9885.6 10243.4 10523.9 10542.0 10583.5 7105.0 7626.7 7838.3 7893.2 7978.1 8675.5 8715.8 8802.4 8828.5 8844.4 7730.6 7823.2 7943.5 7962.8 8059.4 7677.6 7760.3 7789.5 7863.8 7888.8 6675.4 6733.2 6739.2 6740.5 6741.2 5104.9 5152.0 5232.3 5261.6 5363.4 5228.6 5245.5 5251.2 5275.9 5518.9 09:25:19 INFO - PROCESS | 8614 | 09:25:19 INFO - PROCESS | 8614 | [#4] prototype.html Cycles:180 Average:4680.93 Median:5243.12 stddev:1353.33 (25.8%) stddev-sans-first:1316.93 09:25:19 INFO - PROCESS | 8614 | Values: 318.6 324.2 332.3 336.3 338.2 5399.2 5451.3 5596.9 5651.0 5652.4 5391.7 5406.3 5429.5 5450.5 5455.3 4274.6 4281.2 4291.7 4302.2 4311.0 4210.6 4219.5 4268.7 4293.9 4335.5 4217.2 4225.9 4227.2 4230.9 4247.8 4235.9 4253.0 4260.3 4273.9 4284.5 3620.7 3797.9 3802.2 3808.6 3811.8 5365.6 5369.6 5389.4 5402.1 5410.1 4918.0 4946.8 4959.7 4979.8 4984.9 5549.8 5750.7 5759.9 5764.4 5804.9 4166.2 4172.1 4180.4 4181.2 4183.8 5974.1 6008.8 6011.5 6033.6 6035.6 4113.3 4265.8 4285.5 4297.9 4309.8 4285.8 4291.7 4303.9 4304.2 4310.4 4916.8 4919.5 4921.0 4952.9 4996.2 5639.2 5868.2 5868.7 5875.8 5879.6 1458.5 1488.1 1490.7 1491.5 1491.5 908.8 957.6 957.7 973.3 978.7 4871.5 4894.8 4909.2 4914.4 4962.3 5109.5 5240.6 5266.2 5269.0 5284.6 4619.8 4851.7 4860.4 4869.0 4927.0 2736.7 2774.4 2778.9 2798.4 2799.5 5280.9 5290.9 5315.2 5320.9 5347.5 5099.2 5159.0 5276.6 5314.6 5350.1 5434.1 5437.3 5437.6 5439.9 5441.5 5219.6 5221.4 5245.6 5264.6 5288.5 4899.8 5188.9 5190.5 5201.8 5233.8 5369.4 5371.9 5372.9 5397.7 5423.8 3867.8 3974.9 4125.5 4206.8 4243.7 5893.3 5920.1 5934.9 5956.0 5966.5 5633.3 5806.7 5820.0 5871.4 5899.9 5634.3 5721.6 5742.3 5747.0 5750.4 5733.8 5735.7 5752.5 5775.3 5788.9 5570.7 5775.1 5819.6 5880.9 5920.5 5723.8 5729.7 5763.2 5788.5 5793.5 09:25:19 INFO - PROCESS | 8614 | 09:25:19 INFO - PROCESS | 8614 | [#5] yui.html Cycles:180 Average:19487.96 Median:4670.45 stddev:27460.23 (588.0%) stddev-sans-first:27500.76 09:25:19 INFO - PROCESS | 8614 | Values: 628.9 697.0 707.7 732.9 743.6 14849.6 15801.4 15850.7 15893.9 15944.8 13197.4 13264.7 13270.3 13278.8 13301.6 769.8 779.9 815.1 819.3 821.8 816.0 817.8 817.9 818.4 818.9 861.0 862.6 862.9 864.4 866.6 855.7 857.2 858.6 860.4 860.7 620.4 623.9 624.5 624.9 625.3 14710.4 14717.7 14733.0 14749.2 14767.8 13869.7 14173.1 14383.6 14408.4 14424.4 11893.3 11964.7 12010.7 12022.2 12266.7 3788.2 3838.7 3859.5 3884.9 4010.8 85448.1 86712.6 86800.0 87577.0 87767.6 9811.4 10091.6 10172.7 10223.6 10303.2 18683.3 18716.8 18754.3 18760.5 18852.5 6949.2 7032.5 7068.6 7086.0 7256.1 4359.2 4485.5 4497.4 4550.4 4651.9 3424.9 3516.6 3553.1 3557.8 3560.2 585.7 597.8 605.9 615.1 625.6 619.8 621.8 678.5 684.7 715.6 8976.6 9645.7 9879.6 9932.8 10221.9 543.4 627.4 644.7 657.4 706.2 4363.3 4623.0 4689.0 4692.1 4695.7 75092.6 76085.0 76184.0 97448.5 100718.0 63171.7 94609.0 100209.0 100392.0 102852.0 75355.2 76936.0 88419.0 89638.0 92082.0 9511.9 9848.0 9943.8 10069.7 10076.3 47783.0 52315.7 52363.0 53388.5 54693.0 52237.7 66457.7 67723.7 68345.7 69588.3 12261.9 12405.8 12515.4 12558.4 12761.3 14090.3 14162.2 14240.2 14296.1 14528.9 12703.6 13282.0 13687.5 13773.9 14490.1 13147.8 13215.4 13292.5 13915.4 14105.0 12695.7 12707.4 13246.7 13313.5 13444.3 10098.9 10137.8 10357.0 10457.4 10883.1 8548.1 9543.8 10336.8 10466.9 10686.1 09:25:19 INFO - PROCESS | 8614 | -------- Summary: end -------- 09:25:19 INFO - PROCESS | 8614 | 09:25:20 INFO - TEST-INFO | 8614: exit 0 09:25:20 INFO - TEST-OK | dromaeo_css | took 1113239ms 09:25:20 INFO - TEST-START | kraken 09:25:20 INFO - operating with platform_type : linux_ 09:25:20 INFO - Initialising browser for kraken test... 09:25:20 INFO - TEST-INFO | started process 8970 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd8LbcF/profile http://localhost:60976/getInfo.html) 09:25:25 INFO - PROCESS | 8970 | __metrics Screen width/height:1600/1200 09:25:25 INFO - PROCESS | 8970 | colorDepth:24 09:25:25 INFO - PROCESS | 8970 | Browser inner width/height: 1024/697 09:25:25 INFO - PROCESS | 8970 | __metrics 09:25:25 ERROR - PROCESS | 8970 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 09:25:26 INFO - TEST-INFO | 8970: exit 0 09:25:26 INFO - Browser initialized. 09:25:26 INFO - Running cycle 1/1 for kraken test... 09:25:26 INFO - TEST-INFO | started process 9090 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd8LbcF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:25:38 INFO - PROCESS | 9090 | RSS: Main: 163172352 09:25:38 INFO - PROCESS | 9090 | 09:25:41 INFO - PROCESS | 9090 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60976/tests/kraken/driver.html?testName=audio-beat-detection) 09:25:42 INFO - PROCESS | 9090 | RSS: Main: 168144896 09:25:42 INFO - PROCESS | 9090 | 09:25:44 INFO - PROCESS | 9090 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60976/tests/kraken/driver.html?testName=audio-dft) 09:25:45 INFO - PROCESS | 9090 | RSS: Main: 167432192 09:25:45 INFO - PROCESS | 9090 | 09:25:48 INFO - PROCESS | 9090 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60976/tests/kraken/driver.html?testName=audio-fft) 09:25:48 INFO - PROCESS | 9090 | RSS: Main: 163934208 09:25:48 INFO - PROCESS | 9090 | 09:25:51 INFO - PROCESS | 9090 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60976/tests/kraken/driver.html?testName=audio-oscillator) 09:25:51 INFO - PROCESS | 9090 | RSS: Main: 164487168 09:25:51 INFO - PROCESS | 9090 | 09:25:53 INFO - PROCESS | 9090 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60976/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:25:54 INFO - PROCESS | 9090 | RSS: Main: 164569088 09:25:54 INFO - PROCESS | 9090 | 09:25:57 INFO - PROCESS | 9090 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60976/tests/kraken/driver.html?testName=imaging-darkroom) 09:25:58 INFO - PROCESS | 9090 | RSS: Main: 165281792 09:25:58 INFO - PROCESS | 9090 | 09:26:01 INFO - PROCESS | 9090 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60976/tests/kraken/driver.html?testName=imaging-desaturate) 09:26:02 INFO - PROCESS | 9090 | RSS: Main: 165642240 09:26:02 INFO - PROCESS | 9090 | 09:26:05 INFO - PROCESS | 9090 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60976/tests/kraken/driver.html?testName=json-parse-financial) 09:26:05 INFO - PROCESS | 9090 | RSS: Main: 165629952 09:26:05 INFO - PROCESS | 9090 | 09:26:07 INFO - PROCESS | 9090 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60976/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:26:07 INFO - PROCESS | 9090 | RSS: Main: 165126144 09:26:07 INFO - PROCESS | 9090 | 09:26:09 INFO - PROCESS | 9090 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60976/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:26:10 INFO - PROCESS | 9090 | RSS: Main: 165056512 09:26:10 INFO - PROCESS | 9090 | 09:26:12 INFO - PROCESS | 9090 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60976/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:26:13 INFO - PROCESS | 9090 | RSS: Main: 165801984 09:26:13 INFO - PROCESS | 9090 | 09:26:15 INFO - PROCESS | 9090 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60976/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:26:16 INFO - PROCESS | 9090 | RSS: Main: 165847040 09:26:16 INFO - PROCESS | 9090 | 09:26:19 INFO - PROCESS | 9090 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60976/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:26:19 INFO - PROCESS | 9090 | RSS: Main: 166109184 09:26:19 INFO - PROCESS | 9090 | 09:26:21 INFO - PROCESS | 9090 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60976/tests/kraken/driver.html?testName=ai-astar) 09:26:21 INFO - PROCESS | 9090 | RSS: Main: 166539264 09:26:21 INFO - PROCESS | 9090 | 09:26:21 INFO - PROCESS | 9090 | __start_tp_report 09:26:21 INFO - PROCESS | 9090 | _x_x_mozilla_page_load 09:26:21 INFO - PROCESS | 9090 | _x_x_mozilla_page_load_details 09:26:21 INFO - PROCESS | 9090 | |i|pagename|runs| 09:26:21 INFO - PROCESS | 9090 | |0;ai-astar;103;112;109;112;111;111;118;112;111;111 09:26:21 INFO - PROCESS | 9090 | |1;audio-beat-detection;154;123;147;185;118;151;148;120;179;119 09:26:21 INFO - PROCESS | 9090 | |2;audio-dft;163;163;162;161;165;175;162;161;166;164 09:26:21 INFO - PROCESS | 9090 | |3;audio-fft;76;75;76;177;76;77;75;75;180;77 09:26:21 INFO - PROCESS | 9090 | |4;audio-oscillator;84;84;164;86;87;87;146;86;85;151 09:26:21 INFO - PROCESS | 9090 | |5;imaging-gaussian-blur;118;118;117;118;118;118;119;118;118;118 09:26:21 INFO - PROCESS | 9090 | |6;imaging-darkroom;148;148;148;147;148;147;148;148;146;147 09:26:21 INFO - PROCESS | 9090 | |7;imaging-desaturate;101;96;95;95;96;96;95;96;96;96 09:26:21 INFO - PROCESS | 9090 | |8;json-parse-financial;51;52;54;50;52;54;54;52;51;55 09:26:21 INFO - PROCESS | 9090 | |9;json-stringify-tinderbox;61;62;61;61;63;61;64;61;62;62 09:26:21 INFO - PROCESS | 9090 | |10;stanford-crypto-aes;87;85;84;79;84;77;87;79;83;77 09:26:21 INFO - PROCESS | 9090 | |11;stanford-crypto-ccm;137;143;122;127;140;134;125;129;138;126 09:26:21 INFO - PROCESS | 9090 | |12;stanford-crypto-pbkdf2;165;164;162;164;161;170;164;162;160;164 09:26:21 INFO - PROCESS | 9090 | |13;stanford-crypto-sha256-iterative;67;66;66;66;69;69;69;64;63;64 09:26:21 INFO - PROCESS | 9090 | __end_tp_report 09:26:21 INFO - PROCESS | 9090 | __start_cc_report 09:26:21 INFO - PROCESS | 9090 | _x_x_mozilla_cycle_collect,945 09:26:21 INFO - PROCESS | 9090 | __end_cc_report 09:26:21 INFO - PROCESS | 9090 | __startTimestamp1471537581891__endTimestamp 09:26:21 INFO - PROCESS | 9090 | 09:26:21 INFO - PROCESS | 9090 | ------- Summary: start ------- 09:26:21 INFO - PROCESS | 9090 | Number of tests: 14 09:26:21 INFO - PROCESS | 9090 | 09:26:21 INFO - PROCESS | 9090 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.50 stddev:3.65 (3.3%) stddev-sans-first:2.47 09:26:21 INFO - PROCESS | 9090 | Values: 103.0 112.0 109.0 112.0 111.0 111.0 118.0 112.0 111.0 111.0 09:26:21 INFO - PROCESS | 9090 | 09:26:21 INFO - PROCESS | 9090 | [#1] audio-beat-detection Cycles:10 Average:144.40 Median:149.50 stddev:24.49 (16.4%) stddev-sans-first:25.72 09:26:21 INFO - PROCESS | 9090 | Values: 154.0 123.0 147.0 185.0 118.0 151.0 148.0 120.0 179.0 119.0 09:26:21 INFO - PROCESS | 9090 | 09:26:21 INFO - PROCESS | 9090 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.50 stddev:4.13 (2.5%) stddev-sans-first:4.36 09:26:21 INFO - PROCESS | 9090 | Values: 163.0 163.0 162.0 161.0 165.0 175.0 162.0 161.0 166.0 164.0 09:26:21 INFO - PROCESS | 9090 | 09:26:21 INFO - PROCESS | 9090 | [#3] audio-fft Cycles:10 Average:96.40 Median:76.00 stddev:43.28 (57.0%) stddev-sans-first:45.27 09:26:21 INFO - PROCESS | 9090 | Values: 76.0 75.0 76.0 177.0 76.0 77.0 75.0 75.0 180.0 77.0 09:26:21 INFO - PROCESS | 9090 | 09:26:21 INFO - PROCESS | 9090 | [#4] audio-oscillator Cycles:10 Average:106.00 Median:85.50 stddev:33.20 (38.8%) stddev-sans-first:34.25 09:26:21 INFO - PROCESS | 9090 | Values: 84.0 84.0 164.0 86.0 87.0 87.0 146.0 86.0 85.0 151.0 09:26:21 INFO - PROCESS | 9090 | 09:26:21 INFO - PROCESS | 9090 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 09:26:21 INFO - PROCESS | 9090 | Values: 118.0 118.0 117.0 118.0 118.0 118.0 119.0 118.0 118.0 118.0 09:26:21 INFO - PROCESS | 9090 | 09:26:21 INFO - PROCESS | 9090 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.71 (0.5%) stddev-sans-first:0.73 09:26:21 INFO - PROCESS | 9090 | Values: 148.0 148.0 148.0 147.0 148.0 147.0 148.0 148.0 146.0 147.0 09:26:21 INFO - PROCESS | 9090 | 09:26:21 INFO - PROCESS | 9090 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:1.75 (1.8%) stddev-sans-first:0.50 09:26:21 INFO - PROCESS | 9090 | Values: 101.0 96.0 95.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 09:26:21 INFO - PROCESS | 9090 | 09:26:21 INFO - PROCESS | 9090 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:53.00 stddev:1.65 (3.1%) stddev-sans-first:1.66 09:26:21 INFO - PROCESS | 9090 | Values: 51.0 52.0 54.0 50.0 52.0 54.0 54.0 52.0 51.0 55.0 09:26:21 INFO - PROCESS | 9090 | 09:26:21 INFO - PROCESS | 9090 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:1.03 (1.7%) stddev-sans-first:1.05 09:26:21 INFO - PROCESS | 9090 | Values: 61.0 62.0 61.0 61.0 63.0 61.0 64.0 61.0 62.0 62.0 09:26:21 INFO - PROCESS | 9090 | 09:26:21 INFO - PROCESS | 9090 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:84.00 stddev:3.88 (4.6%) stddev-sans-first:3.71 09:26:21 INFO - PROCESS | 9090 | Values: 87.0 85.0 84.0 79.0 84.0 77.0 87.0 79.0 83.0 77.0 09:26:21 INFO - PROCESS | 9090 | 09:26:21 INFO - PROCESS | 9090 | [#11] stanford-crypto-ccm Cycles:10 Average:132.10 Median:135.50 stddev:7.22 (5.3%) stddev-sans-first:7.43 09:26:21 INFO - PROCESS | 9090 | Values: 137.0 143.0 122.0 127.0 140.0 134.0 125.0 129.0 138.0 126.0 09:26:21 INFO - PROCESS | 9090 | 09:26:21 INFO - PROCESS | 9090 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.60 Median:164.00 stddev:2.76 (1.7%) stddev-sans-first:2.88 09:26:21 INFO - PROCESS | 9090 | Values: 165.0 164.0 162.0 164.0 161.0 170.0 164.0 162.0 160.0 164.0 09:26:21 INFO - PROCESS | 9090 | 09:26:21 INFO - PROCESS | 9090 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:2.21 (3.3%) stddev-sans-first:2.33 09:26:21 INFO - PROCESS | 9090 | Values: 67.0 66.0 66.0 66.0 69.0 69.0 69.0 64.0 63.0 64.0 09:26:21 INFO - PROCESS | 9090 | -------- Summary: end -------- 09:26:21 INFO - PROCESS | 9090 | 09:26:22 INFO - TEST-INFO | 9090: exit 0 09:26:22 INFO - TEST-OK | kraken | took 62315ms 09:26:22 INFO - SUITE-END | took 1175s 09:26:23 INFO - Completed test suite (00:19:35) 09:26:23 INFO - javascript benchmark 09:26:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7175.10713942908, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3087.274490494734, 3095.659477457479, 3101.6278046634407, 3119.2357872321286, 3130.9373812523736, 5310.176922576997, 5338.439463856297, 5355.250264962909, 5377.677339359636, 5450.100733378998, 5314.335708036496, 5337.359516857982, 5350.30446042014, 5376.569874410038, 5399.811006614769, 4757.072370887687, 4859.07677541266, 4872.707637541759, 4894.947586268951, 4927.901441971158, 4837.201861692816, 4921.089598424285, 4942.5304596063315, 4962.330085438456, 5001.699898006132, 4757.072370887661, 4787.712737235777, 4833.2266837306215, 4850.369451971256, 4925.753712314406, 4834.661573689843, 4840.806367745321, 4844.612431005511, 4847.394075740533, 4865.902681946377, 4757.595604373632, 4814.1334559779225, 4826.396700412449, 4829.855104346875, 4835.806567737286, 5217.58259339252, 5237.502437268454, 5298.814541491068, 5315.309009828737, 5319.148936170194, 5704.372519022904, 5721.370649228623, 5729.570282228808, 5776.393478684761, 5791.3629500755305, 5767.077267637158, 5820.621659592155, 5829.795957141522, 5831.737571809236, 5835.562332825013, 5350.224217488442, 5379.031774280628, 5388.892222155574, 5418.160185171305, 5427.240186373911, 5885.970570147122, 5908.763649454059, 5941.465268125803, 5953.1070339449425, 5955.13650520672, 5547.8890422192135, 5636.633618814764, 5704.030314846486, 5715.514181294553, 5720.799772007959, 5609.887802244014, 5756.769729210869, 5817.418258174149, 5851.034579294454, 5868.119782032644, 5568.693721845257, 5657.717114144359, 5686.943130568641, 5710.914336284959, 5712.80005199816, 5708.743106560215, 5732.197492351074, 5733.254676891977, 5741.1388291756575, 5745.683987380734, 4320.2223599751715, 4403.0, 4429.512753597101, 4432.135733531994, 4486.1924853526025, 3930.9017274568364, 3940.3498422760495, 3940.3498422760495, 3998.5801490843623, 3998.9400158997637, 5529.612927095065, 5535.861603459945, 5540.2243685884005, 5542.722863856791, 5549.611527193058, 5661.348944871393, 5669.348024977098, 5686.289213848269, 5703.54371650267, 5779.930712818142, 5448.291722076184, 5449.073657478239, 5450.291462109901, 5459.2902922619805, 5460.726963651801, 4843.782029808667, 4884.438289596742, 4885.609151267961, 4890.144224760653, 4936.086823937583, 5796.62321949072, 5912.054071348563, 5989.071693887455, 5994.400559944058, 6069.150318955261, 5816.41835816415, 5818.0, 5820.185174075717, 5821.330546986981, 5829.737661805314, 6022.45797878193, 6026.246719160105, 6027.186329845415, 6029.849253768515, 6032.3967603239325, 5527.419620939743, 5649.858753531194, 5676.148577713376, 5692.0, 5715.142728590745, 5723.370429252862, 5740.282464691913, 5750.971245143747, 5754.05058165398, 5760.798372056958, 5562.137868630369, 5571.331440227199, 5582.7766889323975, 5584.944150558443, 5585.748641311232, 5393.514583687487, 5516.200150978166, 5635.830925072254, 5649.293838270216, 5675.716214189191, 5664.235328230801, 5667.801626943037, 5673.631213971079, 5676.545876329801, 5679.545636349165, 5561.805336813192, 5674.602777805679, 5690.061139911868, 5720.11338242573, 5720.771169153354, 5485.286912701324, 5515.586331025109, 5549.028919939075, 5603.719814009201, 5637.295338082739], "value": 5301.515348024827, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.9263398127017, 588.4703766610053, 591.8697886464978, 619.9535034872384, 642.8714257148572, 36897.44653830191, 41230.17539649205, 41262.38106428398, 41318.38022429666, 41322.58677413225, 41905.161896762045, 42258.154836903246, 42423.0, 42434.0, 42491.0, 8803.471791692487, 8905.866412003825, 8963.0, 8973.46159230445, 9013.909860901373, 8891.244244239248, 8938.597763100675, 8946.686865959693, 8950.283977281802, 8966.910330896706, 8773.385862989593, 8790.780230494256, 8797.120287971216, 8800.823983520326, 8820.955895220546, 8895.154960278764, 8898.911010889873, 8924.241439477652, 8942.284617230638, 8945.910540894572, 8815.294776417872, 8880.73357799267, 8884.067172946812, 8888.911110888874, 8891.377603567753, 40213.0, 40905.181896362206, 40912.38631420531, 41022.79488602568, 41052.79473602643, 3250.3499300140065, 3590.3896337622405, 4037.9905023744063, 4193.287141186006, 4316.956830431687, 30849.38301233963, 31890.0, 32028.359432811212, 32107.0, 32124.03627891167, 4082.0, 4157.605027522381, 4186.84861663042, 4231.449911511515, 4381.934270985906, 328877.0, 334746.99999999756, 335327.0, 335581.0, 337884.0, 56375.15437268444, 56392.718036409555, 56669.71665141648, 56734.0, 56900.430995689516, 59254.70372648195, 59303.0, 59335.40664593385, 59466.0, 59556.0, 14399.712005759826, 14457.421703131968, 14471.348789304297, 14471.782923255949, 14490.130592164503, 11844.28934263947, 11852.70368240801, 11860.10238361858, 11870.584529541424, 11870.703232419259, 14867.256637168315, 15460.591819666246, 15507.224638768017, 15516.224188790515, 15999.0, 6542.387616730194, 6675.299093595103, 6719.395254427125, 6725.932740672629, 6762.154730658668, 854.6624083487112, 956.1251454918671, 959.4195511715451, 989.0949780950493, 1052.315994603514, 27246.0, 28722.569161462594, 28875.133745987652, 29257.414851702848, 29800.552991705143, 1038.9220808439397, 1040.838670006135, 1066.6373433032807, 1074.033369967036, 1090.7927493776158, 14133.222672753098, 14964.625884352761, 14979.325930333162, 15112.0, 15237.695246095016, 517351.0, 518227.0, 519512.0, 519804.0, 520427.0, 58477.415225847195, 58580.7070964651, 58814.705926470946, 58815.0, 58893.0, 1329.308759445083, 1337.5987203838808, 1370.0615078671142, 1374.6357215337944, 1383.5503461375092, 27199.86400067987, 27903.0, 27960.720392796626, 28845.27886802847, 28904.0, 51253.48746512636, 51803.481965181374, 52063.0, 52174.21738673847, 52193.217101742746, 447605.0, 448438.0, 449086.0, 449093.0, 452121.0, 28057.579136312565, 28103.032787704666, 28636.57045144283, 28731.42537149287, 29012.0, 46430.767846160554, 47309.76345118252, 47412.0, 47805.76097119492, 48578.27132592943, 40705.79647101746, 41027.025405680506, 41419.792901035304, 41534.79232603818, 42405.36391954185, 41249.79375103105, 41519.37720934128, 41849.16301673889, 41949.37075943924, 42551.574484254765, 34746.13134671653, 35070.0, 35153.1211719709, 35479.0, 35603.82198088993, 34974.65025349714, 36435.98806197054, 36502.33450975325, 37241.81379093087, 37702.0, 24718.25845224646, 24720.752792471845, 24792.504149916538, 25024.49951001006, 25234.87382563149], "value": 19367.410908604863, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.7608282864624, 389.11088163546304, 397.9263836190305, 403.8647053237166, 416.6583401610679, 13548.45806167752, 18712.251509939604, 18973.14620842062, 20381.388558343257, 20405.285814996478, 19566.31517896874, 19959.201631934742, 20054.49863753407, 20611.587768244663, 20637.142657160854, 5733.827985160452, 5789.39211382805, 5829.795957141501, 5867.031939729939, 5904.350521442638, 5829.067349224125, 5829.154772557977, 5876.294844618652, 5881.7353219105025, 5900.055991041434, 5656.717164141776, 5755.654660720349, 5812.709364531777, 5846.619969701977, 5884.4703976642095, 5807.767689292423, 5807.970960145214, 5815.883682326351, 5850.151727999459, 5869.50109240715, 5075.467075957045, 5213.713245771481, 5225.895482090375, 5233.398159211663, 5246.134387826004, 24082.0, 24208.515829683485, 24404.14585489517, 24583.754162458325, 24781.62827557588, 2314.780095890888, 2415.879206039691, 2462.4090218347646, 2494.064725727852, 2686.31498967762, 10438.32150910196, 10731.35611863283, 12424.254544727346, 13674.589762307147, 15522.593997930338, 1963.7054441833695, 1995.4113536506766, 2034.8982550872545, 2066.4317312738967, 2067.3487851326936, 82952.58523707344, 92688.53655731745, 93261.53369233178, 94647.0, 95398.0, 10084.092431681038, 10431.269811113301, 10497.475126243657, 10612.310199836986, 10778.676639700821, 14197.78703319451, 14208.07647502909, 14255.21596312192, 14255.92872035654, 14288.21414822174, 7354.96322518384, 7666.0, 7752.069751629728, 7831.099423566363, 7845.411594130463, 7305.269473052758, 7459.0, 7520.398368130536, 7655.020086274666, 7754.806129846799, 4261.190373828963, 4272.87181384559, 4340.457442819647, 4370.169667763115, 4476.127155204704, 1935.9739338150803, 2017.778044415113, 2022.6763717805081, 2078.646630072861, 2108.736407949006, 894.3873446689039, 933.1741408853078, 939.8449255872705, 960.6253561111172, 983.7844834882494, 17526.824731752775, 18577.814221857607, 18830.152643131092, 18887.905560472384, 18908.43274701761, 934.5887809363858, 981.1905178227847, 982.543117450389, 1019.5420499049429, 1021.8927012663563, 8472.576371181416, 9915.851262231072, 10548.947255263827, 10598.682039538826, 10615.469226538642, 457595.0, 462563.0, 473964.0, 475451.0, 476102.0, 52226.477735222164, 58660.0, 86691.56654216815, 99195.0, 99580.50209749049, 1002.0330381182195, 1012.1295685710284, 1055.4195192644015, 1073.4096247064083, 1073.9946300268605, 15791.447299344467, 15797.813579401238, 15965.840341596435, 16939.49181524556, 17225.655486890442, 42184.0, 42543.1491370177, 43475.347869782614, 43488.13023739571, 43853.0, 54830.45169548413, 59023.0, 60276.698616506634, 60856.0, 61856.38143618506, 8878.158989123676, 11926.701832453911, 12775.488980440678, 13195.406206720529, 13373.331333433483, 13679.247641379421, 13800.309984500534, 13923.323126926312, 14895.62760930942, 14927.253637318308, 11364.034057105238, 11582.768344633228, 11989.64031079069, 12149.149559530748, 12176.39118044112, 12089.0, 12385.071119665881, 12641.683957901127, 12652.17760845542, 13249.668758281121, 11945.283283003047, 11974.46114924813, 12083.51665933388, 12278.938605306916, 12602.306873121699, 12838.871611283768, 12979.805302920275, 13038.869611303766, 13051.477940882258, 13077.607671769862, 7763.184865589032, 8015.919840801517, 8017.919820801717, 8126.5936703163425, 11720.886515780987], "value": 9368.668434399262, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1484.7921291019256, 1502.4666243483564, 1652.5538104711727, 1749.7812773403325, 1764.9117544122792, 7587.848243035136, 8410.831783364336, 8511.957440212806, 9014.774630634238, 9021.233195178409, 8582.527960962145, 8871.37900346976, 8949.194572488475, 8950.23922966547, 8985.236254918324, 2394.724606670238, 2397.7841994220516, 2411.433313171412, 2414.637804329347, 2425.9272221833285, 2383.976160238393, 2386.0575072846214, 2456.631505274205, 2461.8645974471397, 2465.839720418167, 2414.5050264695783, 2422.757724227572, 2437.1591800828774, 2455.533448644752, 2458.311672731629, 2370.1467471710343, 2378.0487804878103, 2379.5716770981303, 2392.270357540949, 2414.794742446894, 2321.303608917318, 2325.3256555599023, 2328.4528135888054, 2332.440214348544, 2340.5903966805913, 8936.195742383152, 9023.503707296097, 9091.681791137345, 9144.54277286133, 9174.770630734218, 5280.3663560372615, 5394.1908713692865, 5396.217548455491, 5403.83788486346, 5434.728263586844, 3265.96734032659, 3291.210109573709, 3311.4536101543217, 3331.7001469867587, 3361.5798025246845, 1026.271347343387, 1032.3960483117385, 1046.23102020016, 1052.9684109476727, 1059.2426415113232, 12701.872981270253, 12763.192097738483, 12768.170068945488, 12800.231986080866, 12818.743625127538, 4535.795889184995, 4639.512851150648, 4857.6599638025, 4876.805182730253, 4912.533309335608, 10598.258121931545, 10680.946595266974, 10713.089387402159, 10715.785684286271, 10730.892691073146, 5423.403425623178, 5460.426655201226, 5460.481254280837, 5471.753771080311, 5474.616776825584, 4286.742795432284, 4746.786394612251, 4809.951900480951, 4827.734474603931, 4979.676321039121, 3999.5400528938962, 4075.144219713893, 4152.584741525884, 4160.334346504545, 4161.417401563784, 1312.7440149171011, 1329.6476433745065, 1332.0, 1351.8310211223597, 1358.898082643786, 834.5576844272546, 951.7620594851287, 965.2856885904521, 973.571628483465, 982.5529384130203, 5529.917051244234, 5797.956367853827, 5824.854378640483, 5858.912116318259, 5943.514121469632, 455.3647661512238, 459.33396574966434, 475.7264572870544, 477.56302982770376, 478.9856304310876, 3790.8294126764363, 3832.137769002008, 3869.9613003870163, 3907.628775266345, 3948.545917219499, 10949.781004380027, 11270.887291127148, 11307.095432365391, 11349.262297950607, 11384.658460246206, 11156.16328775345, 11179.776404471864, 11183.092395977104, 11199.72000699989, 11214.775704485864, 8273.917260827435, 8313.750587482386, 8356.791080222922, 8371.58142092893, 8462.323014158976, 5723.713814309184, 5765.250517432707, 5825.563082768725, 6002.219711437485, 6033.698315084141, 10140.746481338025, 10152.137068349273, 10171.542280597243, 10316.587336506456, 10397.53211105487, 9885.555150018123, 10243.436610986468, 10523.894761052292, 10541.998510141524, 10583.5237414315, 7105.0, 7626.656800443882, 7838.3337416320255, 7893.210678932291, 7978.082520509984, 8675.479471231747, 8715.825683486422, 8802.38383313162, 8828.470291782256, 8844.425112367675, 7730.613469326624, 7823.178566250689, 7943.523388596703, 7962.840743184988, 8059.43583949118, 7677.61611919413, 7760.3403710685225, 7789.454738168274, 7863.764087077397, 7888.84222315539, 6675.365840245169, 6733.225679046972, 6739.157605299338, 6740.494462915203, 6741.1910570731825, 5104.897902042013, 5152.0, 5232.293640358503, 5261.552768014609, 5363.410024897336, 5228.555572776357, 5245.475452454877, 5251.212318152155, 5275.8681032972945, 5518.889622207453], "value": 4607.4068958080925, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.6383454778827, 324.1830586920959, 332.30548154357405, 336.30720715326424, 338.17822690861226, 5399.19012148178, 5451.318585176853, 5596.944030559694, 5650.9717451412735, 5652.378238393773, 5391.73041347933, 5406.324209473816, 5429.511343979041, 5450.482204190605, 5455.290812194409, 4274.636655884254, 4281.223292333678, 4291.742495450283, 4302.182585308797, 4311.0, 4210.59999300066, 4219.472565929259, 4268.719384184732, 4293.914121717564, 4335.501417336999, 4217.198732240864, 4225.915481690365, 4227.196832601796, 4230.873073807791, 4247.787610619456, 4235.851745188935, 4252.957470425303, 4260.339647354649, 4273.9358909616385, 4284.485861696617, 3620.71034317254, 3797.9240415191543, 3802.2205447883116, 3808.638179372955, 3811.8094095295123, 5365.558670804774, 5369.597280203961, 5389.38318504451, 5402.108652072403, 5410.08028635129, 4917.950820491785, 4946.777395017233, 4959.70241785494, 4979.751012449363, 4984.87537811554, 5549.833504994856, 5750.65496070233, 5759.942400575983, 5764.443600227957, 5804.854878628026, 4166.187708346879, 4172.144710334404, 4180.372944058385, 4181.247375472413, 4183.807614829759, 5974.103884417329, 6008.75964961401, 6011.458968692838, 6033.637981721155, 6035.577509574332, 4113.259613269581, 4265.805574439162, 4285.485741711014, 4297.851074462768, 4309.84915527955, 4285.7642829644665, 4291.699581029298, 4303.935440968388, 4304.246756817544, 4310.396544483775, 4916.778744956486, 4919.483454237254, 4920.975395123073, 4952.90094198114, 4996.200607902718, 5639.182318563785, 5868.2077919480325, 5868.7088840455035, 5875.797690258819, 5879.617824841457, 1458.5478501664518, 1488.0848278308763, 1490.7316682996948, 1491.455618699167, 1491.4854375240525, 908.8227795579799, 957.593022965237, 957.6552441121191, 973.3040875773855, 978.7308490165119, 4871.537203965618, 4894.828680996148, 4909.22628714775, 4914.434839993375, 4962.330085438492, 5109.540141387293, 5240.633155679066, 5266.236395722599, 5268.9736551317, 5284.5772338212855, 4619.815207391734, 4851.749327950281, 4860.392450943632, 4868.9756551217015, 4926.984507626273, 2736.698963114056, 2774.375765452757, 2778.861056947185, 2798.432877588557, 2799.468101060792, 5280.9207861882105, 5290.92063619046, 5315.176147697113, 5320.893582128336, 5347.545458635982, 5099.184130539096, 5159.0040283304725, 5276.604254680838, 5314.601404894648, 5350.057468392369, 5434.130539113723, 5437.34751829783, 5437.619366644297, 5439.864003399867, 5441.483059109379, 5219.556337711337, 5221.399539052905, 5245.606579506629, 5264.578833693219, 5288.471152884681, 4899.799549110491, 5188.922166167586, 5190.480951904779, 5201.76592053366, 5233.770064035025, 5369.4093649697725, 5371.946280537301, 5372.946270537401, 5397.730113494231, 5423.83728488146, 3867.767933923861, 3974.900627484336, 4125.463689720317, 4206.801061697402, 4243.68172387066, 5893.263342082239, 5920.082387229814, 5934.9109763354445, 5956.0, 5966.525106170372, 5633.324001119892, 5806.709664516842, 5819.970900145472, 5871.412858714094, 5899.882002360015, 5634.267545219095, 5721.57088218377, 5742.277316804858, 5746.9712651436475, 5750.367459579359, 5733.799317023884, 5735.684537350486, 5752.539796816328, 5775.33583637887, 5788.884222315614, 5570.749316280858, 5775.133729940375, 5819.621724587888, 5880.882382352414, 5920.467157955804, 5723.761100400583, 5729.71351432435, 5763.164341170591, 5788.507976822018, 5793.507551858139], "value": 4249.336552141964, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [628.9433950944416, 696.9546979446336, 707.6554546361912, 732.8570928668912, 743.6281859070466, 14849.554513364603, 15801.446949356774, 15850.682986340265, 15893.920530397332, 15944.840551594494, 13197.406116724747, 13264.668383290398, 13270.270135142564, 13278.800817987738, 13301.600951971432, 769.8190925132617, 779.8791187365968, 815.1115284340098, 819.2708489444399, 821.7781199076246, 816.0248503038871, 817.7546735979212, 817.8936738224053, 818.3698552114868, 818.8812622169781, 861.0227391910196, 862.5988915154452, 862.8533149364623, 864.4035615425367, 866.5710473315718, 855.7090589199639, 857.1813917708573, 858.5535521528833, 860.3504354212561, 860.6772460327377, 620.4385031546458, 623.8783437229743, 624.5284809968445, 624.8687775567091, 625.337142628815, 14710.411583536647, 14717.70564588713, 14732.96869219155, 14749.188794616291, 14767.778483322758, 13869.729502788876, 14173.149611023371, 14383.640408989755, 14408.423663053465, 14424.423023079064, 11893.345865977368, 11964.70088247792, 12010.69973250667, 12022.15844890858, 12266.693332666666, 3788.2234142000825, 3838.692904567628, 3859.4982652255026, 3884.941725874114, 4010.83956641734, 85448.14551854464, 86712.56643716805, 86800.0, 87577.0, 87767.56116219441, 9811.411315321104, 10091.646792362231, 10172.694819155437, 10223.59105635781, 10303.175745940307, 18683.252669893052, 18716.812831871506, 18754.343597974006, 18760.530986725167, 18852.528686782665, 6949.235584085746, 7032.542884712478, 7068.5758854468895, 7086.0, 7256.0567126273245, 4359.193549193409, 4485.529019452975, 4497.415336006298, 4550.362949187116, 4651.930221046687, 3424.8972530824117, 3516.6483351665142, 3553.1117220694828, 3557.7509574329547, 3560.2167523145386, 585.6632436349116, 597.7818096394784, 605.893968555501, 615.0865964043392, 625.6340041076021, 619.7799781077742, 621.8165641135876, 678.4606238040769, 684.6542496039468, 715.5635062611907, 8976.596053177622, 9645.662401815904, 9879.604815807432, 9932.751681208028, 10221.897781022095, 543.4375421438792, 627.3525721455444, 644.680882962927, 657.431321906557, 706.2125729811223, 4363.323684828857, 4623.0, 4688.97655511727, 4692.131955588227, 4695.694779839299, 75092.62453687696, 76085.0, 76184.0, 97448.51275743576, 100718.0, 63171.68414157992, 94609.0, 100208.98119169309, 100392.0, 102852.0, 75355.24644753592, 76936.0, 88419.0, 89638.0, 92081.99999999866, 9511.904880951379, 9848.0, 9943.751406214902, 10069.748256293358, 10076.345037572535, 47783.0, 52315.73842130765, 52363.0, 53388.46611533835, 54693.0, 52237.7388113057, 66457.66771166114, 67723.66138169277, 68345.65827170832, 69588.30411695818, 12261.87738122643, 12405.813912791496, 12515.4368053436, 12558.434870431036, 12761.298128603015, 14090.295485225493, 14162.221077840817, 14240.216788076756, 14296.142231466145, 14528.927355363156, 12703.555375561811, 13282.0, 13687.520936767165, 13773.862261377259, 14490.058146220463, 13147.802782958071, 13215.405306761026, 13292.468301267842, 13915.443382264595, 14105.0, 12695.682607934506, 12707.426398685531, 13246.668833279246, 13313.46746130144, 13444.327783610976, 10098.899011009797, 10137.847932280874, 10357.0, 10457.372557646566, 10883.074938629989, 8548.135715142209, 9543.76140596463, 10336.810136665814, 10466.947665261625, 10686.145108391465], "value": 7244.347163545989, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 109.0, 112.0, 111.0, 111.0, 118.0, 112.0, 111.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 123.0, 147.0, 185.0, 118.0, 151.0, 148.0, 120.0, 179.0, 119.0], "value": 144.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 161.0, 165.0, 175.0, 162.0, 161.0, 166.0, 164.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 177.0, 76.0, 77.0, 75.0, 75.0, 180.0, 77.0], "value": 96.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 164.0, 86.0, 87.0, 87.0, 146.0, 86.0, 85.0, 151.0], "value": 106.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 119.0, 118.0, 118.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 147.0, 148.0, 147.0, 148.0, 148.0, 146.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 54.0, 50.0, 52.0, 54.0, 54.0, 52.0, 51.0, 55.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 63.0, 61.0, 64.0, 61.0, 62.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 84.0, 79.0, 84.0, 77.0, 87.0, 79.0, 83.0, 77.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 143.0, 122.0, 127.0, 140.0, 134.0, 125.0, 129.0, 138.0, 126.0], "value": 132.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 162.0, 164.0, 161.0, 170.0, 164.0, 162.0, 160.0, 164.0], "value": 163.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 66.0, 69.0, 69.0, 69.0, 64.0, 63.0, 64.0], "value": 66.3, "unit": "score"}]}]} 09:26:23 INFO - Return code: 0 09:26:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:26:23 ERROR - # TBPL SUCCESS # 09:26:23 INFO - Running post-action listener: _resource_record_post_action 09:26:23 INFO - [mozharness: 2016-08-18 16:26:23.205723Z] Finished run-tests step (success) 09:26:23 INFO - Running post-run listener: _resource_record_post_run 09:26:23 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 408109056; Read time: 16; Write time: 790852 09:26:23 INFO - TinderboxPrint: CPU usage
13.4% 09:26:23 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 09:26:23 INFO - TinderboxPrint: I/O write bytes / time
408,109,056 / 790,852 09:26:23 INFO - TinderboxPrint: CPU idle
8,236.3 (86.5%) 09:26:23 INFO - TinderboxPrint: CPU user
1,220.0 (12.8%) 09:26:23 INFO - TinderboxPrint: Swap in / out
0 / 0 09:26:23 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 118026240; Read time: 0; Write time: 230436 09:26:23 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 289607680; Read time: 0; Write time: 560412 09:26:23 INFO - Running post-run listener: _upload_blobber_files 09:26:23 INFO - Blob upload gear active. 09:26:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:26:23 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 09:26:23 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:26:23 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:26:24 INFO - (blobuploader) - INFO - Open directory for files ... 09:26:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:26:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:26:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:26:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:25 INFO - (blobuploader) - INFO - Done attempting. 09:26:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:26:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:26:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:26:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:28 INFO - (blobuploader) - INFO - Done attempting. 09:26:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:26:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:26:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:26:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:29 INFO - (blobuploader) - INFO - Done attempting. 09:26:29 INFO - (blobuploader) - INFO - Iteration through files over. 09:26:29 INFO - Return code: 0 09:26:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:26:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:26:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b4cfdfeacd5ae0b46a8297b8daa1cdf6424da4137d2224669d9edf82e03a55070204bc4bec7f17cf863825a23ae0927f0144c6d27ba0a76c137a72135ce3c054", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/cd92ac9d45e3cde67e1cd688748af718383d271ed8bf243c3b4fd271344cebef1dfa91b99ef121db401a01581ee77c63866f50f3cdf5dada01cd2505850b8dcf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/48a6b1aeea3d565351c027ec9d5fb728e74c113371e5cbf6f8ef3ccca8652694d0558569a1a99203e6e59beae77e3660df1299680a719dab2488b0a3ae92c1ca"} 09:26:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:26:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:26:29 INFO - Contents: 09:26:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b4cfdfeacd5ae0b46a8297b8daa1cdf6424da4137d2224669d9edf82e03a55070204bc4bec7f17cf863825a23ae0927f0144c6d27ba0a76c137a72135ce3c054", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/cd92ac9d45e3cde67e1cd688748af718383d271ed8bf243c3b4fd271344cebef1dfa91b99ef121db401a01581ee77c63866f50f3cdf5dada01cd2505850b8dcf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/48a6b1aeea3d565351c027ec9d5fb728e74c113371e5cbf6f8ef3ccca8652694d0558569a1a99203e6e59beae77e3660df1299680a719dab2488b0a3ae92c1ca"} 09:26:29 INFO - Running post-run listener: copy_logs_to_upload_dir 09:26:29 INFO - Copying logs to upload dir... 09:26:29 INFO - mkdir: /builds/slave/test/build/upload/logs 09:26:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.969338 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-08-18 09:26:28.985183) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 09:26:28.988482) ========= 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=8783db0840cc980e80bb0bd400000236-1471536350.459580-1956736234 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b4cfdfeacd5ae0b46a8297b8daa1cdf6424da4137d2224669d9edf82e03a55070204bc4bec7f17cf863825a23ae0927f0144c6d27ba0a76c137a72135ce3c054", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/cd92ac9d45e3cde67e1cd688748af718383d271ed8bf243c3b4fd271344cebef1dfa91b99ef121db401a01581ee77c63866f50f3cdf5dada01cd2505850b8dcf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/48a6b1aeea3d565351c027ec9d5fb728e74c113371e5cbf6f8ef3ccca8652694d0558569a1a99203e6e59beae77e3660df1299680a719dab2488b0a3ae92c1ca"} build_url:https://queue.taskcluster.net/v1/task/QC_jBdDBQJaM4E7h_9NnWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011455 build_url: 'https://queue.taskcluster.net/v1/task/QC_jBdDBQJaM4E7h_9NnWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b4cfdfeacd5ae0b46a8297b8daa1cdf6424da4137d2224669d9edf82e03a55070204bc4bec7f17cf863825a23ae0927f0144c6d27ba0a76c137a72135ce3c054", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/cd92ac9d45e3cde67e1cd688748af718383d271ed8bf243c3b4fd271344cebef1dfa91b99ef121db401a01581ee77c63866f50f3cdf5dada01cd2505850b8dcf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/48a6b1aeea3d565351c027ec9d5fb728e74c113371e5cbf6f8ef3ccca8652694d0558569a1a99203e6e59beae77e3660df1299680a719dab2488b0a3ae92c1ca"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 09:26:29.014791) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 09:26:29.015135) ========= 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=8783db0840cc980e80bb0bd400000236-1471536350.459580-1956736234 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004652 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 09:26:29.100211) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 09:26:29.100531) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 09:26:29.100876) ========= ========= Total master_lag: 0.18 =========