builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-024 starttime: 1474064532.73 results: success (0) buildid: 20160916135317 builduid: d47740a893eb47e98156e9e33e563422 revision: cf19bbf00b0e21f3c8833e6857047b7aae008063 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-16 15:22:12.728858) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-16 15:22:12.729708) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-16 15:22:12.730283) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-16 15:22:12.755690) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-16 15:22:12.755998) ========= 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=41a7e32711b8e08598a63237000001d6-1474064442.60134-1981398999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-16 15:22:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-09-16 15:22:13 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118053 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-16 15:22:12.888469) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-16 15:22:12.888814) ========= 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=41a7e32711b8e08598a63237000001d6-1474064442.60134-1981398999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020556 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-16 15:22:12.939715) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-16 15:22:12.940081) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev cf19bbf00b0e21f3c8833e6857047b7aae008063 --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 cf19bbf00b0e21f3c8833e6857047b7aae008063 --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=41a7e32711b8e08598a63237000001d6-1474064442.60134-1981398999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-16 15:22:13,176 truncating revision to first 12 chars 2016-09-16 15:22:13,176 Setting DEBUG logging. 2016-09-16 15:22:13,177 attempt 1/10 2016-09-16 15:22:13,177 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/cf19bbf00b0e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-16 15:22:13,468 unpacking tar archive at: autoland-cf19bbf00b0e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.602452 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-16 15:22:13.557273) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-16 15:22:13.557703) ========= script_repo_revision: cf19bbf00b0e21f3c8833e6857047b7aae008063 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-16 15:22:13.558260) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-16 15:22:13.558563) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-16 15:22:13.569526) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-09-16 15:22:13.569828) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] 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=41a7e32711b8e08598a63237000001d6-1474064442.60134-1981398999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:22:13 INFO - MultiFileLogger online at 20160916 15:22:13 in /builds/slave/test 15:22:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 15:22:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:22:13 INFO - {'append_to_log': False, 15:22:13 INFO - 'base_work_dir': '/builds/slave/test', 15:22:13 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 15:22:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:22:13 INFO - 'branch': 'Autoland-Non-PGO', 15:22:13 INFO - 'buildbot_json_path': 'buildprops.json', 15:22:13 INFO - 'config_files': ('talos/linux_config.py',), 15:22:13 INFO - 'default_actions': ('clobber', 15:22:13 INFO - 'read-buildbot-config', 15:22:13 INFO - 'download-and-extract', 15:22:13 INFO - 'populate-webroot', 15:22:13 INFO - 'create-virtualenv', 15:22:13 INFO - 'install', 15:22:13 INFO - 'run-tests'), 15:22:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:22:13 INFO - 'download_minidump_stackwalk': True, 15:22:13 INFO - 'download_symbols': 'ondemand', 15:22:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:22:13 INFO - 'tooltool.py': '/tools/tooltool.py', 15:22:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:22:13 INFO - '/tools/misc-python/virtualenv.py')}, 15:22:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:22:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:22:13 INFO - 'installer_path': 'installer.exe', 15:22:13 INFO - 'log_level': 'info', 15:22:13 INFO - 'log_name': 'talos', 15:22:13 INFO - 'log_to_console': True, 15:22:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:22:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:22:13 INFO - 'opt_config_files': (), 15:22:13 INFO - 'pip_index': False, 15:22:13 INFO - 'sps_profile': False, 15:22:13 INFO - 'sps_profile_interval': 0, 15:22:13 INFO - 'suite': 'dromaeojs', 15:22:13 INFO - 'system_bits': '32', 15:22:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:22:13 INFO - 'title': 'talos-linux64-ix-024', 15:22:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:22:13 INFO - 'use_talos_json': True, 15:22:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:22:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:22:13 INFO - 'work_dir': 'build'} 15:22:13 INFO - [mozharness: 2016-09-16 22:22:13.899490Z] Running clobber step. 15:22:13 INFO - Running pre-action listener: _resource_record_pre_action 15:22:13 INFO - Running main action method: clobber 15:22:13 INFO - rmtree: /builds/slave/test/build 15:22:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:22:14 INFO - Running post-action listener: _resource_record_post_action 15:22:14 INFO - [mozharness: 2016-09-16 22:22:14.353930Z] Finished clobber step (success) 15:22:14 INFO - [mozharness: 2016-09-16 22:22:14.354029Z] Running read-buildbot-config step. 15:22:14 INFO - Running pre-action listener: _resource_record_pre_action 15:22:14 INFO - Running main action method: read_buildbot_config 15:22:14 INFO - Using buildbot properties: 15:22:14 INFO - { 15:22:14 INFO - "project": "", 15:22:14 INFO - "product": "firefox", 15:22:14 INFO - "script_repo_revision": "production", 15:22:14 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 15:22:14 INFO - "repository": "", 15:22:14 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 15:22:14 INFO - "buildid": "20160916135317", 15:22:14 INFO - "pgo_build": "False", 15:22:14 INFO - "basedir": "/builds/slave/test", 15:22:14 INFO - "buildnumber": 459, 15:22:14 INFO - "slavename": "talos-linux64-ix-024", 15:22:14 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:22:14 INFO - "platform": "ubuntu64_hw", 15:22:14 INFO - "scheduler": "tests-autoland-linux64-talos", 15:22:14 INFO - "branch": "autoland", 15:22:14 INFO - "repo_path": "integration/autoland", 15:22:14 INFO - "revision": "cf19bbf00b0e21f3c8833e6857047b7aae008063", 15:22:14 INFO - "stage_platform": "linux64", 15:22:14 INFO - "builduid": "d47740a893eb47e98156e9e33e563422", 15:22:14 INFO - "slavebuilddir": "test" 15:22:14 INFO - } 15:22:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/V8BLiw7XQSW3Nc_ZBEHUUw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 15:22:14 INFO - Running post-action listener: _resource_record_post_action 15:22:14 INFO - [mozharness: 2016-09-16 22:22:14.356450Z] Finished read-buildbot-config step (success) 15:22:14 INFO - [mozharness: 2016-09-16 22:22:14.356539Z] Running download-and-extract step. 15:22:14 INFO - Running pre-action listener: _resource_record_pre_action 15:22:14 INFO - Running main action method: download_and_extract 15:22:14 INFO - mkdir: /builds/slave/test/build/tests 15:22:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:14 INFO - trying https://queue.taskcluster.net/v1/task/V8BLiw7XQSW3Nc_ZBEHUUw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:22:14 INFO - Downloading https://queue.taskcluster.net/v1/task/V8BLiw7XQSW3Nc_ZBEHUUw/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 15:22:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V8BLiw7XQSW3Nc_ZBEHUUw/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 15:22:14 INFO - Downloaded 1361 bytes. 15:22:14 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:22:14 INFO - Using the following test package requirements: 15:22:14 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:22:14 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:22:14 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:22:14 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:22:14 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:22:14 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:22:14 INFO - u'jsshell-linux-x86_64.zip'], 15:22:14 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:22:14 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:22:14 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:22:14 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:22:14 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:22:14 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:22:14 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:22:14 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:22:14 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:22:14 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:22:14 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:22:14 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:22:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V8BLiw7XQSW3Nc_ZBEHUUw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:22:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V8BLiw7XQSW3Nc_ZBEHUUw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:22:14 INFO - Fetch https://queue.taskcluster.net/v1/task/V8BLiw7XQSW3Nc_ZBEHUUw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:22:15 INFO - Expected file size: 20365681 15:22:19 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 15:22:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V8BLiw7XQSW3Nc_ZBEHUUw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:22:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V8BLiw7XQSW3Nc_ZBEHUUw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:22:19 INFO - Fetch https://queue.taskcluster.net/v1/task/V8BLiw7XQSW3Nc_ZBEHUUw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:22:20 INFO - Expected file size: 20365681 15:22:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V8BLiw7XQSW3Nc_ZBEHUUw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 15:22:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V8BLiw7XQSW3Nc_ZBEHUUw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:22:24 INFO - Fetch https://queue.taskcluster.net/v1/task/V8BLiw7XQSW3Nc_ZBEHUUw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:22:25 INFO - Expected file size: 14414048 15:22:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:25 INFO - trying https://queue.taskcluster.net/v1/task/V8BLiw7XQSW3Nc_ZBEHUUw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:22:25 INFO - Downloading https://queue.taskcluster.net/v1/task/V8BLiw7XQSW3Nc_ZBEHUUw/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 15:22:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V8BLiw7XQSW3Nc_ZBEHUUw/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 15:22:27 INFO - Downloaded 55597365 bytes. 15:22:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V8BLiw7XQSW3Nc_ZBEHUUw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:22:27 INFO - mkdir: /builds/slave/test/properties 15:22:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:22:27 INFO - Writing to file /builds/slave/test/properties/build_url 15:22:27 INFO - Contents: 15:22:27 INFO - build_url:https://queue.taskcluster.net/v1/task/V8BLiw7XQSW3Nc_ZBEHUUw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:22:27 INFO - Running post-action listener: _resource_record_post_action 15:22:27 INFO - Running post-action listener: set_extra_try_arguments 15:22:27 INFO - [mozharness: 2016-09-16 22:22:27.767130Z] Finished download-and-extract step (success) 15:22:27 INFO - [mozharness: 2016-09-16 22:22:27.767357Z] Running populate-webroot step. 15:22:27 INFO - Running pre-action listener: _resource_record_pre_action 15:22:27 INFO - Running main action method: populate_webroot 15:22:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:22:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:22:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:22:27 INFO - '--tppagecycles', 15:22:27 INFO - '7'], 15:22:27 INFO - 'tests': ['tsvgm']}}, 15:22:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:22:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:22:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:22:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:22:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:22:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:22:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:27 INFO - 'talos_options': ['--disable-e10s'], 15:22:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:22:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:22:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:27 INFO - 'talos_options': ['--disable-e10s'], 15:22:27 INFO - 'tests': ['damp', 'tps']}, 15:22:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:27 INFO - 'tests': ['damp', 'tps']}, 15:22:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:22:27 INFO - 'tests': ['dromaeo_dom']}, 15:22:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:22:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:22:27 INFO - 'tests': ['basic_compositor_video']}, 15:22:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:22:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:22:27 INFO - 'tests': ['a11yr', 15:22:27 INFO - 'ts_paint', 15:22:27 INFO - 'tpaint', 15:22:27 INFO - 'sessionrestore', 15:22:27 INFO - 'sessionrestore_no_auto_restore', 15:22:27 INFO - 'tabpaint']}, 15:22:27 INFO - 'other-e10s': {'tests': ['a11yr', 15:22:27 INFO - 'ts_paint', 15:22:27 INFO - 'tpaint', 15:22:27 INFO - 'sessionrestore', 15:22:27 INFO - 'sessionrestore_no_auto_restore', 15:22:27 INFO - 'tabpaint']}, 15:22:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:22:27 INFO - 'ts_paint', 15:22:27 INFO - 'tpaint', 15:22:27 INFO - 'sessionrestore', 15:22:27 INFO - 'sessionrestore_no_auto_restore', 15:22:27 INFO - 'tabpaint']}, 15:22:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:22:27 INFO - 'ts_paint', 15:22:27 INFO - 'tpaint', 15:22:27 INFO - 'sessionrestore', 15:22:27 INFO - 'sessionrestore_no_auto_restore', 15:22:27 INFO - 'tabpaint']}, 15:22:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:22:27 INFO - 'tests': ['a11yr', 15:22:27 INFO - 'ts_paint', 15:22:27 INFO - 'tpaint', 15:22:27 INFO - 'sessionrestore', 15:22:27 INFO - 'sessionrestore_no_auto_restore', 15:22:27 INFO - 'tabpaint']}, 15:22:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:22:27 INFO - 'tests': ['a11yr', 15:22:27 INFO - 'ts_paint', 15:22:27 INFO - 'tpaint', 15:22:27 INFO - 'sessionrestore', 15:22:27 INFO - 'sessionrestore_no_auto_restore', 15:22:27 INFO - 'tabpaint']}, 15:22:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:22:27 INFO - 'tests': ['tsvgx', 15:22:27 INFO - 'tsvgr_opacity', 15:22:27 INFO - 'tart', 15:22:27 INFO - 'tscrollx', 15:22:27 INFO - 'cart']}, 15:22:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:22:27 INFO - 'tsvgr_opacity', 15:22:27 INFO - 'tart', 15:22:27 INFO - 'tscrollx', 15:22:27 INFO - 'cart']}, 15:22:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:27 INFO - 'talos_options': ['--disable-e10s'], 15:22:27 INFO - 'tests': ['tp5o']}, 15:22:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:27 INFO - 'tests': ['tp5o']}, 15:22:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:27 INFO - 'talos_options': ['--disable-e10s', 15:22:27 INFO - '--xperf_path', 15:22:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:22:27 INFO - 'tests': ['tp5n']}, 15:22:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:27 INFO - 'talos_options': ['--xperf_path', 15:22:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:22:27 INFO - 'tests': ['tp5n']}}, 15:22:27 INFO - 'talos.zip': {'path': '', 15:22:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:22:27 INFO - Running post-action listener: _resource_record_post_action 15:22:27 INFO - [mozharness: 2016-09-16 22:22:27.789449Z] Finished populate-webroot step (success) 15:22:27 INFO - [mozharness: 2016-09-16 22:22:27.789537Z] Running create-virtualenv step. 15:22:27 INFO - Running pre-action listener: _resource_record_pre_action 15:22:27 INFO - Running main action method: create_virtualenv 15:22:27 INFO - Creating virtualenv /builds/slave/test/build/venv 15:22:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:22:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:22:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:22:27 INFO - Using real prefix '/usr' 15:22:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:22:28 INFO - Installing distribute.............................................................................................................................................................................................done. 15:22:30 INFO - Installing pip.................done. 15:22:30 INFO - Return code: 0 15:22:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:22:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90e751ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2729ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2726f60>, '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 0x2727d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27281d0>, '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': '41a7e32711b8e08598a63237000001d6-1474064442.60134-1981398999', '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 15:22:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:22:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:22:30 INFO - Using env: {'DISPLAY': ':0', 15:22:30 INFO - 'HOME': '/home/cltbld', 15:22:30 INFO - 'LANG': 'en_US.UTF-8', 15:22:30 INFO - 'LANGUAGE': 'en_US:en', 15:22:30 INFO - 'LOGNAME': 'cltbld', 15:22:30 INFO - 'MAIL': '/var/mail/cltbld', 15:22:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:30 INFO - 'MOZ_NO_REMOTE': '1', 15:22:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:30 INFO - 'NO_EM_RESTART': '1', 15:22:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:30 INFO - 'PWD': '/builds/slave/test', 15:22:30 INFO - 'SHELL': '/bin/bash', 15:22:30 INFO - 'SHLVL': '1', 15:22:30 INFO - 'TERM': 'linux', 15:22:30 INFO - 'TMOUT': '86400', 15:22:30 INFO - 'USER': 'cltbld', 15:22:30 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474064442.60134-1981398999', 15:22:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:30 INFO - '_': '/tools/buildbot/bin/python'} 15:22:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:22:30 INFO - Cleaning up... 15:22:30 INFO - Return code: 0 15:22:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:22:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90e751ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2729ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2726f60>, '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 0x2727d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27281d0>, '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': '41a7e32711b8e08598a63237000001d6-1474064442.60134-1981398999', '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 15:22:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:22:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:22:30 INFO - Using env: {'DISPLAY': ':0', 15:22:30 INFO - 'HOME': '/home/cltbld', 15:22:30 INFO - 'LANG': 'en_US.UTF-8', 15:22:30 INFO - 'LANGUAGE': 'en_US:en', 15:22:30 INFO - 'LOGNAME': 'cltbld', 15:22:30 INFO - 'MAIL': '/var/mail/cltbld', 15:22:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:30 INFO - 'MOZ_NO_REMOTE': '1', 15:22:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:30 INFO - 'NO_EM_RESTART': '1', 15:22:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:30 INFO - 'PWD': '/builds/slave/test', 15:22:30 INFO - 'SHELL': '/bin/bash', 15:22:30 INFO - 'SHLVL': '1', 15:22:30 INFO - 'TERM': 'linux', 15:22:30 INFO - 'TMOUT': '86400', 15:22:30 INFO - 'USER': 'cltbld', 15:22:30 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474064442.60134-1981398999', 15:22:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:30 INFO - '_': '/tools/buildbot/bin/python'} 15:22:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:30 INFO - Downloading/unpacking psutil>=3.1.1 15:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:22:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:22:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:22:32 INFO - Installing collected packages: psutil 15:22:32 INFO - Running setup.py install for psutil 15:22:32 INFO - building 'psutil._psutil_linux' extension 15:22:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:22:33 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 15:22:33 INFO - building 'psutil._psutil_posix' extension 15:22:33 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 15:22:33 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 15:22:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:22:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:22:33 INFO - Successfully installed psutil 15:22:33 INFO - Cleaning up... 15:22:33 INFO - Return code: 0 15:22:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:22:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:33 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 0x7f90e751ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2729ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2726f60>, '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 0x2727d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27281d0>, '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': '41a7e32711b8e08598a63237000001d6-1474064442.60134-1981398999', '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 15:22:33 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 15:22:33 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 15:22:33 INFO - Using env: {'DISPLAY': ':0', 15:22:33 INFO - 'HOME': '/home/cltbld', 15:22:33 INFO - 'LANG': 'en_US.UTF-8', 15:22:33 INFO - 'LANGUAGE': 'en_US:en', 15:22:33 INFO - 'LOGNAME': 'cltbld', 15:22:33 INFO - 'MAIL': '/var/mail/cltbld', 15:22:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:33 INFO - 'MOZ_NO_REMOTE': '1', 15:22:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:33 INFO - 'NO_EM_RESTART': '1', 15:22:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:33 INFO - 'PWD': '/builds/slave/test', 15:22:33 INFO - 'SHELL': '/bin/bash', 15:22:33 INFO - 'SHLVL': '1', 15:22:33 INFO - 'TERM': 'linux', 15:22:33 INFO - 'TMOUT': '86400', 15:22:33 INFO - 'USER': 'cltbld', 15:22:33 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474064442.60134-1981398999', 15:22:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:33 INFO - '_': '/tools/buildbot/bin/python'} 15:22:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:22:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:22:35 INFO - Installing collected packages: mozsystemmonitor 15:22:35 INFO - Running setup.py install for mozsystemmonitor 15:22:35 INFO - Successfully installed mozsystemmonitor 15:22:35 INFO - Cleaning up... 15:22:35 INFO - Return code: 0 15:22:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90e751ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2729ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2726f60>, '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 0x2727d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27281d0>, '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': '41a7e32711b8e08598a63237000001d6-1474064442.60134-1981398999', '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 15:22:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:22:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:22:35 INFO - Using env: {'DISPLAY': ':0', 15:22:35 INFO - 'HOME': '/home/cltbld', 15:22:35 INFO - 'LANG': 'en_US.UTF-8', 15:22:35 INFO - 'LANGUAGE': 'en_US:en', 15:22:35 INFO - 'LOGNAME': 'cltbld', 15:22:35 INFO - 'MAIL': '/var/mail/cltbld', 15:22:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:35 INFO - 'MOZ_NO_REMOTE': '1', 15:22:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:35 INFO - 'NO_EM_RESTART': '1', 15:22:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:35 INFO - 'PWD': '/builds/slave/test', 15:22:35 INFO - 'SHELL': '/bin/bash', 15:22:35 INFO - 'SHLVL': '1', 15:22:35 INFO - 'TERM': 'linux', 15:22:35 INFO - 'TMOUT': '86400', 15:22:35 INFO - 'USER': 'cltbld', 15:22:35 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474064442.60134-1981398999', 15:22:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:35 INFO - '_': '/tools/buildbot/bin/python'} 15:22:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:35 INFO - Downloading/unpacking jsonschema==2.5.1 15:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:22:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:38 INFO - Downloading functools32-3.2.3-2.tar.gz 15:22:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:22:38 INFO - warning: no files found matching '*.txt' 15:22:38 INFO - no previously-included directories found matching 'build' 15:22:38 INFO - no previously-included directories found matching 'dist' 15:22:38 INFO - no previously-included directories found matching '.git*' 15:22:38 INFO - Installing collected packages: jsonschema, functools32 15:22:38 INFO - Running setup.py install for functools32 15:22:38 INFO - warning: no files found matching '*.txt' 15:22:38 INFO - no previously-included directories found matching 'build' 15:22:38 INFO - no previously-included directories found matching 'dist' 15:22:38 INFO - no previously-included directories found matching '.git*' 15:22:38 INFO - Successfully installed jsonschema functools32 15:22:38 INFO - Cleaning up... 15:22:38 INFO - Return code: 0 15:22:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:22:38 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')]} 15:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:38 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')]} 15:22:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:38 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 0x7f90e751ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2729ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2726f60>, '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 0x2727d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27281d0>, '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': '41a7e32711b8e08598a63237000001d6-1474064442.60134-1981398999', '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 15:22:38 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 15:22:38 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 15:22:38 INFO - Using env: {'DISPLAY': ':0', 15:22:38 INFO - 'HOME': '/home/cltbld', 15:22:38 INFO - 'LANG': 'en_US.UTF-8', 15:22:38 INFO - 'LANGUAGE': 'en_US:en', 15:22:38 INFO - 'LOGNAME': 'cltbld', 15:22:38 INFO - 'MAIL': '/var/mail/cltbld', 15:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:38 INFO - 'MOZ_NO_REMOTE': '1', 15:22:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:38 INFO - 'NO_EM_RESTART': '1', 15:22:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:38 INFO - 'PWD': '/builds/slave/test', 15:22:38 INFO - 'SHELL': '/bin/bash', 15:22:38 INFO - 'SHLVL': '1', 15:22:38 INFO - 'TERM': 'linux', 15:22:38 INFO - 'TMOUT': '86400', 15:22:38 INFO - 'USER': 'cltbld', 15:22:38 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474064442.60134-1981398999', 15:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:38 INFO - '_': '/tools/buildbot/bin/python'} 15:22:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:22:38 INFO - Cleaning up... 15:22:38 INFO - Return code: 0 15:22:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:22:38 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')]} 15:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:38 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')]} 15:22:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:38 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 0x7f90e751ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2729ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2726f60>, '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 0x2727d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27281d0>, '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': '41a7e32711b8e08598a63237000001d6-1474064442.60134-1981398999', '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 15:22:38 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 15:22:38 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 15:22:38 INFO - Using env: {'DISPLAY': ':0', 15:22:38 INFO - 'HOME': '/home/cltbld', 15:22:38 INFO - 'LANG': 'en_US.UTF-8', 15:22:38 INFO - 'LANGUAGE': 'en_US:en', 15:22:38 INFO - 'LOGNAME': 'cltbld', 15:22:38 INFO - 'MAIL': '/var/mail/cltbld', 15:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:38 INFO - 'MOZ_NO_REMOTE': '1', 15:22:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:38 INFO - 'NO_EM_RESTART': '1', 15:22:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:38 INFO - 'PWD': '/builds/slave/test', 15:22:38 INFO - 'SHELL': '/bin/bash', 15:22:38 INFO - 'SHLVL': '1', 15:22:38 INFO - 'TERM': 'linux', 15:22:38 INFO - 'TMOUT': '86400', 15:22:38 INFO - 'USER': 'cltbld', 15:22:38 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474064442.60134-1981398999', 15:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:38 INFO - '_': '/tools/buildbot/bin/python'} 15:22:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:38 INFO - Downloading/unpacking blobuploader==1.2.4 15:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:40 INFO - Downloading blobuploader-1.2.4.tar.gz 15:22:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:22:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:22:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:22:41 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 15:22:41 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 15:22:41 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 15:22:41 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 15:22:41 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 15:22:41 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 15:22:41 INFO - Downloading docopt-0.6.1.tar.gz 15:22:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:22:41 INFO - Installing collected packages: blobuploader, requests, docopt 15:22:41 INFO - Running setup.py install for blobuploader 15:22:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:22:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:22:41 INFO - Running setup.py install for requests 15:22:41 INFO - Running setup.py install for docopt 15:22:41 INFO - Successfully installed blobuploader requests docopt 15:22:41 INFO - Cleaning up... 15:22:42 INFO - Return code: 0 15:22:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:22:42 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')]} 15:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:42 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')]} 15:22:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:42 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 0x7f90e751ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2729ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2726f60>, '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 0x2727d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27281d0>, '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': '41a7e32711b8e08598a63237000001d6-1474064442.60134-1981398999', '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 15:22:42 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 15:22:42 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 15:22:42 INFO - Using env: {'DISPLAY': ':0', 15:22:42 INFO - 'HOME': '/home/cltbld', 15:22:42 INFO - 'LANG': 'en_US.UTF-8', 15:22:42 INFO - 'LANGUAGE': 'en_US:en', 15:22:42 INFO - 'LOGNAME': 'cltbld', 15:22:42 INFO - 'MAIL': '/var/mail/cltbld', 15:22:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:42 INFO - 'MOZ_NO_REMOTE': '1', 15:22:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:42 INFO - 'NO_EM_RESTART': '1', 15:22:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:42 INFO - 'PWD': '/builds/slave/test', 15:22:42 INFO - 'SHELL': '/bin/bash', 15:22:42 INFO - 'SHLVL': '1', 15:22:42 INFO - 'TERM': 'linux', 15:22:42 INFO - 'TMOUT': '86400', 15:22:42 INFO - 'USER': 'cltbld', 15:22:42 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474064442.60134-1981398999', 15:22:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:42 INFO - '_': '/tools/buildbot/bin/python'} 15:22:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:22:42 INFO - Running setup.py (path:/tmp/pip-RlYr3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:22:42 INFO - Running setup.py (path:/tmp/pip-QGtQWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:22:42 INFO - Running setup.py (path:/tmp/pip-iBp4mp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:22:42 INFO - Running setup.py (path:/tmp/pip-tApNUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:22:42 INFO - Running setup.py (path:/tmp/pip-_9xpWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:22:42 INFO - Running setup.py (path:/tmp/pip-Vjdfob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:22:42 INFO - Running setup.py (path:/tmp/pip-ZOgabW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:22:42 INFO - Running setup.py (path:/tmp/pip-L0GhYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:22:42 INFO - Running setup.py (path:/tmp/pip-7yUnJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:22:42 INFO - Running setup.py (path:/tmp/pip-DLOo7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:22:42 INFO - Running setup.py (path:/tmp/pip-eAlxWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:22:43 INFO - Running setup.py (path:/tmp/pip-Um3JfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:22:43 INFO - Running setup.py (path:/tmp/pip-5w7bV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:22:43 INFO - Running setup.py (path:/tmp/pip-jRYEtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:22:43 INFO - Running setup.py (path:/tmp/pip-pQIk40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:22:43 INFO - Running setup.py (path:/tmp/pip-4KY0Oq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:22:43 INFO - Running setup.py (path:/tmp/pip-yTuZ3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:22:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:22:43 INFO - Running setup.py install for manifestparser 15:22:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:22:43 INFO - Running setup.py install for mozcrash 15:22:43 INFO - Running setup.py install for mozdebug 15:22:43 INFO - Running setup.py install for mozdevice 15:22:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:22:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:22:43 INFO - Running setup.py install for mozfile 15:22:43 INFO - Running setup.py install for mozhttpd 15:22:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:22:44 INFO - Running setup.py install for mozinfo 15:22:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:22:44 INFO - Running setup.py install for mozInstall 15:22:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:22:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:22:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:22:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:22:44 INFO - Running setup.py install for mozleak 15:22:44 INFO - Running setup.py install for mozlog 15:22:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:22:44 INFO - Running setup.py install for moznetwork 15:22:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:22:44 INFO - Running setup.py install for mozprocess 15:22:44 INFO - Running setup.py install for mozprofile 15:22:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:22:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:22:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:22:44 INFO - Running setup.py install for mozrunner 15:22:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:22:44 INFO - Running setup.py install for mozscreenshot 15:22:45 INFO - Running setup.py install for moztest 15:22:45 INFO - Running setup.py install for mozversion 15:22:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:22:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:22:45 INFO - Cleaning up... 15:22:45 INFO - Return code: 0 15:22:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:22:45 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')]} 15:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:45 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')]} 15:22:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:45 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 0x7f90e751ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2729ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2726f60>, '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 0x2727d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27281d0>, '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': '41a7e32711b8e08598a63237000001d6-1474064442.60134-1981398999', '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 15:22:45 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 15:22:45 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 15:22:45 INFO - Using env: {'DISPLAY': ':0', 15:22:45 INFO - 'HOME': '/home/cltbld', 15:22:45 INFO - 'LANG': 'en_US.UTF-8', 15:22:45 INFO - 'LANGUAGE': 'en_US:en', 15:22:45 INFO - 'LOGNAME': 'cltbld', 15:22:45 INFO - 'MAIL': '/var/mail/cltbld', 15:22:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:45 INFO - 'MOZ_NO_REMOTE': '1', 15:22:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:45 INFO - 'NO_EM_RESTART': '1', 15:22:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:45 INFO - 'PWD': '/builds/slave/test', 15:22:45 INFO - 'SHELL': '/bin/bash', 15:22:45 INFO - 'SHLVL': '1', 15:22:45 INFO - 'TERM': 'linux', 15:22:45 INFO - 'TMOUT': '86400', 15:22:45 INFO - 'USER': 'cltbld', 15:22:45 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474064442.60134-1981398999', 15:22:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:45 INFO - '_': '/tools/buildbot/bin/python'} 15:22:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:22:45 INFO - Running setup.py (path:/tmp/pip-KQ8Ou3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:22:45 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)) 15:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:22:45 INFO - Running setup.py (path:/tmp/pip-UZVa_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:22:45 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)) 15:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:22:45 INFO - Running setup.py (path:/tmp/pip-GBQya0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:22:45 INFO - Running setup.py (path:/tmp/pip-Bkiq24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:22:45 INFO - Running setup.py (path:/tmp/pip-AWMFzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:22:45 INFO - Running setup.py (path:/tmp/pip-p__xmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:22:45 INFO - Running setup.py (path:/tmp/pip-Th7OuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:22:45 INFO - Running setup.py (path:/tmp/pip-eGqHFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:22:46 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)) 15:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:22:46 INFO - Running setup.py (path:/tmp/pip-yYhmok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:22:46 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)) 15:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:22:46 INFO - Running setup.py (path:/tmp/pip-ejurCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:22:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 15:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:22:46 INFO - Running setup.py (path:/tmp/pip-MMl8VL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:22:46 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)) 15:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:22:46 INFO - Running setup.py (path:/tmp/pip-nhY7YJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:22:46 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)) 15:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:22:46 INFO - Running setup.py (path:/tmp/pip-qFQZFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:22:46 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)) 15:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:22:46 INFO - Running setup.py (path:/tmp/pip-08fSZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:22:46 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)) 15:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:22:46 INFO - Running setup.py (path:/tmp/pip-lOezfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:22:46 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)) 15:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:22:46 INFO - Running setup.py (path:/tmp/pip-eNbJxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:22:46 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)) 15:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:22:46 INFO - Running setup.py (path:/tmp/pip-tJGhmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:22:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:22:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:22:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:22:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:22:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:22:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:22:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:48 INFO - Downloading blessings-1.6.tar.gz 15:22:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:22:48 INFO - Installing collected packages: blessings 15:22:48 INFO - Running setup.py install for blessings 15:22:48 INFO - Successfully installed blessings 15:22:48 INFO - Cleaning up... 15:22:48 INFO - Return code: 0 15:22:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:22:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:22:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:22:49 INFO - Reading from file tmpfile_stdout 15:22:49 INFO - Current package versions: 15:22:49 INFO - argparse == 1.2.1 15:22:49 INFO - blessings == 1.6 15:22:49 INFO - blobuploader == 1.2.4 15:22:49 INFO - docopt == 0.6.1 15:22:49 INFO - functools32 == 3.2.3-2 15:22:49 INFO - jsonschema == 2.5.1 15:22:49 INFO - manifestparser == 1.1 15:22:49 INFO - mozInstall == 1.12 15:22:49 INFO - mozcrash == 0.17 15:22:49 INFO - mozdebug == 0.1 15:22:49 INFO - mozdevice == 0.48 15:22:49 INFO - mozfile == 1.2 15:22:49 INFO - mozhttpd == 0.7 15:22:49 INFO - mozinfo == 0.9 15:22:49 INFO - mozleak == 0.1 15:22:49 INFO - mozlog == 3.4 15:22:49 INFO - moznetwork == 0.27 15:22:49 INFO - mozprocess == 0.23 15:22:49 INFO - mozprofile == 0.28 15:22:49 INFO - mozrunner == 6.12 15:22:49 INFO - mozscreenshot == 0.1 15:22:49 INFO - mozsystemmonitor == 0.3 15:22:49 INFO - moztest == 0.7 15:22:49 INFO - mozversion == 1.4 15:22:49 INFO - psutil == 3.1.1 15:22:49 INFO - requests == 1.2.3 15:22:49 INFO - wsgiref == 0.1.2 15:22:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:49 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 0x7f90e751ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2729ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2726f60>, '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 0x2727d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27281d0>, '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': '41a7e32711b8e08598a63237000001d6-1474064442.60134-1981398999', '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 15:22:49 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 15:22:49 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 15:22:49 INFO - Using env: {'DISPLAY': ':0', 15:22:49 INFO - 'HOME': '/home/cltbld', 15:22:49 INFO - 'LANG': 'en_US.UTF-8', 15:22:49 INFO - 'LANGUAGE': 'en_US:en', 15:22:49 INFO - 'LOGNAME': 'cltbld', 15:22:49 INFO - 'MAIL': '/var/mail/cltbld', 15:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:49 INFO - 'MOZ_NO_REMOTE': '1', 15:22:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:49 INFO - 'NO_EM_RESTART': '1', 15:22:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:49 INFO - 'PWD': '/builds/slave/test', 15:22:49 INFO - 'SHELL': '/bin/bash', 15:22:49 INFO - 'SHLVL': '1', 15:22:49 INFO - 'TERM': 'linux', 15:22:49 INFO - 'TMOUT': '86400', 15:22:49 INFO - 'USER': 'cltbld', 15:22:49 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474064442.60134-1981398999', 15:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:49 INFO - '_': '/tools/buildbot/bin/python'} 15:22:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:49 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)) 15:22:49 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)) 15:22:49 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)) 15:22:49 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)) 15:22:49 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)) 15:22:49 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)) 15:22:49 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)) 15:22:49 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)) 15:22:49 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)) 15:22:49 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)) 15:22:49 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)) 15:22:49 INFO - Cleaning up... 15:22:49 INFO - Return code: 0 15:22:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:49 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 0x7f90e751ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2729ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2726f60>, '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 0x2727d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27281d0>, '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': '41a7e32711b8e08598a63237000001d6-1474064442.60134-1981398999', '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 15:22:49 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 15:22:49 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 15:22:49 INFO - Using env: {'DISPLAY': ':0', 15:22:49 INFO - 'HOME': '/home/cltbld', 15:22:49 INFO - 'LANG': 'en_US.UTF-8', 15:22:49 INFO - 'LANGUAGE': 'en_US:en', 15:22:49 INFO - 'LOGNAME': 'cltbld', 15:22:49 INFO - 'MAIL': '/var/mail/cltbld', 15:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:49 INFO - 'MOZ_NO_REMOTE': '1', 15:22:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:49 INFO - 'NO_EM_RESTART': '1', 15:22:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:49 INFO - 'PWD': '/builds/slave/test', 15:22:49 INFO - 'SHELL': '/bin/bash', 15:22:49 INFO - 'SHLVL': '1', 15:22:49 INFO - 'TERM': 'linux', 15:22:49 INFO - 'TMOUT': '86400', 15:22:49 INFO - 'USER': 'cltbld', 15:22:49 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474064442.60134-1981398999', 15:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:49 INFO - '_': '/tools/buildbot/bin/python'} 15:22:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:22:49 INFO - Cleaning up... 15:22:49 INFO - Return code: 0 15:22:49 INFO - Running post-action listener: _resource_record_post_action 15:22:49 INFO - Running post-action listener: _start_resource_monitoring 15:22:49 INFO - Starting resource monitoring. 15:22:49 INFO - [mozharness: 2016-09-16 22:22:49.564681Z] Finished create-virtualenv step (success) 15:22:49 INFO - [mozharness: 2016-09-16 22:22:49.565132Z] Running install step. 15:22:49 INFO - Running pre-action listener: _resource_record_pre_action 15:22:49 INFO - Running main action method: install 15:22:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:22:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:22:49 INFO - Reading from file tmpfile_stdout 15:22:49 INFO - Detecting whether we're running mozinstall >=1.0... 15:22:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:22:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:22:49 INFO - Reading from file tmpfile_stdout 15:22:49 INFO - Output received: 15:22:49 INFO - Usage: mozinstall [options] installer 15:22:49 INFO - Options: 15:22:49 INFO - -h, --help show this help message and exit 15:22:49 INFO - -d DEST, --destination=DEST 15:22:49 INFO - Directory to install application into. [default: 15:22:49 INFO - "/builds/slave/test"] 15:22:49 INFO - --app=APP Application being installed. [default: firefox] 15:22:49 INFO - mkdir: /builds/slave/test/build/application 15:22:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:22:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:23:06 INFO - Reading from file tmpfile_stdout 15:23:06 INFO - Output received: 15:23:06 INFO - /builds/slave/test/build/application/firefox/firefox 15:23:06 INFO - Running post-action listener: _resource_record_post_action 15:23:06 INFO - [mozharness: 2016-09-16 22:23:06.013400Z] Finished install step (success) 15:23:06 INFO - [mozharness: 2016-09-16 22:23:06.013646Z] Running run-tests step. 15:23:06 INFO - Running pre-action listener: _resource_record_pre_action 15:23:06 INFO - Running main action method: run_tests 15:23:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:23:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:23:06 INFO - Python 2.7.3 15:23:06 INFO - Return code: 0 15:23:06 INFO - grabbing minidump binary from tooltool 15:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:06 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2726f60>, '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 0x2727d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27281d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:23:06 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:23:06 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:23:06 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:23:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:23:06 INFO - Return code: 0 15:23:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:23:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:23:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:23:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:23:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:23:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V8BLiw7XQSW3Nc_ZBEHUUw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:23:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/V8BLiw7XQSW3Nc_ZBEHUUw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:23:06 INFO - Using env: {'DISPLAY': ':0', 15:23:06 INFO - 'HOME': '/home/cltbld', 15:23:06 INFO - 'LANG': 'en_US.UTF-8', 15:23:06 INFO - 'LANGUAGE': 'en_US:en', 15:23:06 INFO - 'LOGNAME': 'cltbld', 15:23:06 INFO - 'MAIL': '/var/mail/cltbld', 15:23:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:23:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:23:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:06 INFO - 'MOZ_NO_REMOTE': '1', 15:23:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:23:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:06 INFO - 'NO_EM_RESTART': '1', 15:23:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:06 INFO - 'PWD': '/builds/slave/test', 15:23:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:23:06 INFO - 'SHELL': '/bin/bash', 15:23:06 INFO - 'SHLVL': '1', 15:23:06 INFO - 'TERM': 'linux', 15:23:06 INFO - 'TMOUT': '86400', 15:23:06 INFO - 'USER': 'cltbld', 15:23:06 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474064442.60134-1981398999', 15:23:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:06 INFO - '_': '/tools/buildbot/bin/python'} 15:23:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V8BLiw7XQSW3Nc_ZBEHUUw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:23:06 INFO - mozversion application_buildid: 20160916135317 15:23:06 INFO - mozversion application_changeset: cf19bbf00b0e21f3c8833e6857047b7aae008063 15:23:06 INFO - mozversion application_display_name: Nightly 15:23:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:23:06 INFO - mozversion application_name: Firefox 15:23:06 INFO - mozversion application_remotingname: firefox 15:23:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 15:23:06 INFO - mozversion application_vendor: Mozilla 15:23:06 INFO - mozversion application_version: 51.0a1 15:23:06 INFO - mozversion platform_buildid: 20160916135317 15:23:06 INFO - mozversion platform_changeset: cf19bbf00b0e21f3c8833e6857047b7aae008063 15:23:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 15:23:06 INFO - mozversion platform_version: 51.0a1 15:23:06 INFO - using testdate: 1474064586 15:23:06 INFO - actual date: 1474064586 15:23:06 INFO - starting webserver on 'localhost:45944' 15:23:06 INFO - SUITE-START | Running 2 tests 15:23:06 INFO - TEST-START | dromaeo_css 15:23:06 INFO - operating with platform_type : linux_ 15:23:06 INFO - Initialising browser for dromaeo_css test... 15:23:06 INFO - TEST-INFO | started process 16673 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQbzIiX/profile http://localhost:45944/getInfo.html) 15:23:11 INFO - PROCESS | 16673 | __metrics Screen width/height:1600/1200 15:23:11 INFO - PROCESS | 16673 | colorDepth:24 15:23:11 INFO - PROCESS | 16673 | Browser inner width/height: 1024/697 15:23:11 INFO - PROCESS | 16673 | __metrics 15:23:11 INFO - PROCESS | 16673 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:23:11 INFO - PROCESS | 16673 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:23:12 INFO - PROCESS | 16673 | console.error: PushService: 15:23:12 INFO - PROCESS | 16673 | stateChangeProcessEnqueue: Error transitioning state 15:23:12 INFO - PROCESS | 16673 | UnknownError 15:23:12 INFO - TEST-INFO | 16673: exit 0 15:23:12 INFO - Browser initialized. 15:23:12 INFO - Running cycle 1/1 for dromaeo_css test... 15:23:12 INFO - TEST-INFO | started process 16753 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQbzIiX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:23:25 INFO - PROCESS | 16753 | RSS: Main: 173838336 15:23:25 INFO - PROCESS | 16753 | 15:23:49 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.03337 seconds. 15:23:53 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:24:11 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 15:24:13 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.05004 seconds. 15:24:16 INFO - PROCESS | 16753 | 1474064656740 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] 15:24:20 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.01675 seconds. 15:24:23 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:24:26 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.06673 seconds. 15:24:30 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 15:24:32 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.05008 seconds. 15:24:36 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 15:24:37 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 2.01672 seconds. 15:24:43 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.16671 seconds. 15:24:51 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:24:56 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.0334 seconds. 15:24:58 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:25:10 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.03337 seconds. 15:25:15 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:25:19 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 15:25:26 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.03337 seconds. 15:25:31 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.03336 seconds. 15:25:45 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.05004 seconds. 15:25:51 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:25:53 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 15:25:55 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 15:26:03 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.01666 seconds. 15:26:09 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:26:12 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.16668 seconds. 15:26:26 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.01674 seconds. 15:26:30 INFO - PROCESS | 16753 | Cycle 1(1): loaded http://localhost:45944/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45944/tests/dromaeo/cssquery-ext.html) 15:26:31 INFO - PROCESS | 16753 | RSS: Main: 272461824 15:26:31 INFO - PROCESS | 16753 | 15:26:34 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.03336 seconds. 15:26:41 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:26:56 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:27:02 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:27:04 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:27:16 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 15:27:36 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:27:42 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00354 seconds. 15:27:52 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:27:56 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:27:58 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:28:06 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 15:28:08 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1 seconds. 15:28:10 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 15:28:15 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:28:17 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:28:18 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:28:25 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:28:37 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:28:38 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 2.00007 seconds. 15:28:41 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:28:45 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:28:57 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 15:29:00 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:29:05 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:29:33 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 15:29:33 INFO - PROCESS | 16753 | Cycle 1(1): loaded http://localhost:45944/tests/dromaeo/cssquery-ext.html (next: http://localhost:45944/tests/dromaeo/cssquery-jquery.html) 15:29:34 INFO - PROCESS | 16753 | RSS: Main: 274944000 15:29:34 INFO - PROCESS | 16753 | 15:29:46 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:29:49 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:29:51 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:30:01 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:30:12 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:30:29 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:30:35 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:30:45 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:30:47 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:30:59 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:31:05 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:31:17 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:31:28 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 15:31:31 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:31:34 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 15:31:36 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:31:38 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 15:31:45 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.01674 seconds. 15:31:48 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:31:50 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:31:54 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:31:56 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:31:58 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:32:00 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:32:04 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:32:06 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:32:10 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:32:12 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 15:32:14 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:32:20 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 15:32:22 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 15:32:28 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 15:32:30 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:32:36 INFO - PROCESS | 16753 | Cycle 1(1): loaded http://localhost:45944/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45944/tests/dromaeo/cssquery-mootools.html) 15:32:37 INFO - PROCESS | 16753 | RSS: Main: 246558720 15:32:37 INFO - PROCESS | 16753 | 15:32:42 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.03341 seconds. 15:33:20 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:33:22 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:33:26 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 15:33:34 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 15:33:42 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:33:44 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:33:54 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:33:56 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:34:04 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:34:10 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:34:12 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 15:34:33 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 15:34:36 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:34:38 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:34:40 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:34:50 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:34:51 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:34:52 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 2.00008 seconds. 15:34:53 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 15:35:23 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:35:29 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:35:31 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 15:35:33 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:35:35 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:35:37 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:35:39 INFO - PROCESS | 16753 | Cycle 1(1): loaded http://localhost:45944/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45944/tests/dromaeo/cssquery-prototype.html) 15:35:40 INFO - PROCESS | 16753 | RSS: Main: 256008192 15:35:40 INFO - PROCESS | 16753 | 15:35:47 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1 seconds. 15:35:48 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:35:56 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:35:58 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 15:36:17 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:36:19 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:36:25 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:36:27 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:36:39 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:36:42 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 15:36:44 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:36:53 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:36:57 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.01667 seconds. 15:37:05 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 15:37:09 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 15:37:18 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.05005 seconds. 15:37:20 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 15:37:24 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:37:28 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.03333 seconds. 15:37:35 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 15:37:38 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:37:40 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:38:04 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:38:08 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:38:10 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 15:38:14 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.01666 seconds. 15:38:16 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.05004 seconds. 15:38:18 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:38:20 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:38:24 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:38:29 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:38:32 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 15:38:37 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 15:38:43 INFO - PROCESS | 16753 | Cycle 1(1): loaded http://localhost:45944/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45944/tests/dromaeo/cssquery-yui.html) 15:38:43 INFO - PROCESS | 16753 | RSS: Main: 221335552 15:38:43 INFO - PROCESS | 16753 | 15:38:47 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 15:38:51 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:38:53 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:38:56 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:39:12 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:39:14 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:39:28 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:39:40 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 15:39:59 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:40:01 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 15:40:07 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:40:10 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:40:15 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:40:17 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:40:47 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:40:53 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:40:57 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:41:01 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 15:41:03 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:41:07 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.00457 seconds. 15:41:33 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 15:41:46 INFO - PROCESS | 16753 | [GFX1-]: Refresh driver waiting for the compositor for 1.01422 seconds. 15:41:46 INFO - PROCESS | 16753 | Cycle 1(1): loaded http://localhost:45944/tests/dromaeo/cssquery-yui.html (next: http://localhost:45944/tests/dromaeo/cssquery-dojo.html) 15:41:47 INFO - PROCESS | 16753 | RSS: Main: 315129856 15:41:47 INFO - PROCESS | 16753 | 15:41:47 INFO - PROCESS | 16753 | __start_tp_report 15:41:47 INFO - PROCESS | 16753 | _x_x_mozilla_page_load 15:41:47 INFO - PROCESS | 16753 | _x_x_mozilla_page_load_details 15:41:47 INFO - PROCESS | 16753 | |i|pagename|runs| 15:41:47 INFO - PROCESS | 16753 | |0;dojo.html;2579.252016915095;2602.2193341997395;2638.538255805234;2640.432307053983;2657.3755167535624;4652.418447694038;4733.455652599952;4776.904461910764;4778.546038126381;4858.222684370501;4707.976460117695;4708.717476951377;4718.4809670936165;4735.573798358147;4771.689840160388;4340.04519005819;4396.648268138557;4401.36180253863;4473.2171869922795;4487.506374298824;4342.652587792969;4392.780360981938;4419.292913133899;4432.867013989586;4512;4382.9342559861625;4440.644748420134;4475.664325175625;4489.371487991683;4492.191405547001;4416.1167766446515;4450.4881938577155;4487.439070116236;4500.549945005473;4504.6396288296855;4247.362895565659;4276.893077673052;4284.571542845691;4380.912381752379;4387;4637.026224492861;4639.698419602749;4653.767311634405;4702.553257440538;4723.669343145981;4931.235658472942;4955.182394904837;4997.575206107449;5027.99440111979;5057.620678449094;4975.651704380694;5048.873778155539;5059.038782631288;5061.240813877911;5118.539331460149;4692.389989301369;4701.905961880743;4741.928871066937;4745.83389581363;4746.644001699818;5146.6911985281;5190.377154741455;5192.299039629677;5200.323957885451;5265.131253343232;4875.390576177978;4990.925136122961;4993.350864387679;4996.100701873697;4996.675216110941;4973.353464049723;4989.850304490871;4994.1759609663995;5021;5095.414027386824;4965.950340496549;4971.40343158816;4973.55238028572;4978.6017118630425;5032.622553308516;4945.480724523945;4954.455009948902;4962.478939711278;4976;5032.748362581856;4120.855770048034;4181.707280490397;4184.644305234089;4230.090530535949;4232.640225580799;3701.6668499835146;3734.9626503735158;3759.9060023499082;3796.335641262768;3827.062369719381;4389.934150987738;4393.780310984438;4394.560543945579;4398.516163222043;4448.354988526646;5077.543021128116;5080.161773307363;5086.262491938648;5092.516210959953;5155.458676838878;4182.895427614273;4289.013526888833;4376.277914144131;4424.424824772824;4436.0462500562535;4622.560856718606;4623.214053610895;4626.236670949323;4638.652101092432;4674.836380726658;4846.733429661332;4854.563089321978;4856.611471082376;4858.73276969763;4918.0901533216465;4936.086823937583;4991.101601711727;4993.975030124826;5019.924701129559;5111.642185047011;4751.382320298478;4782.569568738831;4786.664933454625;4804.783784729765;4846.636502262274;4956.826511072095;4969.900601988013;4970;4972.0801651694555;5014.623903207201;4950.381202349707;4997.0505603935135;5012.47369026247;5051.68290610114;5119.948800511947;4919.926201107058;4937.284093806306;4950.6039516837845;5008.724520151427;5016.874578135576;4928.654994150518;4935.851924442272;4938.703677779345;4940.283658869515;4994.725290109079;4726.26742854858;4742.834000809955;4803.207470767285;4855.101806165871;4877.048975449753;4942.728149951788;4978.1288274552535;4989.326440930428;5018.347614810052;5042.823501177588;4786.736729479912;4793.880152996203;4799.064182484382;4836.540528649773;4851.563359297539 15:41:47 INFO - PROCESS | 16753 | |1;ext.html;546.3662151903792;556.4741319453117;558.6396774080717;566.4052744618152;574.8160588611646;27177;37847.24305513891;39413.80293098531;39426.80286598563;43164.784176079156;39647.20705585887;40069.39895901557;40092.19815603686;40127.39808902869;40169.19661606766;7505.512141710785;7658.119316278616;7663.080430348338;7663.118741344761;7664.808379790522;7568.394528437711;7644.694212231504;7651.961740191291;7653.272939070779;7657;7658.157602663702;7707;7709.383249340068;7712.884306735404;7718.53688778675;7599.316061554459;7629.771106866803;7651.081870175559;7651.808704782369;7677.078750549914;7520.6239688015385;7553.357964573018;7568.735094271674;7626.771196864103;7627.961860190663;36425.08937276563;36724.44913326302;36758.89723308278;36776.080597985;36780.44829327562;2725.6184134221025;2802.341449759305;2843.843588602626;2844.7581955533806;3044.995151599967;27207.591886121725;28242.71757282442;28308.29229269264;28400.573991390145;28428.857855710798;3143.8113713177054;3150.3069324748517;3162.9525557116663;3280.917977050569;3336.249343897628;246775;247439;247470;247707;247926;30200.395992080474;49048.75475622599;49262.753686232056;49365.25952110721;49380.259296110584;30847.537286940715;32678.836605817294;32739.50890736641;32754.181145471553;32776.180595485304;11818.290902545703;11925.403729813475;11936.880631193751;11937.28376297425;11953;9367.344285900057;9386.90613093874;9392.90607093934;9396.295277854188;9407.341486095907;7630.2751238632245;7667.693292268358;7708.152103268636;7728;7731.188225236269;3000.144958686764;3089.2431354318337;3091.211741006029;3095.086949349947;3100.9379812403627;804.4931693033352;817.9877301840477;851.1871163039283;863.5725315968635;898.3980732908967;25720.356991075372;27081.45837083247;27392.86303568509;27422;27732.861335693597;749.8912657664608;893.6693423433371;911.6444586611227;958.2286259560981;971.8435062275869;14805.62985925339;16255.349786008665;16495.257713402927;16570.502884913472;16896.831031689526;370867;388944;396899;397646;654749;48279;49131.263031054565;49155.262671059245;49212.75393623081;49219.26171107365;1005.582683186484;1082.8862969388101;1140.4240858366638;1170.8594968603823;1174.107678164584;25110.874445628386;28999.420011599228;29039.12882613525;30298.69701303047;30500.08499745011;44453.33320000267;45353.319700203865;45381.31928021016;45479.54520454753;45491.772541137085;316649;317260;317577;318558;318998;21450.463738406666;21776.237831675815;22056.779432206113;24634.876825615756;25066.498670026864;40581.59418405778;40694.389584155666;40798;41055.58944410518;41138;34382.82808585941;34758;34796.47805282872;34984.82507587547;34996;34027.14932126617;34211.82894085613;34567;34734.47898281477;35336.64663353334;28217.43565128727;28698.13905582836;34309.313813723085;34799.65200347964;34801.82599086988;30067.248318792204;32521.349573007934;32561;32643.020709378758;33278.334433311684;24731.876340618903;24777.380565486008;25022.249332519325;25182.053322722284;25396 15:41:47 INFO - PROCESS | 16753 | |2;jquery.html;340.2039228205996;358.7865220193984;367.7811702037288;372.76515795049124;384.4387194695744;15245.390184392625;15470.61323466914;16647.83352166478;16767.83232167678;16791.076490793002;15254.237288135604;16328.101954392503;16573.51397290407;16689.91655041723;16725.330986760517;4635.745034023127;5010.273510340999;5044.16771232748;5049.949500505003;5050.318207042057;4946.455889852114;5027.572656324217;5030.1448753711775;5034.043531728978;5034.068697290994;4742.383490146276;4930.753462326869;4959.082569724595;4961.131801934665;4966.2798894160505;4961.925571116418;5003.099442100421;5004.149294619905;5006.3241462402475;5009.949900500985;4380.408644832971;4383.167198232358;4467.285234362519;4472.910541789146;4473.888152796174;18416.263349466004;18736.15687294075;18850.528736781554;19402.902985484983;19498.512537186543;1798.9100544972698;1837.5773572078497;1885.2930151193302;1915.582797627949;1934.7775005874364;12423.44094515749;12428.813567796491;12671.556495522613;13208.471661133543;13371.465141394332;1625.878059145557;1636.885418020739;1647.3081305851572;1696.0841145781262;1704.4204970310154;66457.66771166114;66846.66576667134;67812.660936695;68724.6563767178;70453.29546704519;9154.221891139328;9446.952765236267;9480.762980925394;9650.227981761442;9834.213262938947;13240.139390939557;13246.933765331112;13248.801267980987;13249.536266230636;13273.469061237442;6614.404703576702;6871.312868713088;7026.859462810715;7035.226125126232;7036.437085033185;6326.46225070865;6377.96811015942;6408.67956602168;6587.044878492592;6617.669116544153;5911.201987731687;5922.526197904157;6019.916415045333;6025.6685882276015;6032.3967603239325;1765.3997640802188;1791.3909270847973;1795.6049669072784;1817.7909540403023;1841.686913224755;770.5915864591775;792.3106896999648;829.4567058576642;866.9263112635497;871.9580101778314;16119.274632641325;16120.677586448206;16621.83378166227;16716.582085447717;17133.624975144114;794.3248238996806;810.7162493127477;811.9472234304751;822.6791551294999;829.6805729794073;9042.372372972928;9766.560504777302;9777.755556111011;9811.607535698635;9815.754606134904;376688;379002;381587;394204;403578;80479;83661.58169209115;83932.58033709793;84156;84213.57893210495;880.6345366672887;896.9641214351353;917.2478567574658;920.1212841736126;925.1673493855584;10949.45252737344;14230.730780765522;14879.256037198313;15597.532074037797;16081.437149699705;24786;35136.82431587826;35349;35915.46126808048;36813.44779828358;44514.3322850151;48143.5185648139;48870.26694599513;49001;49059;7286.562806231643;7424.851502970018;7519.8496030077995;7583.355414789805;7693.884591731016;5853.795117170878;8552.828943420973;10391.220658450495;10462.267641265344;10520.894791051991;9325.813483730422;9384.577694003923;9679.999200247945;9692.806143877224;9807.411555306704;9319.720408387759;9337.299702522203;9448.905510945078;9572.377795443273;10412.895871041193;8957.14907083826;9622.615095396106;9831.5084245786;9963.302568820112;10211.336263142872;7024.613646249505;7071.964640176766;7143.107111611049;7180.748673796392;7273.818154546178;8089.716859909875;9031.683891063782;9677.129058384498;9935.304528682922;9970.202383809423 15:41:47 INFO - PROCESS | 16753 | |3;mootools.html;1387.8057072009917;1420.0627585793375;1490.970180596388;1682.7728256685343;1723.026490033132;6852;7069.540479868805;7373.741919032835;7977.960110199456;7982.84034319314;7502.212267711893;7754.728584499544;7759.45683802134;8006.239407256301;8006.439549231542;2196.275229174377;2219.8668079915255;2227.6881236626887;2229;2232.274510784002;1827.936022239222;1861.2182883189025;2071.3785864240745;2120.766715661276;2144.1959265275523;2133.9039743211592;2169.7287839020123;2175.271284119814;2182.2689399051337;2183.5087105401235;2115.3759640905814;2120.363890832744;2131.989340053305;2158.6438237690763;2159.7840215978435;2112.324056301984;2122.26781760294;2133.3173384516963;2133.45596872798;2136.6154092263387;7920.920790792076;7931.087924888597;7995;8016.478928869605;8020.67917283308;4299.484061912559;4428.3578881062385;4429.025614364835;4429.557044295545;4435.29035354345;2808.817426867247;2896.232498387929;2939.897103601385;2949.73452389286;2950.232939435762;941.131853271256;945.5461378538272;955.5461155950937;963.3208587945481;967.0812727908515;10608.681739547827;10612.522436490299;10625.893741062568;10706.143508519377;10750.838737418944;4014.016565941363;4135.60711732385;4213.536510983789;4292.699511034198;4334.761588112621;7812.6093695315;7879.2120787921895;7883.448158628841;7888.960555197187;7891.842163156704;4282.785860706952;4294.849680261176;4297.634701050383;4299.634531064895;4302.849400270976;3952.8616498422416;3993.281209382281;4011.5787842276723;4012.4382586437923;4013.4381186633896;3253.837308134584;3274.9017529474154;3371.983140084333;3380.712639425627;3398.7111095557157;958.5878072428923;966.0291407135784;996.5117092624706;1015.4871789746279;1031.128696251666;591.8549955260903;639.2329204954074;648.1735786871776;656.9638669873203;684.4832151725416;4854.2233242681;4920.040592084581;5151.665141765773;5156.92264616031;5229.764660590283;804.8269622031291;831.1148626712531;841.9747407577782;844.7972486603171;849.4648371526023;3271.5092736089778;3439.724822014233;3469.1847415857255;3713.20166164276;4052.1287923096675;9498.715038548855;9695.175910047585;9714.271429642664;9759;9775.755606109904;9651.758706032406;9717.22262219035;9721.513924303756;9735.464549449849;9757.414555126716;6965.233824279325;7300.744473943492;7492.550446973199;7492.70029198826;7499.21258267885;5297.947020529746;5299.920501192408;5330.8400747976075;5333.973330133324;5595.720213989365;8368.24685778283;8409.789755256168;8566.143385661384;8640.827183456422;8725.520096394504;8637.956810215908;8723.781905452415;8737.344699147463;8754.21212090915;8768.649254029768;6660.63366514827;6785.355391237825;6785.4910881685055;6790.93209067903;6797.762078327235;6863.210730766026;6993.230744617987;7064.576125432491;7162.89255661155;7205.963970180115;5040.974795126001;6274.498040156868;6378.45783108441;6410.871782564416;6462.224533056064;6372.808815735535;6455.870882582228;6530.738770449128;6598.505112116514;6714.261431242657;6026.457618814327;6130.9577371846;6135.631862088289;6135.723892424762;6142.723577438936;4463.642908567242;4491.797869095833;4495.100979803987;4536.88657783558;4563.133004729091;4450.198964186348;4489.573490518395;4518.1415531049;4545;4704.50602686713 15:41:47 INFO - PROCESS | 16753 | |4;prototype.html;300.48316894940695;303.8875616022072;312.5670945740149;313.2075848104297;316.12591185372435;4760;4827.155247831624;4879.951200487994;4952.727599981999;4964.627652926031;4656.4877863434995;4713.9057218855605;4746.335513028179;4758.381410416641;4799.040191961613;3859.1509867829172;3859.826307816155;3864.4928477893645;3878.3600705883564;3916.608339166075;3570.6786389224962;3666.2850744104912;3918.4318273850276;3923.3134201514763;3938.684905207591;3828.885133446001;3843.6348546888003;3857.556381016177;3858.84564617415;3865.526063319464;3852.1332700142525;3862.1889403225355;3862.633049860273;3869.2454971280613;3870.1872606752336;3395.219099607104;3397.8980630581123;3406.2165701888457;3408.403529382348;3446.3107378524146;4480.641548676098;4671.626269898434;4682.1037479820725;4685.250359942393;4716.669833111683;4369.584889435499;4374.912501749979;4389.18800021997;4410.970953361458;4438.733675979452;5066.468020857794;5075.720835354054;5080.288759573663;5098.643094983353;5116.462771408986;3584.8386822593047;3637.94543081854;3638.4542318652416;3703.5555733312176;3748.83130259139;5265.210218467222;5269.394019687708;5298.15229563268;5299.33758280215;5367.543758780508;3652.726045546595;3674.265146970563;3704.388775852008;3705.2959937611768;3713.5729391119826;3732.525652367354;3747;3771.6610603236004;3778.319902417591;3818.7517811342173;4312.827486900489;4313.84901528445;4349.173657005159;4368.771926317538;4383.7588932609015;4963.677360971526;4994.225894986283;5030.547250747377;5034.295198672189;5041.445441001487;1240.1566934484456;1275.655572995286;1285.890699290552;1306.3076569418224;1323.7881938889925;825.4623382808054;835.6253962232215;851.8424091543085;853.9829203416022;877.3507604372718;4048.6963477739287;4057.6406903687007;4082.9177119669184;4125.690573207022;4136.276151673445;4700.55344742249;4700.858974230779;4710.387649605529;4712.88217794551;4716.198246298138;4063.167050754588;4279.251131052053;4557.339185818038;4563.133004729091;4573.6569757268335;2756.4487102579164;2762.1713485954533;2772.542530482488;2773.4468697529446;2789.986050069737;4933.851984440401;4954.430240522386;5004;5009.5741861941415;5031;5091.236314552847;5242.895142097213;5334.946650533445;5347.385050719139;5359.383670877821;4929.605631549396;4945.357103576512;4946.579540739005;4970.975145124324;4978.6763860348965;5059.266406370982;5178.948210517998;5208.713520756395;5219.921701174561;5224.346956630421;5100.617453690914;5134;5135.6903989483935;5150.278960945546;5160.716160611202;4926.507349265188;4927.187014142626;4957.529034741694;4965.47862474435;5045.2936588876855;3748.306563285801;3748.718846086609;3753.6434038766274;3754.4743735877546;3757.736958412994;5066.82266120684;5160.535551800356;5201.895962080662;5220.321358223407;5253.290805741176;5031.84904452867;5069.518395752398;5083.72039537829;5097.260897169964;5141.871453213699;4882.609391248762;5092.770825312796;5093.796248150181;5107.693538387709;5154.329937108152;4723.692959957729;4875.7074575525585;4984.526469985346;4992.650514463952;5005.199168133081;4901.803927842989;5068.695878247317;5074.340335756328;5074.619403544675;5077.822276220315;5008.749562521933;5019.698818070928;5022.3219865317715;5034.974825125851;5041.218611115283 15:41:47 INFO - PROCESS | 16753 | |5;yui.html;579.5971799599279;584.8976429124905;612.6722203621064;653.5196630476598;659.4954859532457;11787.469563869625;13376.732465350688;13384.665383365409;13412.329383530834;13431.7313653727;11829.822552661717;11883.881161188385;13250.403731832066;13266.270355130464;13360.93319533401;710.4777988178697;735.6763024269331;745.679357876113;747.1034758290047;748.3190296829886;745.1877453575602;747.1669088965791;748.1956896336433;748.2442732839844;748.3302444312337;780.5706861226303;780.6135962698472;781.1719577248135;781.6287263549825;782.026377160436;775.7013549783346;775.8681024225895;776.2974508070233;776.3323541754087;776.8756998880181;568.763962955373;568.9288838895138;569.1803802524352;570.0707846210692;570.5264630356794;11489.48297326614;11497.770044599145;11522.251053681568;11529.135314851419;11540.942295288554;10523;10552.736181595521;10833.729156771065;10884.564617415293;11007.944960275227;9445.480498572575;9492.667756628554;9566.952165239129;9591.712248632552;9667.90332096677;3131.1389367923775;3143.748500119985;3164.114048066545;3180.77734558581;3188.649248582654;58968.11547826786;59834;59920.70039649818;61028.69485652588;61328.38671613316;7942.285194332538;7965.8805117923275;7966.880496792553;7981.161977992343;8116.918830811616;15942.681146377008;15993.36026558948;16024.519264422086;16027.919860400623;16048.839511604969;6309.356182030648;6430.164078669743;6431.356864313531;6519.217693876765;6680.933190668031;3592.191756854739;3596.6583174598372;3633.364161271767;3633.800140992271;3679.7608155469807;2670.7729842963568;2796.5944937983877;2799.7620202283033;2800.4819108465;2803.1590522843067;468.2554737966581;474.61793256428905;479.7936887138494;488.5676176583749;494.6487993524566;510.892568156355;575.2579172867038;576.826951914424;576.944192128404;582.9825105246849;7975.52146871178;8059.83880322402;8064.637091330904;8078.292874078672;8223;555.4084899581933;587.6757424386541;591.544510726738;601.1043545117743;613.5980932489226;3627.764195327295;3735.813209339522;3823.502944617182;3876.554196267465;4066.79666016698;99089.50455247678;99579.50210248903;101332;103210.48394757978;103594.48202758937;85907.57046214728;89026;89467.55266223627;89658;91354.54322728344;63302.366976330566;71006;77207;77808.99999999886;77863.61068194623;7267.200607933229;7543.245675432413;7574.280443358092;7815.491993020435;7914.44598878073;37487.62512374841;38087.61912380841;38195.42706859455;42413.363799542414;47361;50175.74912125416;51387.48612513977;51452.742736286076;58293.4170658288;62524.687376562826;11256.887431125584;11671.35807530594;11674.299542027506;11776.057915366922;11786.58746943853;12434.502619895104;12455;13192.670183245496;13318.40067196998;13738.381772820047;11660.941695291469;11818.40907954616;11901.642950711492;12518.499260029497;12544.24734515932;12450.315232662291;12770.361481926053;13504.054716169774;13569.660758480723;13825.51610693621;11660.708482288012;11971.700707482383;12183.390830458264;12412.069094817743;12521.686957826127;10079.798404032024;10240.795184096127;10490.160787137163;10884.673459795902;11035.944820275847;10326.793464130826;10420.426876521864;10616.734581635212;10707.357558546511;10735.624253151102 15:41:47 INFO - PROCESS | 16753 | __end_tp_report 15:41:47 INFO - PROCESS | 16753 | __start_cc_report 15:41:47 INFO - PROCESS | 16753 | _x_x_mozilla_cycle_collect,871 15:41:47 INFO - PROCESS | 16753 | __end_cc_report 15:41:47 INFO - PROCESS | 16753 | __startTimestamp1474065707109__endTimestamp 15:41:47 INFO - PROCESS | 16753 | 15:41:47 INFO - PROCESS | 16753 | ------- Summary: start ------- 15:41:47 INFO - PROCESS | 16753 | Number of tests: 6 15:41:47 INFO - PROCESS | 16753 | 15:41:47 INFO - PROCESS | 16753 | [#0] dojo.html Cycles:165 Average:4679.26 Median:4803.21 stddev:482.69 (10.0%) stddev-sans-first:455.19 15:41:47 INFO - PROCESS | 16753 | Values: 2579.3 2602.2 2638.5 2640.4 2657.4 4652.4 4733.5 4776.9 4778.5 4858.2 4708.0 4708.7 4718.5 4735.6 4771.7 4340.0 4396.6 4401.4 4473.2 4487.5 4342.7 4392.8 4419.3 4432.9 4512.0 4382.9 4440.6 4475.7 4489.4 4492.2 4416.1 4450.5 4487.4 4500.5 4504.6 4247.4 4276.9 4284.6 4380.9 4387.0 4637.0 4639.7 4653.8 4702.6 4723.7 4931.2 4955.2 4997.6 5028.0 5057.6 4975.7 5048.9 5059.0 5061.2 5118.5 4692.4 4701.9 4741.9 4745.8 4746.6 5146.7 5190.4 5192.3 5200.3 5265.1 4875.4 4990.9 4993.4 4996.1 4996.7 4973.4 4989.9 4994.2 5021.0 5095.4 4966.0 4971.4 4973.6 4978.6 5032.6 4945.5 4954.5 4962.5 4976.0 5032.7 4120.9 4181.7 4184.6 4230.1 4232.6 3701.7 3735.0 3759.9 3796.3 3827.1 4389.9 4393.8 4394.6 4398.5 4448.4 5077.5 5080.2 5086.3 5092.5 5155.5 4182.9 4289.0 4376.3 4424.4 4436.0 4622.6 4623.2 4626.2 4638.7 4674.8 4846.7 4854.6 4856.6 4858.7 4918.1 4936.1 4991.1 4994.0 5019.9 5111.6 4751.4 4782.6 4786.7 4804.8 4846.6 4956.8 4969.9 4970.0 4972.1 5014.6 4950.4 4997.1 5012.5 5051.7 5119.9 4919.9 4937.3 4950.6 5008.7 5016.9 4928.7 4935.9 4938.7 4940.3 4994.7 4726.3 4742.8 4803.2 4855.1 4877.0 4942.7 4978.1 4989.3 5018.3 5042.8 4786.7 4793.9 4799.1 4836.5 4851.6 15:41:47 INFO - PROCESS | 16753 | 15:41:47 INFO - PROCESS | 16753 | [#1] ext.html Cycles:180 Average:47105.43 Median:35166.32 stddev:93285.10 (265.3%) stddev-sans-first:93481.29 15:41:47 INFO - PROCESS | 16753 | Values: 546.4 556.5 558.6 566.4 574.8 27177.0 37847.2 39413.8 39426.8 43164.8 39647.2 40069.4 40092.2 40127.4 40169.2 7505.5 7658.1 7663.1 7663.1 7664.8 7568.4 7644.7 7652.0 7653.3 7657.0 7658.2 7707.0 7709.4 7712.9 7718.5 7599.3 7629.8 7651.1 7651.8 7677.1 7520.6 7553.4 7568.7 7626.8 7628.0 36425.1 36724.4 36758.9 36776.1 36780.4 2725.6 2802.3 2843.8 2844.8 3045.0 27207.6 28242.7 28308.3 28400.6 28428.9 3143.8 3150.3 3163.0 3280.9 3336.2 246775.0 247439.0 247470.0 247707.0 247926.0 30200.4 49048.8 49262.8 49365.3 49380.3 30847.5 32678.8 32739.5 32754.2 32776.2 11818.3 11925.4 11936.9 11937.3 11953.0 9367.3 9386.9 9392.9 9396.3 9407.3 7630.3 7667.7 7708.2 7728.0 7731.2 3000.1 3089.2 3091.2 3095.1 3100.9 804.5 818.0 851.2 863.6 898.4 25720.4 27081.5 27392.9 27422.0 27732.9 749.9 893.7 911.6 958.2 971.8 14805.6 16255.3 16495.3 16570.5 16896.8 370867.0 388944.0 396899.0 397646.0 654749.0 48279.0 49131.3 49155.3 49212.8 49219.3 1005.6 1082.9 1140.4 1170.9 1174.1 25110.9 28999.4 29039.1 30298.7 30500.1 44453.3 45353.3 45381.3 45479.5 45491.8 316649.0 317260.0 317577.0 318558.0 318998.0 21450.5 21776.2 22056.8 24634.9 25066.5 40581.6 40694.4 40798.0 41055.6 41138.0 34382.8 34758.0 34796.5 34984.8 34996.0 34027.1 34211.8 34567.0 34734.5 35336.6 28217.4 28698.1 34309.3 34799.7 34801.8 30067.2 32521.3 32561.0 32643.0 33278.3 24731.9 24777.4 25022.2 25182.1 25396.0 15:41:47 INFO - PROCESS | 16753 | 15:41:47 INFO - PROCESS | 16753 | [#2] jquery.html Cycles:180 Average:23929.40 Median:5008.14 stddev:64079.90 (1279.5%) stddev-sans-first:64235.18 15:41:47 INFO - PROCESS | 16753 | Values: 340.2 358.8 367.8 372.8 384.4 15245.4 15470.6 16647.8 16767.8 16791.1 15254.2 16328.1 16573.5 16689.9 16725.3 4635.7 5010.3 5044.2 5049.9 5050.3 4946.5 5027.6 5030.1 5034.0 5034.1 4742.4 4930.8 4959.1 4961.1 4966.3 4961.9 5003.1 5004.1 5006.3 5009.9 4380.4 4383.2 4467.3 4472.9 4473.9 18416.3 18736.2 18850.5 19402.9 19498.5 1798.9 1837.6 1885.3 1915.6 1934.8 12423.4 12428.8 12671.6 13208.5 13371.5 1625.9 1636.9 1647.3 1696.1 1704.4 66457.7 66846.7 67812.7 68724.7 70453.3 9154.2 9447.0 9480.8 9650.2 9834.2 13240.1 13246.9 13248.8 13249.5 13273.5 6614.4 6871.3 7026.9 7035.2 7036.4 6326.5 6378.0 6408.7 6587.0 6617.7 5911.2 5922.5 6019.9 6025.7 6032.4 1765.4 1791.4 1795.6 1817.8 1841.7 770.6 792.3 829.5 866.9 872.0 16119.3 16120.7 16621.8 16716.6 17133.6 794.3 810.7 811.9 822.7 829.7 9042.4 9766.6 9777.8 9811.6 9815.8 376688.0 379002.0 381587.0 394204.0 403578.0 80479.0 83661.6 83932.6 84156.0 84213.6 880.6 897.0 917.2 920.1 925.2 10949.5 14230.7 14879.3 15597.5 16081.4 24786.0 35136.8 35349.0 35915.5 36813.4 44514.3 48143.5 48870.3 49001.0 49059.0 7286.6 7424.9 7519.8 7583.4 7693.9 5853.8 8552.8 10391.2 10462.3 10520.9 9325.8 9384.6 9680.0 9692.8 9807.4 9319.7 9337.3 9448.9 9572.4 10412.9 8957.1 9622.6 9831.5 9963.3 10211.3 7024.6 7072.0 7143.1 7180.7 7273.8 8089.7 9031.7 9677.1 9935.3 9970.2 15:41:47 INFO - PROCESS | 16753 | 15:41:47 INFO - PROCESS | 16753 | [#3] mootools.html Cycles:180 Average:5005.95 Median:5332.41 stddev:2827.95 (53.0%) stddev-sans-first:2822.81 15:41:47 INFO - PROCESS | 16753 | Values: 1387.8 1420.1 1491.0 1682.8 1723.0 6852.0 7069.5 7373.7 7978.0 7982.8 7502.2 7754.7 7759.5 8006.2 8006.4 2196.3 2219.9 2227.7 2229.0 2232.3 1827.9 1861.2 2071.4 2120.8 2144.2 2133.9 2169.7 2175.3 2182.3 2183.5 2115.4 2120.4 2132.0 2158.6 2159.8 2112.3 2122.3 2133.3 2133.5 2136.6 7920.9 7931.1 7995.0 8016.5 8020.7 4299.5 4428.4 4429.0 4429.6 4435.3 2808.8 2896.2 2939.9 2949.7 2950.2 941.1 945.5 955.5 963.3 967.1 10608.7 10612.5 10625.9 10706.1 10750.8 4014.0 4135.6 4213.5 4292.7 4334.8 7812.6 7879.2 7883.4 7889.0 7891.8 4282.8 4294.8 4297.6 4299.6 4302.8 3952.9 3993.3 4011.6 4012.4 4013.4 3253.8 3274.9 3372.0 3380.7 3398.7 958.6 966.0 996.5 1015.5 1031.1 591.9 639.2 648.2 657.0 684.5 4854.2 4920.0 5151.7 5156.9 5229.8 804.8 831.1 842.0 844.8 849.5 3271.5 3439.7 3469.2 3713.2 4052.1 9498.7 9695.2 9714.3 9759.0 9775.8 9651.8 9717.2 9721.5 9735.5 9757.4 6965.2 7300.7 7492.6 7492.7 7499.2 5297.9 5299.9 5330.8 5334.0 5595.7 8368.2 8409.8 8566.1 8640.8 8725.5 8638.0 8723.8 8737.3 8754.2 8768.6 6660.6 6785.4 6785.5 6790.9 6797.8 6863.2 6993.2 7064.6 7162.9 7206.0 5041.0 6274.5 6378.5 6410.9 6462.2 6372.8 6455.9 6530.7 6598.5 6714.3 6026.5 6131.0 6135.6 6135.7 6142.7 4463.6 4491.8 4495.1 4536.9 4563.1 4450.2 4489.6 4518.1 4545.0 4704.5 15:41:47 INFO - PROCESS | 16753 | 15:41:47 INFO - PROCESS | 16753 | [#4] prototype.html Cycles:180 Average:4203.04 Median:4716.43 stddev:1207.83 (25.6%) stddev-sans-first:1175.16 15:41:47 INFO - PROCESS | 16753 | Values: 300.5 303.9 312.6 313.2 316.1 4760.0 4827.2 4880.0 4952.7 4964.6 4656.5 4713.9 4746.3 4758.4 4799.0 3859.2 3859.8 3864.5 3878.4 3916.6 3570.7 3666.3 3918.4 3923.3 3938.7 3828.9 3843.6 3857.6 3858.8 3865.5 3852.1 3862.2 3862.6 3869.2 3870.2 3395.2 3397.9 3406.2 3408.4 3446.3 4480.6 4671.6 4682.1 4685.3 4716.7 4369.6 4374.9 4389.2 4411.0 4438.7 5066.5 5075.7 5080.3 5098.6 5116.5 3584.8 3637.9 3638.5 3703.6 3748.8 5265.2 5269.4 5298.2 5299.3 5367.5 3652.7 3674.3 3704.4 3705.3 3713.6 3732.5 3747.0 3771.7 3778.3 3818.8 4312.8 4313.8 4349.2 4368.8 4383.8 4963.7 4994.2 5030.5 5034.3 5041.4 1240.2 1275.7 1285.9 1306.3 1323.8 825.5 835.6 851.8 854.0 877.4 4048.7 4057.6 4082.9 4125.7 4136.3 4700.6 4700.9 4710.4 4712.9 4716.2 4063.2 4279.3 4557.3 4563.1 4573.7 2756.4 2762.2 2772.5 2773.4 2790.0 4933.9 4954.4 5004.0 5009.6 5031.0 5091.2 5242.9 5334.9 5347.4 5359.4 4929.6 4945.4 4946.6 4971.0 4978.7 5059.3 5178.9 5208.7 5219.9 5224.3 5100.6 5134.0 5135.7 5150.3 5160.7 4926.5 4927.2 4957.5 4965.5 5045.3 3748.3 3748.7 3753.6 3754.5 3757.7 5066.8 5160.5 5201.9 5220.3 5253.3 5031.8 5069.5 5083.7 5097.3 5141.9 4882.6 5092.8 5093.8 5107.7 5154.3 4723.7 4875.7 4984.5 4992.7 5005.2 4901.8 5068.7 5074.3 5074.6 5077.8 5008.7 5019.7 5022.3 5035.0 5041.2 15:41:47 INFO - PROCESS | 16753 | 15:41:47 INFO - PROCESS | 16753 | [#5] yui.html Cycles:180 Average:17385.13 Median:484.18 stddev:25504.67 (5267.6%) stddev-sans-first:25545.00 15:41:47 INFO - PROCESS | 16753 | Values: 579.6 584.9 612.7 653.5 659.5 11787.5 13376.7 13384.7 13412.3 13431.7 11829.8 11883.9 13250.4 13266.3 13360.9 710.5 735.7 745.7 747.1 748.3 745.2 747.2 748.2 748.2 748.3 780.6 780.6 781.2 781.6 782.0 775.7 775.9 776.3 776.3 776.9 568.8 568.9 569.2 570.1 570.5 11489.5 11497.8 11522.3 11529.1 11540.9 10523.0 10552.7 10833.7 10884.6 11007.9 9445.5 9492.7 9567.0 9591.7 9667.9 3131.1 3143.7 3164.1 3180.8 3188.6 58968.1 59834.0 59920.7 61028.7 61328.4 7942.3 7965.9 7966.9 7981.2 8116.9 15942.7 15993.4 16024.5 16027.9 16048.8 6309.4 6430.2 6431.4 6519.2 6680.9 3592.2 3596.7 3633.4 3633.8 3679.8 2670.8 2796.6 2799.8 2800.5 2803.2 468.3 474.6 479.8 488.6 494.6 510.9 575.3 576.8 576.9 583.0 7975.5 8059.8 8064.6 8078.3 8223.0 555.4 587.7 591.5 601.1 613.6 3627.8 3735.8 3823.5 3876.6 4066.8 99089.5 99579.5 101332.0 103210.5 103594.5 85907.6 89026.0 89467.6 89658.0 91354.5 63302.4 71006.0 77207.0 77809.0 77863.6 7267.2 7543.2 7574.3 7815.5 7914.4 37487.6 38087.6 38195.4 42413.4 47361.0 50175.7 51387.5 51452.7 58293.4 62524.7 11256.9 11671.4 11674.3 11776.1 11786.6 12434.5 12455.0 13192.7 13318.4 13738.4 11660.9 11818.4 11901.6 12518.5 12544.2 12450.3 12770.4 13504.1 13569.7 13825.5 11660.7 11971.7 12183.4 12412.1 12521.7 10079.8 10240.8 10490.2 10884.7 11035.9 10326.8 10420.4 10616.7 10707.4 10735.6 15:41:47 INFO - PROCESS | 16753 | -------- Summary: end -------- 15:41:47 INFO - PROCESS | 16753 | 15:41:48 INFO - TEST-INFO | 16753: exit 0 15:41:48 INFO - TEST-OK | dromaeo_css | took 1121738ms 15:41:48 INFO - TEST-START | kraken 15:41:48 INFO - operating with platform_type : linux_ 15:41:48 INFO - Initialising browser for kraken test... 15:41:48 INFO - TEST-INFO | started process 17061 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYDR387/profile http://localhost:45944/getInfo.html) 15:41:52 INFO - PROCESS | 17061 | __metrics Screen width/height:1600/1200 15:41:52 INFO - PROCESS | 17061 | colorDepth:24 15:41:52 INFO - PROCESS | 17061 | Browser inner width/height: 1024/697 15:41:52 INFO - PROCESS | 17061 | __metrics 15:41:53 INFO - PROCESS | 17061 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:41:53 INFO - PROCESS | 17061 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:41:53 INFO - PROCESS | 17061 | console.error: PushService: 15:41:53 INFO - PROCESS | 17061 | stateChangeProcessEnqueue: Error transitioning state 15:41:53 INFO - PROCESS | 17061 | UnknownError 15:41:54 INFO - TEST-INFO | 17061: exit 0 15:41:54 INFO - Browser initialized. 15:41:54 INFO - Running cycle 1/1 for kraken test... 15:41:54 INFO - TEST-INFO | started process 17143 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYDR387/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:42:06 INFO - PROCESS | 17143 | RSS: Main: 174145536 15:42:06 INFO - PROCESS | 17143 | 15:42:09 INFO - PROCESS | 17143 | Cycle 1(1): loaded http://localhost:45944/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45944/tests/kraken/driver.html?testName=audio-beat-detection) 15:42:10 INFO - PROCESS | 17143 | RSS: Main: 233111552 15:42:10 INFO - PROCESS | 17143 | 15:42:13 INFO - PROCESS | 17143 | Cycle 1(1): loaded http://localhost:45944/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45944/tests/kraken/driver.html?testName=audio-dft) 15:42:13 INFO - PROCESS | 17143 | RSS: Main: 218177536 15:42:13 INFO - PROCESS | 17143 | 15:42:17 INFO - PROCESS | 17143 | Cycle 1(1): loaded http://localhost:45944/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45944/tests/kraken/driver.html?testName=audio-fft) 15:42:17 INFO - PROCESS | 17143 | RSS: Main: 299548672 15:42:17 INFO - PROCESS | 17143 | 15:42:19 INFO - PROCESS | 17143 | Cycle 1(1): loaded http://localhost:45944/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45944/tests/kraken/driver.html?testName=audio-oscillator) 15:42:20 INFO - PROCESS | 17143 | RSS: Main: 208986112 15:42:20 INFO - PROCESS | 17143 | 15:42:22 INFO - PROCESS | 17143 | Cycle 1(1): loaded http://localhost:45944/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45944/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:42:23 INFO - PROCESS | 17143 | RSS: Main: 213712896 15:42:23 INFO - PROCESS | 17143 | 15:42:26 INFO - PROCESS | 17143 | Cycle 1(1): loaded http://localhost:45944/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45944/tests/kraken/driver.html?testName=imaging-darkroom) 15:42:27 INFO - PROCESS | 17143 | RSS: Main: 249397248 15:42:27 INFO - PROCESS | 17143 | 15:42:30 INFO - PROCESS | 17143 | Cycle 1(1): loaded http://localhost:45944/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45944/tests/kraken/driver.html?testName=imaging-desaturate) 15:42:31 INFO - PROCESS | 17143 | RSS: Main: 243462144 15:42:31 INFO - PROCESS | 17143 | 15:42:34 INFO - PROCESS | 17143 | Cycle 1(1): loaded http://localhost:45944/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45944/tests/kraken/driver.html?testName=json-parse-financial) 15:42:34 INFO - PROCESS | 17143 | RSS: Main: 246571008 15:42:34 INFO - PROCESS | 17143 | 15:42:36 INFO - PROCESS | 17143 | Cycle 1(1): loaded http://localhost:45944/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45944/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:42:37 INFO - PROCESS | 17143 | RSS: Main: 210403328 15:42:37 INFO - PROCESS | 17143 | 15:42:39 INFO - PROCESS | 17143 | Cycle 1(1): loaded http://localhost:45944/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45944/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:42:39 INFO - PROCESS | 17143 | RSS: Main: 216625152 15:42:39 INFO - PROCESS | 17143 | 15:42:41 INFO - PROCESS | 17143 | Cycle 1(1): loaded http://localhost:45944/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45944/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:42:42 INFO - PROCESS | 17143 | RSS: Main: 221147136 15:42:42 INFO - PROCESS | 17143 | 15:42:45 INFO - PROCESS | 17143 | Cycle 1(1): loaded http://localhost:45944/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45944/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:42:46 INFO - PROCESS | 17143 | RSS: Main: 222953472 15:42:46 INFO - PROCESS | 17143 | 15:42:49 INFO - PROCESS | 17143 | Cycle 1(1): loaded http://localhost:45944/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45944/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:42:49 INFO - PROCESS | 17143 | RSS: Main: 221138944 15:42:49 INFO - PROCESS | 17143 | 15:42:51 INFO - PROCESS | 17143 | Cycle 1(1): loaded http://localhost:45944/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45944/tests/kraken/driver.html?testName=ai-astar) 15:42:51 INFO - PROCESS | 17143 | RSS: Main: 271761408 15:42:51 INFO - PROCESS | 17143 | 15:42:51 INFO - PROCESS | 17143 | __start_tp_report 15:42:51 INFO - PROCESS | 17143 | _x_x_mozilla_page_load 15:42:51 INFO - PROCESS | 17143 | _x_x_mozilla_page_load_details 15:42:51 INFO - PROCESS | 17143 | |i|pagename|runs| 15:42:51 INFO - PROCESS | 17143 | |0;ai-astar;112;115;114;115;113;115;115;114;115;115 15:42:51 INFO - PROCESS | 17143 | |1;audio-beat-detection;157;123;123;177;127;130;124;126;154;127 15:42:51 INFO - PROCESS | 17143 | |2;audio-dft;162;162;164;163;162;162;162;162;162;161 15:42:51 INFO - PROCESS | 17143 | |3;audio-fft;78;76;77;110;77;79;76;77;105;77 15:42:51 INFO - PROCESS | 17143 | |4;audio-oscillator;84;83;118;83;84;83;103;83;83;121 15:42:51 INFO - PROCESS | 17143 | |5;imaging-gaussian-blur;117;118;117;117;118;116;117;117;116;117 15:42:51 INFO - PROCESS | 17143 | |6;imaging-darkroom;146;146;145;147;146;146;145;147;149;146 15:42:51 INFO - PROCESS | 17143 | |7;imaging-desaturate;96;96;96;95;96;97;95;96;96;95 15:42:51 INFO - PROCESS | 17143 | |8;json-parse-financial;65;63;65;64;64;66;66;64;65;66 15:42:51 INFO - PROCESS | 17143 | |9;json-stringify-tinderbox;65;74;65;67;65;66;66;65;66;66 15:42:51 INFO - PROCESS | 17143 | |10;stanford-crypto-aes;83;83;83;86;83;89;82;90;82;96 15:42:51 INFO - PROCESS | 17143 | |11;stanford-crypto-ccm;143;151;135;134;140;134;146;143;172;136 15:42:51 INFO - PROCESS | 17143 | |12;stanford-crypto-pbkdf2;173;174;183;174;177;174;175;171;172;170 15:42:51 INFO - PROCESS | 17143 | |13;stanford-crypto-sha256-iterative;70;70;68;71;71;70;72;68;70;69 15:42:51 INFO - PROCESS | 17143 | __end_tp_report 15:42:51 INFO - PROCESS | 17143 | __start_cc_report 15:42:51 INFO - PROCESS | 17143 | _x_x_mozilla_cycle_collect,1950 15:42:51 INFO - PROCESS | 17143 | __end_cc_report 15:42:51 INFO - PROCESS | 17143 | __startTimestamp1474065771652__endTimestamp 15:42:51 INFO - PROCESS | 17143 | 15:42:51 INFO - PROCESS | 17143 | ------- Summary: start ------- 15:42:51 INFO - PROCESS | 17143 | Number of tests: 14 15:42:51 INFO - PROCESS | 17143 | 15:42:51 INFO - PROCESS | 17143 | [#0] ai-astar Cycles:10 Average:114.30 Median:115.00 stddev:1.06 (0.9%) stddev-sans-first:0.73 15:42:51 INFO - PROCESS | 17143 | Values: 112.0 115.0 114.0 115.0 113.0 115.0 115.0 114.0 115.0 115.0 15:42:51 INFO - PROCESS | 17143 | 15:42:51 INFO - PROCESS | 17143 | [#1] audio-beat-detection Cycles:10 Average:136.80 Median:128.50 stddev:18.91 (14.7%) stddev-sans-first:18.60 15:42:51 INFO - PROCESS | 17143 | Values: 157.0 123.0 123.0 177.0 127.0 130.0 124.0 126.0 154.0 127.0 15:42:51 INFO - PROCESS | 17143 | 15:42:51 INFO - PROCESS | 17143 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 15:42:51 INFO - PROCESS | 17143 | Values: 162.0 162.0 164.0 163.0 162.0 162.0 162.0 162.0 162.0 161.0 15:42:51 INFO - PROCESS | 17143 | 15:42:51 INFO - PROCESS | 17143 | [#3] audio-fft Cycles:10 Average:83.20 Median:77.00 stddev:12.89 (16.7%) stddev-sans-first:13.53 15:42:51 INFO - PROCESS | 17143 | Values: 78.0 76.0 77.0 110.0 77.0 79.0 76.0 77.0 105.0 77.0 15:42:51 INFO - PROCESS | 17143 | 15:42:51 INFO - PROCESS | 17143 | [#4] audio-oscillator Cycles:10 Average:92.50 Median:83.00 stddev:15.52 (18.7%) stddev-sans-first:16.16 15:42:51 INFO - PROCESS | 17143 | Values: 84.0 83.0 118.0 83.0 84.0 83.0 103.0 83.0 83.0 121.0 15:42:51 INFO - PROCESS | 17143 | 15:42:51 INFO - PROCESS | 17143 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 15:42:51 INFO - PROCESS | 17143 | Values: 117.0 118.0 117.0 117.0 118.0 116.0 117.0 117.0 116.0 117.0 15:42:51 INFO - PROCESS | 17143 | 15:42:51 INFO - PROCESS | 17143 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:1.16 (0.8%) stddev-sans-first:1.22 15:42:51 INFO - PROCESS | 17143 | Values: 146.0 146.0 145.0 147.0 146.0 146.0 145.0 147.0 149.0 146.0 15:42:51 INFO - PROCESS | 17143 | 15:42:51 INFO - PROCESS | 17143 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 15:42:51 INFO - PROCESS | 17143 | Values: 96.0 96.0 96.0 95.0 96.0 97.0 95.0 96.0 96.0 95.0 15:42:51 INFO - PROCESS | 17143 | 15:42:51 INFO - PROCESS | 17143 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:65.00 stddev:1.03 (1.6%) stddev-sans-first:1.09 15:42:51 INFO - PROCESS | 17143 | Values: 65.0 63.0 65.0 64.0 64.0 66.0 66.0 64.0 65.0 66.0 15:42:51 INFO - PROCESS | 17143 | 15:42:51 INFO - PROCESS | 17143 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:66.00 stddev:2.72 (4.1%) stddev-sans-first:2.83 15:42:51 INFO - PROCESS | 17143 | Values: 65.0 74.0 65.0 67.0 65.0 66.0 66.0 65.0 66.0 66.0 15:42:51 INFO - PROCESS | 17143 | 15:42:51 INFO - PROCESS | 17143 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:84.50 stddev:4.62 (5.5%) stddev-sans-first:4.80 15:42:51 INFO - PROCESS | 17143 | Values: 83.0 83.0 83.0 86.0 83.0 89.0 82.0 90.0 82.0 96.0 15:42:51 INFO - PROCESS | 17143 | 15:42:51 INFO - PROCESS | 17143 | [#11] stanford-crypto-ccm Cycles:10 Average:143.40 Median:143.00 stddev:11.53 (8.1%) stddev-sans-first:12.23 15:42:51 INFO - PROCESS | 17143 | Values: 143.0 151.0 135.0 134.0 140.0 134.0 146.0 143.0 172.0 136.0 15:42:51 INFO - PROCESS | 17143 | 15:42:51 INFO - PROCESS | 17143 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.30 Median:174.00 stddev:3.65 (2.1%) stddev-sans-first:3.84 15:42:51 INFO - PROCESS | 17143 | Values: 173.0 174.0 183.0 174.0 177.0 174.0 175.0 171.0 172.0 170.0 15:42:51 INFO - PROCESS | 17143 | 15:42:51 INFO - PROCESS | 17143 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:1.29 (1.8%) stddev-sans-first:1.36 15:42:51 INFO - PROCESS | 17143 | Values: 70.0 70.0 68.0 71.0 71.0 70.0 72.0 68.0 70.0 69.0 15:42:51 INFO - PROCESS | 17143 | -------- Summary: end -------- 15:42:51 INFO - PROCESS | 17143 | 15:42:52 INFO - TEST-INFO | 17143: exit 0 15:42:52 INFO - TEST-OK | kraken | took 64955ms 15:42:52 INFO - SUITE-END | took 1186s 15:42:53 INFO - Completed test suite (00:19:47) 15:42:53 INFO - javascript benchmark 15:42:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2579.252016915095, 2602.2193341997395, 2638.538255805234, 2640.432307053983, 2657.3755167535624, 4652.418447694038, 4733.455652599952, 4776.904461910764, 4778.546038126381, 4858.222684370501, 4707.976460117695, 4708.717476951377, 4718.4809670936165, 4735.573798358147, 4771.689840160388, 4340.04519005819, 4396.648268138557, 4401.36180253863, 4473.2171869922795, 4487.506374298824, 4342.652587792969, 4392.780360981938, 4419.292913133899, 4432.867013989586, 4512.0, 4382.9342559861625, 4440.644748420134, 4475.664325175625, 4489.371487991683, 4492.191405547001, 4416.1167766446515, 4450.4881938577155, 4487.439070116236, 4500.549945005473, 4504.6396288296855, 4247.362895565659, 4276.893077673052, 4284.571542845691, 4380.912381752379, 4387.0, 4637.026224492861, 4639.698419602749, 4653.767311634405, 4702.553257440538, 4723.669343145981, 4931.235658472942, 4955.182394904837, 4997.575206107449, 5027.99440111979, 5057.620678449094, 4975.651704380694, 5048.873778155539, 5059.038782631288, 5061.240813877911, 5118.539331460149, 4692.389989301369, 4701.905961880743, 4741.928871066937, 4745.83389581363, 4746.644001699818, 5146.6911985281, 5190.377154741455, 5192.299039629677, 5200.323957885451, 5265.131253343232, 4875.390576177978, 4990.925136122961, 4993.350864387679, 4996.100701873697, 4996.675216110941, 4973.353464049723, 4989.850304490871, 4994.1759609663995, 5021.0, 5095.414027386824, 4965.950340496549, 4971.40343158816, 4973.55238028572, 4978.6017118630425, 5032.622553308516, 4945.480724523945, 4954.455009948902, 4962.478939711278, 4976.0, 5032.748362581856, 4120.855770048034, 4181.707280490397, 4184.644305234089, 4230.090530535949, 4232.640225580799, 3701.6668499835146, 3734.9626503735158, 3759.9060023499082, 3796.335641262768, 3827.062369719381, 4389.934150987738, 4393.780310984438, 4394.560543945579, 4398.516163222043, 4448.354988526646, 5077.543021128116, 5080.161773307363, 5086.262491938648, 5092.516210959953, 5155.458676838878, 4182.895427614273, 4289.013526888833, 4376.277914144131, 4424.424824772824, 4436.0462500562535, 4622.560856718606, 4623.214053610895, 4626.236670949323, 4638.652101092432, 4674.836380726658, 4846.733429661332, 4854.563089321978, 4856.611471082376, 4858.73276969763, 4918.0901533216465, 4936.086823937583, 4991.101601711727, 4993.975030124826, 5019.924701129559, 5111.642185047011, 4751.382320298478, 4782.569568738831, 4786.664933454625, 4804.783784729765, 4846.636502262274, 4956.826511072095, 4969.900601988013, 4970.0, 4972.0801651694555, 5014.623903207201, 4950.381202349707, 4997.0505603935135, 5012.47369026247, 5051.68290610114, 5119.948800511947, 4919.926201107058, 4937.284093806306, 4950.6039516837845, 5008.724520151427, 5016.874578135576, 4928.654994150518, 4935.851924442272, 4938.703677779345, 4940.283658869515, 4994.725290109079, 4726.26742854858, 4742.834000809955, 4803.207470767285, 4855.101806165871, 4877.048975449753, 4942.728149951788, 4978.1288274552535, 4989.326440930428, 5018.347614810052, 5042.823501177588, 4786.736729479912, 4793.880152996203, 4799.064182484382, 4836.540528649773, 4851.563359297539], "value": 4648.472708462124, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.3662151903792, 556.4741319453117, 558.6396774080717, 566.4052744618152, 574.8160588611646, 27177.0, 37847.24305513891, 39413.80293098531, 39426.80286598563, 43164.784176079156, 39647.20705585887, 40069.39895901557, 40092.19815603686, 40127.39808902869, 40169.19661606766, 7505.512141710785, 7658.119316278616, 7663.080430348338, 7663.118741344761, 7664.808379790522, 7568.394528437711, 7644.694212231504, 7651.961740191291, 7653.272939070779, 7657.0, 7658.157602663702, 7707.0, 7709.383249340068, 7712.884306735404, 7718.53688778675, 7599.316061554459, 7629.771106866803, 7651.081870175559, 7651.808704782369, 7677.078750549914, 7520.6239688015385, 7553.357964573018, 7568.735094271674, 7626.771196864103, 7627.961860190663, 36425.08937276563, 36724.44913326302, 36758.89723308278, 36776.080597985, 36780.44829327562, 2725.6184134221025, 2802.341449759305, 2843.843588602626, 2844.7581955533806, 3044.995151599967, 27207.591886121725, 28242.71757282442, 28308.29229269264, 28400.573991390145, 28428.857855710798, 3143.8113713177054, 3150.3069324748517, 3162.9525557116663, 3280.917977050569, 3336.249343897628, 246775.0, 247439.0, 247470.0, 247707.0, 247926.0, 30200.395992080474, 49048.75475622599, 49262.753686232056, 49365.25952110721, 49380.259296110584, 30847.537286940715, 32678.836605817294, 32739.50890736641, 32754.181145471553, 32776.180595485304, 11818.290902545703, 11925.403729813475, 11936.880631193751, 11937.28376297425, 11953.0, 9367.344285900057, 9386.90613093874, 9392.90607093934, 9396.295277854188, 9407.341486095907, 7630.2751238632245, 7667.693292268358, 7708.152103268636, 7728.0, 7731.188225236269, 3000.144958686764, 3089.2431354318337, 3091.211741006029, 3095.086949349947, 3100.9379812403627, 804.4931693033352, 817.9877301840477, 851.1871163039283, 863.5725315968635, 898.3980732908967, 25720.356991075372, 27081.45837083247, 27392.86303568509, 27422.0, 27732.861335693597, 749.8912657664608, 893.6693423433371, 911.6444586611227, 958.2286259560981, 971.8435062275869, 14805.62985925339, 16255.349786008665, 16495.257713402927, 16570.502884913472, 16896.831031689526, 370867.0, 388944.0, 396899.0, 397646.0, 654749.0, 48279.0, 49131.263031054565, 49155.262671059245, 49212.75393623081, 49219.26171107365, 1005.582683186484, 1082.8862969388101, 1140.4240858366638, 1170.8594968603823, 1174.107678164584, 25110.874445628386, 28999.420011599228, 29039.12882613525, 30298.69701303047, 30500.08499745011, 44453.33320000267, 45353.319700203865, 45381.31928021016, 45479.54520454753, 45491.772541137085, 316649.0, 317260.0, 317577.0, 318558.0, 318998.0, 21450.463738406666, 21776.237831675815, 22056.779432206113, 24634.876825615756, 25066.498670026864, 40581.59418405778, 40694.389584155666, 40798.0, 41055.58944410518, 41138.0, 34382.82808585941, 34758.0, 34796.47805282872, 34984.82507587547, 34996.0, 34027.14932126617, 34211.82894085613, 34567.0, 34734.47898281477, 35336.64663353334, 28217.43565128727, 28698.13905582836, 34309.313813723085, 34799.65200347964, 34801.82599086988, 30067.248318792204, 32521.349573007934, 32561.0, 32643.020709378758, 33278.334433311684, 24731.876340618903, 24777.380565486008, 25022.249332519325, 25182.053322722284, 25396.0], "value": 15940.19488663191, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.2039228205996, 358.7865220193984, 367.7811702037288, 372.76515795049124, 384.4387194695744, 15245.390184392625, 15470.61323466914, 16647.83352166478, 16767.83232167678, 16791.076490793002, 15254.237288135604, 16328.101954392503, 16573.51397290407, 16689.91655041723, 16725.330986760517, 4635.745034023127, 5010.273510340999, 5044.16771232748, 5049.949500505003, 5050.318207042057, 4946.455889852114, 5027.572656324217, 5030.1448753711775, 5034.043531728978, 5034.068697290994, 4742.383490146276, 4930.753462326869, 4959.082569724595, 4961.131801934665, 4966.2798894160505, 4961.925571116418, 5003.099442100421, 5004.149294619905, 5006.3241462402475, 5009.949900500985, 4380.408644832971, 4383.167198232358, 4467.285234362519, 4472.910541789146, 4473.888152796174, 18416.263349466004, 18736.15687294075, 18850.528736781554, 19402.902985484983, 19498.512537186543, 1798.9100544972698, 1837.5773572078497, 1885.2930151193302, 1915.582797627949, 1934.7775005874364, 12423.44094515749, 12428.813567796491, 12671.556495522613, 13208.471661133543, 13371.465141394332, 1625.878059145557, 1636.885418020739, 1647.3081305851572, 1696.0841145781262, 1704.4204970310154, 66457.66771166114, 66846.66576667134, 67812.660936695, 68724.6563767178, 70453.29546704519, 9154.221891139328, 9446.952765236267, 9480.762980925394, 9650.227981761442, 9834.213262938947, 13240.139390939557, 13246.933765331112, 13248.801267980987, 13249.536266230636, 13273.469061237442, 6614.404703576702, 6871.312868713088, 7026.859462810715, 7035.226125126232, 7036.437085033185, 6326.46225070865, 6377.96811015942, 6408.67956602168, 6587.044878492592, 6617.669116544153, 5911.201987731687, 5922.526197904157, 6019.916415045333, 6025.6685882276015, 6032.3967603239325, 1765.3997640802188, 1791.3909270847973, 1795.6049669072784, 1817.7909540403023, 1841.686913224755, 770.5915864591775, 792.3106896999648, 829.4567058576642, 866.9263112635497, 871.9580101778314, 16119.274632641325, 16120.677586448206, 16621.83378166227, 16716.582085447717, 17133.624975144114, 794.3248238996806, 810.7162493127477, 811.9472234304751, 822.6791551294999, 829.6805729794073, 9042.372372972928, 9766.560504777302, 9777.755556111011, 9811.607535698635, 9815.754606134904, 376688.0, 379002.0, 381587.0, 394204.0, 403578.0, 80479.0, 83661.58169209115, 83932.58033709793, 84156.0, 84213.57893210495, 880.6345366672887, 896.9641214351353, 917.2478567574658, 920.1212841736126, 925.1673493855584, 10949.45252737344, 14230.730780765522, 14879.256037198313, 15597.532074037797, 16081.437149699705, 24786.0, 35136.82431587826, 35349.0, 35915.46126808048, 36813.44779828358, 44514.3322850151, 48143.5185648139, 48870.26694599513, 49001.0, 49059.0, 7286.562806231643, 7424.851502970018, 7519.8496030077995, 7583.355414789805, 7693.884591731016, 5853.795117170878, 8552.828943420973, 10391.220658450495, 10462.267641265344, 10520.894791051991, 9325.813483730422, 9384.577694003923, 9679.999200247945, 9692.806143877224, 9807.411555306704, 9319.720408387759, 9337.299702522203, 9448.905510945078, 9572.377795443273, 10412.895871041193, 8957.14907083826, 9622.615095396106, 9831.5084245786, 9963.302568820112, 10211.336263142872, 7024.613646249505, 7071.964640176766, 7143.107111611049, 7180.748673796392, 7273.818154546178, 8089.716859909875, 9031.683891063782, 9677.129058384498, 9935.304528682922, 9970.202383809423], "value": 7937.505493267319, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1387.8057072009917, 1420.0627585793375, 1490.970180596388, 1682.7728256685343, 1723.026490033132, 6852.0, 7069.540479868805, 7373.741919032835, 7977.960110199456, 7982.84034319314, 7502.212267711893, 7754.728584499544, 7759.45683802134, 8006.239407256301, 8006.439549231542, 2196.275229174377, 2219.8668079915255, 2227.6881236626887, 2229.0, 2232.274510784002, 1827.936022239222, 1861.2182883189025, 2071.3785864240745, 2120.766715661276, 2144.1959265275523, 2133.9039743211592, 2169.7287839020123, 2175.271284119814, 2182.2689399051337, 2183.5087105401235, 2115.3759640905814, 2120.363890832744, 2131.989340053305, 2158.6438237690763, 2159.7840215978435, 2112.324056301984, 2122.26781760294, 2133.3173384516963, 2133.45596872798, 2136.6154092263387, 7920.920790792076, 7931.087924888597, 7995.0, 8016.478928869605, 8020.67917283308, 4299.484061912559, 4428.3578881062385, 4429.025614364835, 4429.557044295545, 4435.29035354345, 2808.817426867247, 2896.232498387929, 2939.897103601385, 2949.73452389286, 2950.232939435762, 941.131853271256, 945.5461378538272, 955.5461155950937, 963.3208587945481, 967.0812727908515, 10608.681739547827, 10612.522436490299, 10625.893741062568, 10706.143508519377, 10750.838737418944, 4014.016565941363, 4135.60711732385, 4213.536510983789, 4292.699511034198, 4334.761588112621, 7812.6093695315, 7879.2120787921895, 7883.448158628841, 7888.960555197187, 7891.842163156704, 4282.785860706952, 4294.849680261176, 4297.634701050383, 4299.634531064895, 4302.849400270976, 3952.8616498422416, 3993.281209382281, 4011.5787842276723, 4012.4382586437923, 4013.4381186633896, 3253.837308134584, 3274.9017529474154, 3371.983140084333, 3380.712639425627, 3398.7111095557157, 958.5878072428923, 966.0291407135784, 996.5117092624706, 1015.4871789746279, 1031.128696251666, 591.8549955260903, 639.2329204954074, 648.1735786871776, 656.9638669873203, 684.4832151725416, 4854.2233242681, 4920.040592084581, 5151.665141765773, 5156.92264616031, 5229.764660590283, 804.8269622031291, 831.1148626712531, 841.9747407577782, 844.7972486603171, 849.4648371526023, 3271.5092736089778, 3439.724822014233, 3469.1847415857255, 3713.20166164276, 4052.1287923096675, 9498.715038548855, 9695.175910047585, 9714.271429642664, 9759.0, 9775.755606109904, 9651.758706032406, 9717.22262219035, 9721.513924303756, 9735.464549449849, 9757.414555126716, 6965.233824279325, 7300.744473943492, 7492.550446973199, 7492.70029198826, 7499.21258267885, 5297.947020529746, 5299.920501192408, 5330.8400747976075, 5333.973330133324, 5595.720213989365, 8368.24685778283, 8409.789755256168, 8566.143385661384, 8640.827183456422, 8725.520096394504, 8637.956810215908, 8723.781905452415, 8737.344699147463, 8754.21212090915, 8768.649254029768, 6660.63366514827, 6785.355391237825, 6785.4910881685055, 6790.93209067903, 6797.762078327235, 6863.210730766026, 6993.230744617987, 7064.576125432491, 7162.89255661155, 7205.963970180115, 5040.974795126001, 6274.498040156868, 6378.45783108441, 6410.871782564416, 6462.224533056064, 6372.808815735535, 6455.870882582228, 6530.738770449128, 6598.505112116514, 6714.261431242657, 6026.457618814327, 6130.9577371846, 6135.631862088289, 6135.723892424762, 6142.723577438936, 4463.642908567242, 4491.797869095833, 4495.100979803987, 4536.88657783558, 4563.133004729091, 4450.198964186348, 4489.573490518395, 4518.1415531049, 4545.0, 4704.50602686713], "value": 4006.1549501828226, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.48316894940695, 303.8875616022072, 312.5670945740149, 313.2075848104297, 316.12591185372435, 4760.0, 4827.155247831624, 4879.951200487994, 4952.727599981999, 4964.627652926031, 4656.4877863434995, 4713.9057218855605, 4746.335513028179, 4758.381410416641, 4799.040191961613, 3859.1509867829172, 3859.826307816155, 3864.4928477893645, 3878.3600705883564, 3916.608339166075, 3570.6786389224962, 3666.2850744104912, 3918.4318273850276, 3923.3134201514763, 3938.684905207591, 3828.885133446001, 3843.6348546888003, 3857.556381016177, 3858.84564617415, 3865.526063319464, 3852.1332700142525, 3862.1889403225355, 3862.633049860273, 3869.2454971280613, 3870.1872606752336, 3395.219099607104, 3397.8980630581123, 3406.2165701888457, 3408.403529382348, 3446.3107378524146, 4480.641548676098, 4671.626269898434, 4682.1037479820725, 4685.250359942393, 4716.669833111683, 4369.584889435499, 4374.912501749979, 4389.18800021997, 4410.970953361458, 4438.733675979452, 5066.468020857794, 5075.720835354054, 5080.288759573663, 5098.643094983353, 5116.462771408986, 3584.8386822593047, 3637.94543081854, 3638.4542318652416, 3703.5555733312176, 3748.83130259139, 5265.210218467222, 5269.394019687708, 5298.15229563268, 5299.33758280215, 5367.543758780508, 3652.726045546595, 3674.265146970563, 3704.388775852008, 3705.2959937611768, 3713.5729391119826, 3732.525652367354, 3747.0, 3771.6610603236004, 3778.319902417591, 3818.7517811342173, 4312.827486900489, 4313.84901528445, 4349.173657005159, 4368.771926317538, 4383.7588932609015, 4963.677360971526, 4994.225894986283, 5030.547250747377, 5034.295198672189, 5041.445441001487, 1240.1566934484456, 1275.655572995286, 1285.890699290552, 1306.3076569418224, 1323.7881938889925, 825.4623382808054, 835.6253962232215, 851.8424091543085, 853.9829203416022, 877.3507604372718, 4048.6963477739287, 4057.6406903687007, 4082.9177119669184, 4125.690573207022, 4136.276151673445, 4700.55344742249, 4700.858974230779, 4710.387649605529, 4712.88217794551, 4716.198246298138, 4063.167050754588, 4279.251131052053, 4557.339185818038, 4563.133004729091, 4573.6569757268335, 2756.4487102579164, 2762.1713485954533, 2772.542530482488, 2773.4468697529446, 2789.986050069737, 4933.851984440401, 4954.430240522386, 5004.0, 5009.5741861941415, 5031.0, 5091.236314552847, 5242.895142097213, 5334.946650533445, 5347.385050719139, 5359.383670877821, 4929.605631549396, 4945.357103576512, 4946.579540739005, 4970.975145124324, 4978.6763860348965, 5059.266406370982, 5178.948210517998, 5208.713520756395, 5219.921701174561, 5224.346956630421, 5100.617453690914, 5134.0, 5135.6903989483935, 5150.278960945546, 5160.716160611202, 4926.507349265188, 4927.187014142626, 4957.529034741694, 4965.47862474435, 5045.2936588876855, 3748.306563285801, 3748.718846086609, 3753.6434038766274, 3754.4743735877546, 3757.736958412994, 5066.82266120684, 5160.535551800356, 5201.895962080662, 5220.321358223407, 5253.290805741176, 5031.84904452867, 5069.518395752398, 5083.72039537829, 5097.260897169964, 5141.871453213699, 4882.609391248762, 5092.770825312796, 5093.796248150181, 5107.693538387709, 5154.329937108152, 4723.692959957729, 4875.7074575525585, 4984.526469985346, 4992.650514463952, 5005.199168133081, 4901.803927842989, 5068.695878247317, 5074.340335756328, 5074.619403544675, 5077.822276220315, 5008.749562521933, 5019.698818070928, 5022.3219865317715, 5034.974825125851, 5041.218611115283], "value": 3820.3297540175327, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.5971799599279, 584.8976429124905, 612.6722203621064, 653.5196630476598, 659.4954859532457, 11787.469563869625, 13376.732465350688, 13384.665383365409, 13412.329383530834, 13431.7313653727, 11829.822552661717, 11883.881161188385, 13250.403731832066, 13266.270355130464, 13360.93319533401, 710.4777988178697, 735.6763024269331, 745.679357876113, 747.1034758290047, 748.3190296829886, 745.1877453575602, 747.1669088965791, 748.1956896336433, 748.2442732839844, 748.3302444312337, 780.5706861226303, 780.6135962698472, 781.1719577248135, 781.6287263549825, 782.026377160436, 775.7013549783346, 775.8681024225895, 776.2974508070233, 776.3323541754087, 776.8756998880181, 568.763962955373, 568.9288838895138, 569.1803802524352, 570.0707846210692, 570.5264630356794, 11489.48297326614, 11497.770044599145, 11522.251053681568, 11529.135314851419, 11540.942295288554, 10523.0, 10552.736181595521, 10833.729156771065, 10884.564617415293, 11007.944960275227, 9445.480498572575, 9492.667756628554, 9566.952165239129, 9591.712248632552, 9667.90332096677, 3131.1389367923775, 3143.748500119985, 3164.114048066545, 3180.77734558581, 3188.649248582654, 58968.11547826786, 59834.0, 59920.70039649818, 61028.69485652588, 61328.38671613316, 7942.285194332538, 7965.8805117923275, 7966.880496792553, 7981.161977992343, 8116.918830811616, 15942.681146377008, 15993.36026558948, 16024.519264422086, 16027.919860400623, 16048.839511604969, 6309.356182030648, 6430.164078669743, 6431.356864313531, 6519.217693876765, 6680.933190668031, 3592.191756854739, 3596.6583174598372, 3633.364161271767, 3633.800140992271, 3679.7608155469807, 2670.7729842963568, 2796.5944937983877, 2799.7620202283033, 2800.4819108465, 2803.1590522843067, 468.2554737966581, 474.61793256428905, 479.7936887138494, 488.5676176583749, 494.6487993524566, 510.892568156355, 575.2579172867038, 576.826951914424, 576.944192128404, 582.9825105246849, 7975.52146871178, 8059.83880322402, 8064.637091330904, 8078.292874078672, 8223.0, 555.4084899581933, 587.6757424386541, 591.544510726738, 601.1043545117743, 613.5980932489226, 3627.764195327295, 3735.813209339522, 3823.502944617182, 3876.554196267465, 4066.79666016698, 99089.50455247678, 99579.50210248903, 101332.0, 103210.48394757978, 103594.48202758937, 85907.57046214728, 89026.0, 89467.55266223627, 89658.0, 91354.54322728344, 63302.366976330566, 71006.0, 77207.0, 77808.99999999886, 77863.61068194623, 7267.200607933229, 7543.245675432413, 7574.280443358092, 7815.491993020435, 7914.44598878073, 37487.62512374841, 38087.61912380841, 38195.42706859455, 42413.363799542414, 47361.0, 50175.74912125416, 51387.48612513977, 51452.742736286076, 58293.4170658288, 62524.687376562826, 11256.887431125584, 11671.35807530594, 11674.299542027506, 11776.057915366922, 11786.58746943853, 12434.502619895104, 12455.0, 13192.670183245496, 13318.40067196998, 13738.381772820047, 11660.941695291469, 11818.40907954616, 11901.642950711492, 12518.499260029497, 12544.24734515932, 12450.315232662291, 12770.361481926053, 13504.054716169774, 13569.660758480723, 13825.51610693621, 11660.708482288012, 11971.700707482383, 12183.390830458264, 12412.069094817743, 12521.686957826127, 10079.798404032024, 10240.795184096127, 10490.160787137163, 10884.673459795902, 11035.944820275847, 10326.793464130826, 10420.426876521864, 10616.734581635212, 10707.357558546511, 10735.624253151102], "value": 6322.893813043608, "unit": "score"}], "name": "dromaeo_css", "value": 6202.2091478543125, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 114.0, 115.0, 113.0, 115.0, 115.0, 114.0, 115.0, 115.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 123.0, 123.0, 177.0, 127.0, 130.0, 124.0, 126.0, 154.0, 127.0], "value": 136.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 163.0, 162.0, 162.0, 162.0, 162.0, 162.0, 161.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 77.0, 110.0, 77.0, 79.0, 76.0, 77.0, 105.0, 77.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 118.0, 83.0, 84.0, 83.0, 103.0, 83.0, 83.0, 121.0], "value": 92.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 147.0, 146.0, 146.0, 145.0, 147.0, 149.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 97.0, 95.0, 96.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 65.0, 64.0, 64.0, 66.0, 66.0, 64.0, 65.0, 66.0], "value": 64.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 74.0, 65.0, 67.0, 65.0, 66.0, 66.0, 65.0, 66.0, 66.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 86.0, 83.0, 89.0, 82.0, 90.0, 82.0, 96.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 151.0, 135.0, 134.0, 140.0, 134.0, 146.0, 143.0, 172.0, 136.0], "value": 143.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 174.0, 183.0, 174.0, 177.0, 174.0, 175.0, 171.0, 172.0, 170.0], "value": 174.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 68.0, 71.0, 71.0, 70.0, 72.0, 68.0, 70.0, 69.0], "value": 69.9, "unit": "score"}], "name": "kraken", "value": 1552.7, "alertThreshold": 2.0}]} 15:42:53 INFO - Return code: 0 15:42:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:42:53 INFO - # TBPL SUCCESS # 15:42:53 INFO - Running post-action listener: _resource_record_post_action 15:42:53 INFO - [mozharness: 2016-09-16 22:42:53.464702Z] Finished run-tests step (success) 15:42:53 INFO - Running post-run listener: _resource_record_post_run 15:42:53 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 395579392; Read time: 16; Write time: 282468 15:42:53 INFO - TinderboxPrint: CPU usage
13.1% 15:42:53 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 15:42:53 INFO - TinderboxPrint: I/O write bytes / time
395,579,392 / 282,468 15:42:53 INFO - TinderboxPrint: CPU idle
8,341.7 (86.9%) 15:42:53 INFO - TinderboxPrint: CPU user
1,205.2 (12.6%) 15:42:53 INFO - TinderboxPrint: Swap in / out
0 / 0 15:42:53 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110395392; Read time: 0; Write time: 89792 15:42:53 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 285184000; Read time: 0; Write time: 192676 15:42:54 INFO - Running post-run listener: _upload_blobber_files 15:42:54 INFO - Blob upload gear active. 15:42:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:42:54 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 15:42:54 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:42:54 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:42:54 INFO - (blobuploader) - INFO - Open directory for files ... 15:42:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:42:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:42:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:42:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:42:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:42:57 INFO - (blobuploader) - INFO - Done attempting. 15:42:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:42:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:42:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:42:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:42:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:42:58 INFO - (blobuploader) - INFO - Done attempting. 15:42:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:42:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:42:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:42:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:42:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:42:59 INFO - (blobuploader) - INFO - Done attempting. 15:42:59 INFO - (blobuploader) - INFO - Iteration through files over. 15:42:59 INFO - Return code: 0 15:42:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:42:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:42:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e3707ce69b4687b017ae4873760349fd42a10ffcd6dfe0e1cbbe33c6f9aa5d3eb557e490244fd5b534dbb57a3518a9ec600674d0f320656bc5664dcffa1f691d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2a86cca7f5dcd092a86fb19a4b5263241341dad41a430e2e1d6f01990eeace0a50187f98e8f19ff9f1159c3b7740b692a538fa0d4e7f28875344931bf877b02c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c172c072257be7307bb6a20c948ccba2c3699a44d7407285fa52b43ff33671f703ac06f28b3d8d1589c85e0fd54c3e88547b3027e2affb9d921e9d9ea54f1c6d"} 15:42:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:42:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:42:59 INFO - Contents: 15:42:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e3707ce69b4687b017ae4873760349fd42a10ffcd6dfe0e1cbbe33c6f9aa5d3eb557e490244fd5b534dbb57a3518a9ec600674d0f320656bc5664dcffa1f691d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2a86cca7f5dcd092a86fb19a4b5263241341dad41a430e2e1d6f01990eeace0a50187f98e8f19ff9f1159c3b7740b692a538fa0d4e7f28875344931bf877b02c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c172c072257be7307bb6a20c948ccba2c3699a44d7407285fa52b43ff33671f703ac06f28b3d8d1589c85e0fd54c3e88547b3027e2affb9d921e9d9ea54f1c6d"} 15:42:59 INFO - Running post-run listener: copy_logs_to_upload_dir 15:42:59 INFO - Copying logs to upload dir... 15:42:59 INFO - mkdir: /builds/slave/test/build/upload/logs 15:42:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.817353 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-09-16 15:42:59.422555) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-16 15:42:59.426402) ========= 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=41a7e32711b8e08598a63237000001d6-1474064442.60134-1981398999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e3707ce69b4687b017ae4873760349fd42a10ffcd6dfe0e1cbbe33c6f9aa5d3eb557e490244fd5b534dbb57a3518a9ec600674d0f320656bc5664dcffa1f691d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2a86cca7f5dcd092a86fb19a4b5263241341dad41a430e2e1d6f01990eeace0a50187f98e8f19ff9f1159c3b7740b692a538fa0d4e7f28875344931bf877b02c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c172c072257be7307bb6a20c948ccba2c3699a44d7407285fa52b43ff33671f703ac06f28b3d8d1589c85e0fd54c3e88547b3027e2affb9d921e9d9ea54f1c6d"} build_url:https://queue.taskcluster.net/v1/task/V8BLiw7XQSW3Nc_ZBEHUUw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011274 build_url: 'https://queue.taskcluster.net/v1/task/V8BLiw7XQSW3Nc_ZBEHUUw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e3707ce69b4687b017ae4873760349fd42a10ffcd6dfe0e1cbbe33c6f9aa5d3eb557e490244fd5b534dbb57a3518a9ec600674d0f320656bc5664dcffa1f691d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2a86cca7f5dcd092a86fb19a4b5263241341dad41a430e2e1d6f01990eeace0a50187f98e8f19ff9f1159c3b7740b692a538fa0d4e7f28875344931bf877b02c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c172c072257be7307bb6a20c948ccba2c3699a44d7407285fa52b43ff33671f703ac06f28b3d8d1589c85e0fd54c3e88547b3027e2affb9d921e9d9ea54f1c6d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-16 15:42:59.452373) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-16 15:42:59.452943) ========= 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=41a7e32711b8e08598a63237000001d6-1474064442.60134-1981398999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004514 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-16 15:42:59.539494) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-16 15:42:59.540460) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-16 15:42:59.540805) ========= ========= Total master_lag: 0.19 =========