builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-003 starttime: 1480910932.92 results: success (0) buildid: 20161204191338 builduid: e78c2c19b4d64468a4c28dec6d7eb821 revision: 52cc3c8b17c96e2a008fedaec7149427d1b31530 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-04 20:08:52.915665) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-04 20:08:52.916030) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-04 20:08:52.916327) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-04 20:08:52.933745) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 20:08:52.934021) ========= 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=7de08804244eb36560b44971000001c3-1480906069.544433-512934353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-04 20:08:53-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.7M=0s 2016-12-04 20:08:53 (41.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.105699 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 20:08:53.053171) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 20:08:53.053488) ========= 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=7de08804244eb36560b44971000001c3-1480906069.544433-512934353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013770 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 20:08:53.102920) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-04 20:08:53.103253) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 52cc3c8b17c96e2a008fedaec7149427d1b31530 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 52cc3c8b17c96e2a008fedaec7149427d1b31530 --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=7de08804244eb36560b44971000001c3-1480906069.544433-512934353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-04 20:08:53,792 truncating revision to first 12 chars 2016-12-04 20:08:53,793 Setting DEBUG logging. 2016-12-04 20:08:53,793 attempt 1/10 2016-12-04 20:08:53,793 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/52cc3c8b17c9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-04 20:08:54,529 unpacking tar archive at: mozilla-central-52cc3c8b17c9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.124824 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-04 20:08:54.241203) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-04 20:08:54.241504) ========= script_repo_revision: 52cc3c8b17c96e2a008fedaec7149427d1b31530 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-04 20:08:54.241888) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-04 20:08:54.242150) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-04 20:08:54.253875) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-12-04 20:08:54.254161) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=7de08804244eb36560b44971000001c3-1480906069.544433-512934353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:08:55 INFO - MultiFileLogger online at 20161204 20:08:55 in /builds/slave/test 20:08:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 20:08:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:08:55 INFO - {'append_to_log': False, 20:08:55 INFO - 'base_work_dir': '/builds/slave/test', 20:08:55 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 20:08:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:08:55 INFO - 'branch': 'Firefox-Non-PGO', 20:08:55 INFO - 'buildbot_json_path': 'buildprops.json', 20:08:55 INFO - 'config_files': ('talos/linux_config.py',), 20:08:55 INFO - 'default_actions': ('clobber', 20:08:55 INFO - 'read-buildbot-config', 20:08:55 INFO - 'download-and-extract', 20:08:55 INFO - 'populate-webroot', 20:08:55 INFO - 'create-virtualenv', 20:08:55 INFO - 'install', 20:08:55 INFO - 'run-tests'), 20:08:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:08:55 INFO - 'download_minidump_stackwalk': True, 20:08:55 INFO - 'download_symbols': 'ondemand', 20:08:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:08:55 INFO - 'tooltool.py': '/tools/tooltool.py', 20:08:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:08:55 INFO - '/tools/misc-python/virtualenv.py')}, 20:08:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:08:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:08:55 INFO - 'installer_path': 'installer.exe', 20:08:55 INFO - 'log_level': 'info', 20:08:55 INFO - 'log_name': 'talos', 20:08:55 INFO - 'log_to_console': True, 20:08:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:08:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:08:55 INFO - 'opt_config_files': (), 20:08:55 INFO - 'pip_index': False, 20:08:55 INFO - 'sps_profile': False, 20:08:55 INFO - 'sps_profile_interval': 0, 20:08:55 INFO - 'suite': 'dromaeojs', 20:08:55 INFO - 'system_bits': '32', 20:08:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:08:55 INFO - 'title': 'talos-linux64-ix-003', 20:08:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:08:55 INFO - 'use_talos_json': True, 20:08:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:08:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:08:55 INFO - 'work_dir': 'build'} 20:08:55 INFO - [mozharness: 2016-12-05 04:08:55.047862Z] Running clobber step. 20:08:55 INFO - Running pre-action listener: _resource_record_pre_action 20:08:55 INFO - Running main action method: clobber 20:08:55 INFO - rmtree: /builds/slave/test/build 20:08:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:08:56 INFO - Running post-action listener: _resource_record_post_action 20:08:56 INFO - [mozharness: 2016-12-05 04:08:56.028033Z] Finished clobber step (success) 20:08:56 INFO - [mozharness: 2016-12-05 04:08:56.028132Z] Running read-buildbot-config step. 20:08:56 INFO - Running pre-action listener: _resource_record_pre_action 20:08:56 INFO - Running main action method: read_buildbot_config 20:08:56 INFO - Using buildbot properties: 20:08:56 INFO - { 20:08:56 INFO - "project": "", 20:08:56 INFO - "product": "firefox", 20:08:56 INFO - "script_repo_revision": "production", 20:08:56 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 20:08:56 INFO - "repository": "", 20:08:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 20:08:56 INFO - "buildid": "20161204191338", 20:08:56 INFO - "pgo_build": "False", 20:08:56 INFO - "basedir": "/builds/slave/test", 20:08:56 INFO - "buildnumber": 733, 20:08:56 INFO - "slavename": "talos-linux64-ix-003", 20:08:56 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:08:56 INFO - "platform": "ubuntu64_hw", 20:08:56 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 20:08:56 INFO - "branch": "mozilla-central", 20:08:56 INFO - "repo_path": "mozilla-central", 20:08:56 INFO - "revision": "52cc3c8b17c96e2a008fedaec7149427d1b31530", 20:08:56 INFO - "stage_platform": "linux64", 20:08:56 INFO - "builduid": "e78c2c19b4d64468a4c28dec6d7eb821", 20:08:56 INFO - "slavebuilddir": "test" 20:08:56 INFO - } 20:08:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/TEzR31s_QyyQw1qCcLYHvg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 20:08:56 INFO - Running post-action listener: _resource_record_post_action 20:08:56 INFO - [mozharness: 2016-12-05 04:08:56.030558Z] Finished read-buildbot-config step (success) 20:08:56 INFO - [mozharness: 2016-12-05 04:08:56.030646Z] Running download-and-extract step. 20:08:56 INFO - Running pre-action listener: _resource_record_pre_action 20:08:56 INFO - Running main action method: download_and_extract 20:08:56 INFO - mkdir: /builds/slave/test/build/tests 20:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:56 INFO - trying https://queue.taskcluster.net/v1/task/TEzR31s_QyyQw1qCcLYHvg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 20:08:56 INFO - Downloading https://queue.taskcluster.net/v1/task/TEzR31s_QyyQw1qCcLYHvg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 20:08:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TEzR31s_QyyQw1qCcLYHvg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:08:56 INFO - Downloaded 1361 bytes. 20:08:56 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 20:08:56 INFO - Using the following test package requirements: 20:08:56 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 20:08:56 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:08:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:08:56 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:08:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:08:56 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:08:56 INFO - u'jsshell-linux-x86_64.zip'], 20:08:56 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:08:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:08:56 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 20:08:56 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:08:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:08:56 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:08:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:08:56 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:08:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:08:56 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:08:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:08:56 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:08:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TEzR31s_QyyQw1qCcLYHvg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 20:08:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TEzR31s_QyyQw1qCcLYHvg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:08:56 INFO - Fetch https://queue.taskcluster.net/v1/task/TEzR31s_QyyQw1qCcLYHvg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:08:58 INFO - Expected file size: 20218590 20:08:58 INFO - Obtained file size: 20218590 20:09:02 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:09:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TEzR31s_QyyQw1qCcLYHvg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 20:09:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TEzR31s_QyyQw1qCcLYHvg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:09:02 INFO - Fetch https://queue.taskcluster.net/v1/task/TEzR31s_QyyQw1qCcLYHvg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:09:03 INFO - Expected file size: 20218590 20:09:03 INFO - Obtained file size: 20218590 20:09:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TEzR31s_QyyQw1qCcLYHvg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 20:09:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TEzR31s_QyyQw1qCcLYHvg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:09:08 INFO - Fetch https://queue.taskcluster.net/v1/task/TEzR31s_QyyQw1qCcLYHvg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 20:09:09 INFO - Expected file size: 14409734 20:09:09 INFO - Obtained file size: 14409734 20:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:09 INFO - trying https://queue.taskcluster.net/v1/task/TEzR31s_QyyQw1qCcLYHvg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:09:09 INFO - Downloading https://queue.taskcluster.net/v1/task/TEzR31s_QyyQw1qCcLYHvg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:09:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TEzR31s_QyyQw1qCcLYHvg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:09:12 INFO - Downloaded 55710849 bytes. 20:09:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TEzR31s_QyyQw1qCcLYHvg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:09:12 INFO - mkdir: /builds/slave/test/properties 20:09:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:09:12 INFO - Writing to file /builds/slave/test/properties/build_url 20:09:12 INFO - Contents: 20:09:12 INFO - build_url:https://queue.taskcluster.net/v1/task/TEzR31s_QyyQw1qCcLYHvg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:09:12 INFO - Running post-action listener: _resource_record_post_action 20:09:12 INFO - Running post-action listener: set_extra_try_arguments 20:09:12 INFO - [mozharness: 2016-12-05 04:09:12.818408Z] Finished download-and-extract step (success) 20:09:12 INFO - [mozharness: 2016-12-05 04:09:12.818637Z] Running populate-webroot step. 20:09:12 INFO - Running pre-action listener: _resource_record_pre_action 20:09:12 INFO - Running main action method: populate_webroot 20:09:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:09:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:09:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:09:12 INFO - '--tppagecycles', 20:09:12 INFO - '7'], 20:09:12 INFO - 'tests': ['tsvgm']}}, 20:09:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:09:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:09:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:09:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:09:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:09:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:09:12 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:09:12 INFO - 'talos_options': ['--disable-e10s'], 20:09:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:09:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:09:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:09:12 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:09:12 INFO - 'talos_options': ['--disable-e10s'], 20:09:12 INFO - 'tests': ['damp', 'tps']}, 20:09:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:09:12 INFO - 'tests': ['damp', 'tps']}, 20:09:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:09:12 INFO - 'tests': ['dromaeo_dom']}, 20:09:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:09:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:09:12 INFO - 'tests': ['basic_compositor_video']}, 20:09:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:09:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:09:12 INFO - 'tests': ['a11yr', 20:09:12 INFO - 'ts_paint', 20:09:12 INFO - 'tpaint', 20:09:12 INFO - 'sessionrestore', 20:09:12 INFO - 'sessionrestore_no_auto_restore', 20:09:12 INFO - 'tabpaint']}, 20:09:12 INFO - 'other-e10s': {'tests': ['a11yr', 20:09:12 INFO - 'ts_paint', 20:09:12 INFO - 'tpaint', 20:09:12 INFO - 'sessionrestore', 20:09:12 INFO - 'sessionrestore_no_auto_restore', 20:09:12 INFO - 'tabpaint']}, 20:09:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:09:12 INFO - 'ts_paint', 20:09:12 INFO - 'tpaint', 20:09:12 INFO - 'sessionrestore', 20:09:12 INFO - 'sessionrestore_no_auto_restore', 20:09:12 INFO - 'tabpaint']}, 20:09:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:09:12 INFO - 'ts_paint', 20:09:12 INFO - 'tpaint', 20:09:12 INFO - 'sessionrestore', 20:09:12 INFO - 'sessionrestore_no_auto_restore', 20:09:12 INFO - 'tabpaint']}, 20:09:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:09:12 INFO - 'tests': ['a11yr', 20:09:12 INFO - 'ts_paint', 20:09:12 INFO - 'tpaint', 20:09:12 INFO - 'sessionrestore', 20:09:12 INFO - 'sessionrestore_no_auto_restore', 20:09:12 INFO - 'tabpaint']}, 20:09:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:09:12 INFO - 'tests': ['a11yr', 20:09:12 INFO - 'ts_paint', 20:09:12 INFO - 'tpaint', 20:09:12 INFO - 'sessionrestore', 20:09:12 INFO - 'sessionrestore_no_auto_restore', 20:09:12 INFO - 'tabpaint']}, 20:09:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:09:12 INFO - 'tests': ['tsvgx', 20:09:12 INFO - 'tsvgr_opacity', 20:09:12 INFO - 'tart', 20:09:12 INFO - 'tscrollx', 20:09:12 INFO - 'cart', 20:09:12 INFO - 'tsvg_static']}, 20:09:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:09:12 INFO - 'tsvgr_opacity', 20:09:12 INFO - 'tart', 20:09:12 INFO - 'tscrollx', 20:09:12 INFO - 'cart', 20:09:12 INFO - 'tsvg_static']}, 20:09:12 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:09:12 INFO - 'talos_options': ['--disable-e10s'], 20:09:12 INFO - 'tests': ['tp5o']}, 20:09:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:09:12 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:09:12 INFO - 'talos_options': ['--disable-e10s', 20:09:12 INFO - '--xperf_path', 20:09:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:09:12 INFO - 'tests': ['tp5n']}, 20:09:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:09:12 INFO - 'talos_options': ['--xperf_path', 20:09:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:09:12 INFO - 'tests': ['tp5n']}}, 20:09:12 INFO - 'talos.zip': {'path': '', 20:09:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:09:12 INFO - Running post-action listener: _resource_record_post_action 20:09:12 INFO - [mozharness: 2016-12-05 04:09:12.836630Z] Finished populate-webroot step (success) 20:09:12 INFO - [mozharness: 2016-12-05 04:09:12.836718Z] Running create-virtualenv step. 20:09:12 INFO - Running pre-action listener: _resource_record_pre_action 20:09:12 INFO - Running main action method: create_virtualenv 20:09:12 INFO - Creating virtualenv /builds/slave/test/build/venv 20:09:12 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 20:09:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:09:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:09:12 INFO - Using real prefix '/usr' 20:09:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:09:13 INFO - Installing distribute.............................................................................................................................................................................................done. 20:09:15 INFO - Installing pip.................done. 20:09:15 INFO - Return code: 0 20:09:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:09:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:09:15 INFO - Reading from file tmpfile_stdout 20:09:15 INFO - Output received: 20:09:15 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 20:09:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8c2719e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2043120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d3f20>, '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 0x2040c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2040f90>, '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': '7de08804244eb36560b44971000001c3-1480906069.544433-512934353', '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 20:09:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:09:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:09:15 INFO - Using env: {'DISPLAY': ':0', 20:09:15 INFO - 'HOME': '/home/cltbld', 20:09:15 INFO - 'LANG': 'en_US.UTF-8', 20:09:15 INFO - 'LANGUAGE': 'en_US:en', 20:09:15 INFO - 'LOGNAME': 'cltbld', 20:09:15 INFO - 'MAIL': '/var/mail/cltbld', 20:09:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:15 INFO - 'MOZ_NO_REMOTE': '1', 20:09:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:15 INFO - 'NO_EM_RESTART': '1', 20:09:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:15 INFO - 'PWD': '/builds/slave/test', 20:09:15 INFO - 'SHELL': '/bin/bash', 20:09:15 INFO - 'SHLVL': '1', 20:09:15 INFO - 'TERM': 'linux', 20:09:15 INFO - 'TMOUT': '86400', 20:09:15 INFO - 'USER': 'cltbld', 20:09:15 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1480906069.544433-512934353', 20:09:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:15 INFO - '_': '/tools/buildbot/bin/python'} 20:09:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:15 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 20:09:15 INFO - Cleaning up... 20:09:15 INFO - Return code: 0 20:09:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd8c2719e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2043120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d3f20>, '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 0x2040c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2040f90>, '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': '7de08804244eb36560b44971000001c3-1480906069.544433-512934353', '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 20:09:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:09:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:09:15 INFO - Using env: {'DISPLAY': ':0', 20:09:15 INFO - 'HOME': '/home/cltbld', 20:09:15 INFO - 'LANG': 'en_US.UTF-8', 20:09:15 INFO - 'LANGUAGE': 'en_US:en', 20:09:15 INFO - 'LOGNAME': 'cltbld', 20:09:15 INFO - 'MAIL': '/var/mail/cltbld', 20:09:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:15 INFO - 'MOZ_NO_REMOTE': '1', 20:09:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:15 INFO - 'NO_EM_RESTART': '1', 20:09:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:15 INFO - 'PWD': '/builds/slave/test', 20:09:15 INFO - 'SHELL': '/bin/bash', 20:09:15 INFO - 'SHLVL': '1', 20:09:15 INFO - 'TERM': 'linux', 20:09:15 INFO - 'TMOUT': '86400', 20:09:15 INFO - 'USER': 'cltbld', 20:09:15 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1480906069.544433-512934353', 20:09:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:15 INFO - '_': '/tools/buildbot/bin/python'} 20:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:16 INFO - Downloading/unpacking psutil>=3.1.1 20:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:09:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:09:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:09:18 INFO - Installing collected packages: psutil 20:09:18 INFO - Running setup.py install for psutil 20:09:18 INFO - building 'psutil._psutil_linux' extension 20:09:18 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 20:09:18 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 20:09:18 INFO - building 'psutil._psutil_posix' extension 20:09:18 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 20:09:18 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 20:09:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:09:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:09:18 INFO - Successfully installed psutil 20:09:18 INFO - Cleaning up... 20:09:18 INFO - Return code: 0 20:09:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8c2719e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2043120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d3f20>, '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 0x2040c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2040f90>, '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': '7de08804244eb36560b44971000001c3-1480906069.544433-512934353', '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 20:09:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:09:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:09:18 INFO - Using env: {'DISPLAY': ':0', 20:09:18 INFO - 'HOME': '/home/cltbld', 20:09:18 INFO - 'LANG': 'en_US.UTF-8', 20:09:18 INFO - 'LANGUAGE': 'en_US:en', 20:09:18 INFO - 'LOGNAME': 'cltbld', 20:09:18 INFO - 'MAIL': '/var/mail/cltbld', 20:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:18 INFO - 'MOZ_NO_REMOTE': '1', 20:09:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:18 INFO - 'NO_EM_RESTART': '1', 20:09:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:18 INFO - 'PWD': '/builds/slave/test', 20:09:18 INFO - 'SHELL': '/bin/bash', 20:09:18 INFO - 'SHLVL': '1', 20:09:18 INFO - 'TERM': 'linux', 20:09:18 INFO - 'TMOUT': '86400', 20:09:18 INFO - 'USER': 'cltbld', 20:09:18 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1480906069.544433-512934353', 20:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:18 INFO - '_': '/tools/buildbot/bin/python'} 20:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:09:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:09:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:09:20 INFO - Installing collected packages: mozsystemmonitor 20:09:20 INFO - Running setup.py install for mozsystemmonitor 20:09:21 INFO - Successfully installed mozsystemmonitor 20:09:21 INFO - Cleaning up... 20:09:21 INFO - Return code: 0 20:09:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:09:21 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')]} 20:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:21 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')]} 20:09:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:21 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 0x7fd8c2719e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2043120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d3f20>, '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 0x2040c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2040f90>, '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': '7de08804244eb36560b44971000001c3-1480906069.544433-512934353', '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 20:09:21 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 20:09:21 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 20:09:21 INFO - Using env: {'DISPLAY': ':0', 20:09:21 INFO - 'HOME': '/home/cltbld', 20:09:21 INFO - 'LANG': 'en_US.UTF-8', 20:09:21 INFO - 'LANGUAGE': 'en_US:en', 20:09:21 INFO - 'LOGNAME': 'cltbld', 20:09:21 INFO - 'MAIL': '/var/mail/cltbld', 20:09:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:21 INFO - 'MOZ_NO_REMOTE': '1', 20:09:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:21 INFO - 'NO_EM_RESTART': '1', 20:09:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:21 INFO - 'PWD': '/builds/slave/test', 20:09:21 INFO - 'SHELL': '/bin/bash', 20:09:21 INFO - 'SHLVL': '1', 20:09:21 INFO - 'TERM': 'linux', 20:09:21 INFO - 'TMOUT': '86400', 20:09:21 INFO - 'USER': 'cltbld', 20:09:21 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1480906069.544433-512934353', 20:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:21 INFO - '_': '/tools/buildbot/bin/python'} 20:09:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:21 INFO - Downloading/unpacking jsonschema==2.5.1 20:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:09:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:23 INFO - Downloading functools32-3.2.3-2.tar.gz 20:09:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:09:23 INFO - warning: no files found matching '*.txt' 20:09:23 INFO - no previously-included directories found matching 'build' 20:09:23 INFO - no previously-included directories found matching 'dist' 20:09:23 INFO - no previously-included directories found matching '.git*' 20:09:23 INFO - Installing collected packages: jsonschema, functools32 20:09:23 INFO - Running setup.py install for functools32 20:09:23 INFO - warning: no files found matching '*.txt' 20:09:23 INFO - no previously-included directories found matching 'build' 20:09:23 INFO - no previously-included directories found matching 'dist' 20:09:23 INFO - no previously-included directories found matching '.git*' 20:09:23 INFO - Successfully installed jsonschema functools32 20:09:23 INFO - Cleaning up... 20:09:23 INFO - Return code: 0 20:09:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd8c2719e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2043120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d3f20>, '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 0x2040c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2040f90>, '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': '7de08804244eb36560b44971000001c3-1480906069.544433-512934353', '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 20:09:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:09:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:09:23 INFO - Using env: {'DISPLAY': ':0', 20:09:23 INFO - 'HOME': '/home/cltbld', 20:09:23 INFO - 'LANG': 'en_US.UTF-8', 20:09:23 INFO - 'LANGUAGE': 'en_US:en', 20:09:23 INFO - 'LOGNAME': 'cltbld', 20:09:23 INFO - 'MAIL': '/var/mail/cltbld', 20:09:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:23 INFO - 'MOZ_NO_REMOTE': '1', 20:09:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:23 INFO - 'NO_EM_RESTART': '1', 20:09:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:23 INFO - 'PWD': '/builds/slave/test', 20:09:23 INFO - 'SHELL': '/bin/bash', 20:09:23 INFO - 'SHLVL': '1', 20:09:23 INFO - 'TERM': 'linux', 20:09:23 INFO - 'TMOUT': '86400', 20:09:23 INFO - 'USER': 'cltbld', 20:09:23 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1480906069.544433-512934353', 20:09:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:23 INFO - '_': '/tools/buildbot/bin/python'} 20:09:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:09:23 INFO - Cleaning up... 20:09:23 INFO - Return code: 0 20:09:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:24 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 0x7fd8c2719e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2043120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d3f20>, '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 0x2040c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2040f90>, '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': '7de08804244eb36560b44971000001c3-1480906069.544433-512934353', '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 20:09:24 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 20:09:24 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 20:09:24 INFO - Using env: {'DISPLAY': ':0', 20:09:24 INFO - 'HOME': '/home/cltbld', 20:09:24 INFO - 'LANG': 'en_US.UTF-8', 20:09:24 INFO - 'LANGUAGE': 'en_US:en', 20:09:24 INFO - 'LOGNAME': 'cltbld', 20:09:24 INFO - 'MAIL': '/var/mail/cltbld', 20:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:24 INFO - 'MOZ_NO_REMOTE': '1', 20:09:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:24 INFO - 'NO_EM_RESTART': '1', 20:09:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:24 INFO - 'PWD': '/builds/slave/test', 20:09:24 INFO - 'SHELL': '/bin/bash', 20:09:24 INFO - 'SHLVL': '1', 20:09:24 INFO - 'TERM': 'linux', 20:09:24 INFO - 'TMOUT': '86400', 20:09:24 INFO - 'USER': 'cltbld', 20:09:24 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1480906069.544433-512934353', 20:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:24 INFO - '_': '/tools/buildbot/bin/python'} 20:09:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:24 INFO - Downloading/unpacking blobuploader==1.2.4 20:09:24 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 20:09:24 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 20:09:24 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 20:09:24 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 20:09:24 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 20:09:24 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 20:09:26 INFO - Downloading blobuploader-1.2.4.tar.gz 20:09:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:09:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:09:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:26 INFO - Downloading docopt-0.6.1.tar.gz 20:09:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:09:26 INFO - Installing collected packages: blobuploader, requests, docopt 20:09:26 INFO - Running setup.py install for blobuploader 20:09:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:09:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:09:27 INFO - Running setup.py install for requests 20:09:27 INFO - Running setup.py install for docopt 20:09:27 INFO - Successfully installed blobuploader requests docopt 20:09:27 INFO - Cleaning up... 20:09:27 INFO - Return code: 0 20:09:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:27 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 0x7fd8c2719e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2043120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d3f20>, '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 0x2040c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2040f90>, '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': '7de08804244eb36560b44971000001c3-1480906069.544433-512934353', '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 20:09:27 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 20:09:27 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 20:09:27 INFO - Using env: {'DISPLAY': ':0', 20:09:27 INFO - 'HOME': '/home/cltbld', 20:09:27 INFO - 'LANG': 'en_US.UTF-8', 20:09:27 INFO - 'LANGUAGE': 'en_US:en', 20:09:27 INFO - 'LOGNAME': 'cltbld', 20:09:27 INFO - 'MAIL': '/var/mail/cltbld', 20:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:27 INFO - 'MOZ_NO_REMOTE': '1', 20:09:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:27 INFO - 'NO_EM_RESTART': '1', 20:09:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:27 INFO - 'PWD': '/builds/slave/test', 20:09:27 INFO - 'SHELL': '/bin/bash', 20:09:27 INFO - 'SHLVL': '1', 20:09:27 INFO - 'TERM': 'linux', 20:09:27 INFO - 'TMOUT': '86400', 20:09:27 INFO - 'USER': 'cltbld', 20:09:27 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1480906069.544433-512934353', 20:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:27 INFO - '_': '/tools/buildbot/bin/python'} 20:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:09:27 INFO - Running setup.py (path:/tmp/pip-jb58v_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:09:27 INFO - Running setup.py (path:/tmp/pip-5fJAYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:09:27 INFO - Running setup.py (path:/tmp/pip-taueva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:09:28 INFO - Running setup.py (path:/tmp/pip-BfeYNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:09:28 INFO - Running setup.py (path:/tmp/pip-oma2Te-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:09:28 INFO - Running setup.py (path:/tmp/pip-cGKgzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:09:28 INFO - Running setup.py (path:/tmp/pip-CFL7lK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:09:28 INFO - Running setup.py (path:/tmp/pip-jk5O5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:09:28 INFO - Running setup.py (path:/tmp/pip-KbKzRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:09:28 INFO - Running setup.py (path:/tmp/pip-6_nDcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:09:28 INFO - Running setup.py (path:/tmp/pip-11H70Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:09:28 INFO - Running setup.py (path:/tmp/pip-6ha3s3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:09:28 INFO - Running setup.py (path:/tmp/pip-miCXxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:09:28 INFO - Running setup.py (path:/tmp/pip-D3Ow7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:28 INFO - Running setup.py (path:/tmp/pip-DSbgXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:09:28 INFO - Running setup.py (path:/tmp/pip-iVNtVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:09:28 INFO - Running setup.py (path:/tmp/pip-7jdUJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:09:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:09:29 INFO - Running setup.py install for manifestparser 20:09:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:09:29 INFO - Running setup.py install for mozcrash 20:09:29 INFO - Running setup.py install for mozdebug 20:09:29 INFO - Running setup.py install for mozdevice 20:09:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:09:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:09:29 INFO - Running setup.py install for mozfile 20:09:29 INFO - Running setup.py install for mozhttpd 20:09:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:09:29 INFO - Running setup.py install for mozinfo 20:09:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:09:29 INFO - Running setup.py install for mozInstall 20:09:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:09:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:09:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:09:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:09:29 INFO - Running setup.py install for mozleak 20:09:29 INFO - Running setup.py install for mozlog 20:09:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:09:30 INFO - Running setup.py install for moznetwork 20:09:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:09:30 INFO - Running setup.py install for mozprocess 20:09:30 INFO - Running setup.py install for mozprofile 20:09:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:09:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:09:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:09:30 INFO - Running setup.py install for mozrunner 20:09:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:09:30 INFO - Running setup.py install for mozscreenshot 20:09:30 INFO - Running setup.py install for moztest 20:09:30 INFO - Running setup.py install for mozversion 20:09:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:09:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:09:30 INFO - Cleaning up... 20:09:30 INFO - Return code: 0 20:09:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:09: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')]} 20:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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')]} 20:09:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:30 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 0x7fd8c2719e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2043120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d3f20>, '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 0x2040c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2040f90>, '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': '7de08804244eb36560b44971000001c3-1480906069.544433-512934353', '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 20:09:30 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 20:09:30 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 20:09:30 INFO - Using env: {'DISPLAY': ':0', 20:09:30 INFO - 'HOME': '/home/cltbld', 20:09:30 INFO - 'LANG': 'en_US.UTF-8', 20:09:30 INFO - 'LANGUAGE': 'en_US:en', 20:09:30 INFO - 'LOGNAME': 'cltbld', 20:09:30 INFO - 'MAIL': '/var/mail/cltbld', 20:09:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:30 INFO - 'MOZ_NO_REMOTE': '1', 20:09:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:30 INFO - 'NO_EM_RESTART': '1', 20:09:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:30 INFO - 'PWD': '/builds/slave/test', 20:09:30 INFO - 'SHELL': '/bin/bash', 20:09:30 INFO - 'SHLVL': '1', 20:09:30 INFO - 'TERM': 'linux', 20:09:30 INFO - 'TMOUT': '86400', 20:09:30 INFO - 'USER': 'cltbld', 20:09:30 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1480906069.544433-512934353', 20:09:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:30 INFO - '_': '/tools/buildbot/bin/python'} 20:09:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:09:31 INFO - Running setup.py (path:/tmp/pip-QFejpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:09:31 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)) 20:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:09:31 INFO - Running setup.py (path:/tmp/pip-JVVPUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:09:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 20:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:09:31 INFO - Running setup.py (path:/tmp/pip-llHsjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:09:31 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)) 20:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:09:31 INFO - Running setup.py (path:/tmp/pip-4UyFNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:09:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 20:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:09:31 INFO - Running setup.py (path:/tmp/pip-zWO80M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:09:31 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)) 20:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:09:31 INFO - Running setup.py (path:/tmp/pip-dY0mjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:09:31 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)) 20:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:09:31 INFO - Running setup.py (path:/tmp/pip-r8JAbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:09:31 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)) 20:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:09:31 INFO - Running setup.py (path:/tmp/pip-1cndVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:09:31 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)) 20:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:09:31 INFO - Running setup.py (path:/tmp/pip-RyUgjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:09:31 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)) 20:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:09:31 INFO - Running setup.py (path:/tmp/pip-TbNzUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:09:31 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)) 20:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:09:31 INFO - Running setup.py (path:/tmp/pip-UBIFhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:09:31 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)) 20:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:09:31 INFO - Running setup.py (path:/tmp/pip-MRfUOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:09:31 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)) 20:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:09:31 INFO - Running setup.py (path:/tmp/pip-wbQuL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:09:32 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)) 20:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:09:32 INFO - Running setup.py (path:/tmp/pip-riCKLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 20:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:32 INFO - Running setup.py (path:/tmp/pip-4pwPgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:32 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)) 20:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:09:32 INFO - Running setup.py (path:/tmp/pip-lGyYa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:09:32 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)) 20:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:09:32 INFO - Running setup.py (path:/tmp/pip-QOsMnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:09:32 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)) 20:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:09:32 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)) 20:09:32 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:09:32 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:09:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:34 INFO - Downloading blessings-1.6.tar.gz 20:09:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:09:34 INFO - Installing collected packages: blessings 20:09:34 INFO - Running setup.py install for blessings 20:09:34 INFO - Successfully installed blessings 20:09:34 INFO - Cleaning up... 20:09:34 INFO - Return code: 0 20:09:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:09:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:09:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:09:34 INFO - Reading from file tmpfile_stdout 20:09:34 INFO - Current package versions: 20:09:34 INFO - argparse == 1.2.1 20:09:34 INFO - blessings == 1.6 20:09:34 INFO - blobuploader == 1.2.4 20:09:34 INFO - docopt == 0.6.1 20:09:34 INFO - functools32 == 3.2.3-2 20:09:34 INFO - jsonschema == 2.5.1 20:09:34 INFO - manifestparser == 1.1 20:09:34 INFO - mozInstall == 1.12 20:09:34 INFO - mozcrash == 1.0 20:09:34 INFO - mozdebug == 0.1 20:09:34 INFO - mozdevice == 0.49 20:09:34 INFO - mozfile == 1.2 20:09:34 INFO - mozhttpd == 0.7 20:09:34 INFO - mozinfo == 0.9 20:09:34 INFO - mozleak == 0.1 20:09:34 INFO - mozlog == 3.4 20:09:34 INFO - moznetwork == 0.27 20:09:34 INFO - mozprocess == 0.23 20:09:34 INFO - mozprofile == 0.28 20:09:34 INFO - mozrunner == 6.13 20:09:34 INFO - mozscreenshot == 0.1 20:09:34 INFO - mozsystemmonitor == 0.3 20:09:34 INFO - moztest == 0.7 20:09:34 INFO - mozversion == 1.4 20:09:34 INFO - psutil == 3.1.1 20:09:34 INFO - requests == 1.2.3 20:09:34 INFO - wsgiref == 0.1.2 20:09:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:09:34 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')]} 20:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:34 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')]} 20:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:34 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 0x7fd8c2719e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2043120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d3f20>, '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 0x2040c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2040f90>, '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': '7de08804244eb36560b44971000001c3-1480906069.544433-512934353', '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 20:09:34 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 20:09:34 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 20:09:34 INFO - Using env: {'DISPLAY': ':0', 20:09:34 INFO - 'HOME': '/home/cltbld', 20:09:34 INFO - 'LANG': 'en_US.UTF-8', 20:09:34 INFO - 'LANGUAGE': 'en_US:en', 20:09:34 INFO - 'LOGNAME': 'cltbld', 20:09:34 INFO - 'MAIL': '/var/mail/cltbld', 20:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:34 INFO - 'MOZ_NO_REMOTE': '1', 20:09:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:34 INFO - 'NO_EM_RESTART': '1', 20:09:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:34 INFO - 'PWD': '/builds/slave/test', 20:09:34 INFO - 'SHELL': '/bin/bash', 20:09:34 INFO - 'SHLVL': '1', 20:09:34 INFO - 'TERM': 'linux', 20:09:34 INFO - 'TMOUT': '86400', 20:09:34 INFO - 'USER': 'cltbld', 20:09:34 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1480906069.544433-512934353', 20:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:34 INFO - '_': '/tools/buildbot/bin/python'} 20:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:34 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)) 20:09:34 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)) 20:09:34 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)) 20:09:34 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)) 20:09:34 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)) 20:09:34 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)) 20:09:34 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)) 20:09:34 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)) 20:09:34 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)) 20:09:34 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)) 20:09:34 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)) 20:09:34 INFO - Cleaning up... 20:09:35 INFO - Return code: 0 20:09:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:09: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')]} 20:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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')]} 20:09:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8c2719e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2043120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d3f20>, '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 0x2040c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2040f90>, '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': '7de08804244eb36560b44971000001c3-1480906069.544433-512934353', '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 20:09: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'] in /builds/slave/test/build 20:09: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 20:09:35 INFO - Using env: {'DISPLAY': ':0', 20:09:35 INFO - 'HOME': '/home/cltbld', 20:09:35 INFO - 'LANG': 'en_US.UTF-8', 20:09:35 INFO - 'LANGUAGE': 'en_US:en', 20:09:35 INFO - 'LOGNAME': 'cltbld', 20:09:35 INFO - 'MAIL': '/var/mail/cltbld', 20:09:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:35 INFO - 'MOZ_NO_REMOTE': '1', 20:09:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:35 INFO - 'NO_EM_RESTART': '1', 20:09:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:35 INFO - 'PWD': '/builds/slave/test', 20:09:35 INFO - 'SHELL': '/bin/bash', 20:09:35 INFO - 'SHLVL': '1', 20:09:35 INFO - 'TERM': 'linux', 20:09:35 INFO - 'TMOUT': '86400', 20:09:35 INFO - 'USER': 'cltbld', 20:09:35 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1480906069.544433-512934353', 20:09:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:35 INFO - '_': '/tools/buildbot/bin/python'} 20:09:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:09:35 INFO - Cleaning up... 20:09:35 INFO - Return code: 0 20:09:35 INFO - Running post-action listener: _resource_record_post_action 20:09:35 INFO - Running post-action listener: _start_resource_monitoring 20:09:35 INFO - Starting resource monitoring. 20:09:35 INFO - [mozharness: 2016-12-05 04:09:35.271385Z] Finished create-virtualenv step (success) 20:09:35 INFO - [mozharness: 2016-12-05 04:09:35.271850Z] Running install step. 20:09:35 INFO - Running pre-action listener: _resource_record_pre_action 20:09:35 INFO - Running main action method: install 20:09:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:09:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:09:35 INFO - Reading from file tmpfile_stdout 20:09:35 INFO - Detecting whether we're running mozinstall >=1.0... 20:09:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:09:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:09:35 INFO - Reading from file tmpfile_stdout 20:09:35 INFO - Output received: 20:09:35 INFO - Usage: mozinstall [options] installer 20:09:35 INFO - Options: 20:09:35 INFO - -h, --help show this help message and exit 20:09:35 INFO - -d DEST, --destination=DEST 20:09:35 INFO - Directory to install application into. [default: 20:09:35 INFO - "/builds/slave/test"] 20:09:35 INFO - --app=APP Application being installed. [default: firefox] 20:09:35 INFO - mkdir: /builds/slave/test/build/application 20:09:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:09:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:09:51 INFO - Reading from file tmpfile_stdout 20:09:51 INFO - Output received: 20:09:51 INFO - /builds/slave/test/build/application/firefox/firefox 20:09:51 INFO - Running post-action listener: _resource_record_post_action 20:09:51 INFO - [mozharness: 2016-12-05 04:09:51.620364Z] Finished install step (success) 20:09:51 INFO - [mozharness: 2016-12-05 04:09:51.620606Z] Running run-tests step. 20:09:51 INFO - Running pre-action listener: _resource_record_pre_action 20:09:51 INFO - Running main action method: run_tests 20:09:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:09:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:09:51 INFO - Python 2.7.3 20:09:51 INFO - Return code: 0 20:09:51 INFO - grabbing minidump binary from tooltool 20:09:51 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')]} 20:09:51 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 0x20d3f20>, '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 0x2040c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2040f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:09:51 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 20:09:51 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 20:09:51 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 20:09:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:09:51 INFO - Return code: 0 20:09:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:09:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:09:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:09:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:09:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:09:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TEzR31s_QyyQw1qCcLYHvg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 20:09:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TEzR31s_QyyQw1qCcLYHvg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 20:09:51 INFO - Using env: {'DISPLAY': ':0', 20:09:51 INFO - 'HOME': '/home/cltbld', 20:09:51 INFO - 'LANG': 'en_US.UTF-8', 20:09:51 INFO - 'LANGUAGE': 'en_US:en', 20:09:51 INFO - 'LOGNAME': 'cltbld', 20:09:51 INFO - 'MAIL': '/var/mail/cltbld', 20:09:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:09:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:09:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:51 INFO - 'MOZ_NO_REMOTE': '1', 20:09:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:09:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:51 INFO - 'NO_EM_RESTART': '1', 20:09:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:51 INFO - 'PWD': '/builds/slave/test', 20:09:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:09:51 INFO - 'SHELL': '/bin/bash', 20:09:51 INFO - 'SHLVL': '1', 20:09:51 INFO - 'TERM': 'linux', 20:09:51 INFO - 'TMOUT': '86400', 20:09:51 INFO - 'USER': 'cltbld', 20:09:51 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1480906069.544433-512934353', 20:09:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:51 INFO - '_': '/tools/buildbot/bin/python'} 20:09:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TEzR31s_QyyQw1qCcLYHvg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 20:09:51 INFO - mozversion application_buildid: 20161204191338 20:09:51 INFO - mozversion application_changeset: 52cc3c8b17c96e2a008fedaec7149427d1b31530 20:09:51 INFO - mozversion application_display_name: Nightly 20:09:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:09:51 INFO - mozversion application_name: Firefox 20:09:51 INFO - mozversion application_remotingname: firefox 20:09:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:09:51 INFO - mozversion application_vendor: Mozilla 20:09:51 INFO - mozversion application_version: 53.0a1 20:09:51 INFO - mozversion platform_buildid: 20161204191338 20:09:51 INFO - mozversion platform_changeset: 52cc3c8b17c96e2a008fedaec7149427d1b31530 20:09:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:09:51 INFO - mozversion platform_version: 53.0a1 20:09:51 INFO - using testdate: 1480910991 20:09:51 INFO - actual date: 1480910991 20:09:51 INFO - starting webserver on 'localhost:38229' 20:09:51 INFO - SUITE-START | Running 2 tests 20:09:51 INFO - TEST-START | dromaeo_css 20:09:51 INFO - operating with platform_type : linux_ 20:09:51 INFO - Initialising browser for dromaeo_css test... 20:09:51 INFO - TEST-INFO | started process 13676 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp06FB7m/profile http://localhost:38229/getInfo.html) 20:09:56 INFO - PROCESS | 13676 | __metrics Screen width/height:1600/1200 20:09:56 INFO - PROCESS | 13676 | colorDepth:24 20:09:56 INFO - PROCESS | 13676 | Browser inner width/height: 1024/697 20:09:56 INFO - PROCESS | 13676 | __metrics 20:09:57 INFO - PROCESS | 13676 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:09:57 INFO - PROCESS | 13676 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:09:58 INFO - TEST-INFO | 13676: exit 0 20:09:58 INFO - Browser initialized. 20:09:58 INFO - Running cycle 1/1 for dromaeo_css test... 20:09:58 INFO - TEST-INFO | started process 13758 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp06FB7m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:10:10 INFO - PROCESS | 13758 | RSS: Main: 173740032 20:10:10 INFO - PROCESS | 13758 | 20:11:02 INFO - PROCESS | 13758 | 1480911062027 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] 20:13:15 INFO - PROCESS | 13758 | Cycle 1(1): loaded http://localhost:38229/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38229/tests/dromaeo/cssquery-ext.html) 20:13:18 INFO - PROCESS | 13758 | RSS: Main: 446939136 20:13:18 INFO - PROCESS | 13758 | 20:16:21 INFO - PROCESS | 13758 | Cycle 1(1): loaded http://localhost:38229/tests/dromaeo/cssquery-ext.html (next: http://localhost:38229/tests/dromaeo/cssquery-jquery.html) 20:16:21 INFO - PROCESS | 13758 | RSS: Main: 290635776 20:16:21 INFO - PROCESS | 13758 | 20:19:24 INFO - PROCESS | 13758 | Cycle 1(1): loaded http://localhost:38229/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38229/tests/dromaeo/cssquery-mootools.html) 20:19:24 INFO - PROCESS | 13758 | RSS: Main: 221470720 20:19:24 INFO - PROCESS | 13758 | 20:22:27 INFO - PROCESS | 13758 | Cycle 1(1): loaded http://localhost:38229/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38229/tests/dromaeo/cssquery-prototype.html) 20:22:27 INFO - PROCESS | 13758 | RSS: Main: 221982720 20:22:27 INFO - PROCESS | 13758 | 20:25:31 INFO - PROCESS | 13758 | Cycle 1(1): loaded http://localhost:38229/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38229/tests/dromaeo/cssquery-yui.html) 20:25:31 INFO - PROCESS | 13758 | RSS: Main: 220205056 20:25:31 INFO - PROCESS | 13758 | 20:28:34 INFO - PROCESS | 13758 | Cycle 1(1): loaded http://localhost:38229/tests/dromaeo/cssquery-yui.html (next: http://localhost:38229/tests/dromaeo/cssquery-dojo.html) 20:28:35 INFO - PROCESS | 13758 | RSS: Main: 314503168 20:28:35 INFO - PROCESS | 13758 | 20:28:35 INFO - PROCESS | 13758 | __start_tp_report 20:28:35 INFO - PROCESS | 13758 | _x_x_mozilla_page_load 20:28:35 INFO - PROCESS | 13758 | _x_x_mozilla_page_load_details 20:28:35 INFO - PROCESS | 13758 | |i|pagename|runs| 20:28:35 INFO - PROCESS | 13758 | |0;dojo.html;2625.199314209166;2645.576707726764;2661.3745769744105;2679.102500662278;2689.045388886944;4594.77026148692;4649.558291962267;4690.835820746274;4697.694649847762;4722.456917454494;4678.345031695557;4713.080949214905;4728.385309909716;4772.236442169254;4801.5438533339275;4301.8064187111495;4314.762688052156;4354.433923589929;4385.166818304512;4455.933161002571;4040.975885915633;4354.825806967718;4406.53731358206;4428.6014258716705;4480.0367920897;4240.9151816963795;4266.0827921996915;4414.4702635683925;4460.8884777880485;4500.707454015478;4313.137372525476;4314.374415709736;4325.264705000158;4358.65130789536;4419.4254746883025;4318.071614602844;4334.32817913224;4339.132173565268;4341.565843415665;4377.102693947733;4694.155052090622;4712.976435117803;4745.240761478181;4745.264484004984;4771.737554434505;4940.580050695695;4984.950150498521;4989.700617962933;5028.296038554606;5061.772220250097;5099.15863882459;5113.897722045538;5114.232865070269;5121.923171152435;5150.742462876879;4771.71369717818;4774.498677638798;4775.355327030876;4781.474037855903;4819.879503012383;5058.519440653132;5094.745262736848;5112.897742045213;5218.086834803894;5279.604029697788;4909.926351104737;4931.852044438672;4944.826931057468;4962.702237865739;5012.498750124958;5034.84895453137;5037.571806396498;5038.571721403649;5041.571466425322;5088.592912566985;4819.831305904347;4953.8266160684925;4993.325901003391;4999.600031997432;5069.1635880079375;4863.416390033219;4916.385451818523;4922.040202160544;4922.680025798311;4923.064617722621;4247.277962746341;4248.660107191417;4249.320108782642;4266.4240327556;4300.806463709078;3750.437434384864;3790.507234059555;3791.374423220193;3806.06751345922;3814.179951310426;4409.603135717736;4410.911781764346;4418.160549495586;4453;4455.710378825366;4943.258511223274;5053.191489361684;5103.18349064148;5106.361704786902;5117.71852548106;4326.524082350938;4339.978300108479;4372.978135109368;4375.081232941055;4387.868363949086;4575.611073058761;4579.702319349231;4583.060472603109;4584.839530616412;4586.289125185602;4780.713157210578;4782.665213435096;4787.880302992453;4791.401074865642;4793.089313030652;5074.391073071255;5075;5077.898442031064;5081.618878584047;5084.542391184811;4822.083804077214;4832.468428472795;4841.05599408112;4843.685160464559;4843.733594652328;5032.04391165692;5032.421271553671;5037.042961837239;5041.571466425395;5041.747912604428;5041.42023667283;5043.773030213576;5046.873828154326;5103.92344114846;5105.668131571436;4945.406551213878;4945.455999839943;4945.629077819106;4947.529984651453;4986.850394488171;4814.374131362901;4845.53967373099;4847.781849816696;4910.21436570147;4979.302897594413;4836.46798852119;4849.563539281482;4850.975745121252;4852.684575502581;4857.271409288635;4856.150173719514;4946.703197808143;4963.181075122564;4964.652474326763;5003.899922001467;4918.852434426973;4922.581580565692;4926.556609905126;4956.826511072095;4973.229149481836 20:28:35 INFO - PROCESS | 13758 | |1;ext.html;538.9676619402836;563.9295088113986;573.4380307298848;575.3268675649495;585.408737175453;27196.456070878594;36698.26603467933;37715.43426848596;37767.81116094423;41449.378259326135;37337.25325493488;37600.24799504008;37630.811845940734;37761;37773.43339849898;7350.4854660173805;7479.364254038386;7503.587302698349;7513.962430187841;7517.586532740697;7098.574085554857;7296.562206267615;9380.343375963685;9618.134367906887;9636.95181524095;9578.473183974878;9642.13220810127;9660.468674222915;9665.90334096657;9680.467574283412;9541.236701063934;9585.520723963775;9603.087706667855;9606.423614583147;9609.327347085708;9533.094356036165;9595.712128636153;9599.952000240024;9606.66376676813;9608.039196080406;34916.127096822784;35084.473732894025;35178.12054698653;35293;35309;3073.754099672043;3098.0860646109227;3130.874765009397;3176.682331766828;3403.5745531808525;25989.74010259892;26391.604125938127;26493.47013059728;26693.065742699106;27564;3312.271300313927;3314.9171270718184;3323.5845519310087;3341.365140623274;3354.111160542458;257974;263353;264153;379763;380496.9999999972;49450.25824612634;49934;49990.75004624954;50013.74993125011;50094.74952625286;53852;54184;54213.728931355094;54224;54408.45591544113;13888.166709997433;14106.71786564263;14157.362918668685;14396.496122635657;14616.415343386358;10160.949195254125;10479.580816767397;11140.275882067639;11175.38535380562;11203.71990700239;16384.180790960403;16979.15104244783;17184.742228866577;17697.469075927744;17720.468385948443;6564.409203171737;6609.768658096944;6732.225794033651;6788.151481064867;6871.106756121672;799.5922079739374;871.6252011634931;889.973300800977;909.8953620333614;967.6371360739722;25363.365915851882;27106;29103.56344654832;30235.848820755757;30435;929.5770424456856;968.2496065549255;986.1469828598355;993.9254555908336;1002.2433063037361;13153.868461315456;13819.101758385672;14204.71590568183;14209;14240;378091;382328;383548;383986;383992;44215;44407;44719;44734.55265447369;44752;1076.5747529725716;1119.8992090711874;1141.2068612314363;1165.5745652836654;1210.7941649919535;25161.496770064132;27309.726902731512;27400.588991165547;27418;27665.446691066467;39542.40686389649;40100.19799603933;40109;40187.79906100451;40207.59792402039;301683;304819;306311;306311;307080;21396.823174724916;21929.451763705398;21934.367875855;21958.121675133454;23907.16324928619;38416.23167536578;38608.42087368636;38688;38786.80606596949;38818.61181388263;32815.671843282216;33328;33377;33683.494747579294;34693.102172630206;33440.33119337551;33479;33690.66309336973;33729.156771079935;34676.82661586676;33177.50233746544;33694.49458258177;33753.32493350168;33866.8306658475;33996.830015850755;28219.43561128725;30236.54645180368;30748;30837.074887753402;31060;22204.88897555502;24208.152714655607;24224.349031713977;24313.149039783522;24514.387140321636 20:28:35 INFO - PROCESS | 13758 | |2;jquery.html;341.224141608019;349.3693882542014;361.10446093687654;367.2709671302465;382.6059159066163;12875.871241287585;15492.612684682888;16172.676546469078;16618.75071873923;17530.561735956606;16190.676186476263;16316.592085197875;16317.83682163178;16666.500004999838;17037.91481042593;4794.304825800257;5014.147594908856;5065.544101030907;5323.148296272597;5361.303030606015;3324.7672662913606;3518.313928783888;5338.332708411449;5379.220013098098;5381.192821076831;5077.771500282496;5354.491323324298;5382.784688612451;5431.21247419124;5440.91838622421;5204.791808327663;5312.096943519611;5419.918701219485;5422.05114105032;5433.592480563934;5118.104331741967;5150.227465880111;5153.845384638467;5168.53483186515;5168.896622067575;11890.286582804973;11936.104792140537;12003.459844306939;12105;12126.757464850742;1736.5311365931127;1847.5658220318348;1877.6057028024131;1942.5435022769639;2021.5350469392122;9012.188902998696;9258.814823703555;10454.13029481785;11692.240004399688;12435.875641243652;1666.441742016426;1696.8472837444565;1697.4059079322262;1707.6584683063436;1764.0826770079616;64595.35404645988;64834.675826620565;65108;65686;69312.99999999949;9389.577469013911;9461.053894610484;9658.323917325719;9709.757256068513;9734.269929755297;12993.805092923614;13002.869971300166;13032.41354139066;13034.152780069266;13041.739165216643;6895.724171033103;6965.686544105527;7030.2969703029285;7079.82300442493;7098.3256590623805;6449.193850768654;6483.675816209265;6636.767713130017;6658.800235992928;6668.633225172565;3902.941455878164;4017.879463616096;4062.73592216505;4133.731307465066;4185.372194170899;1677.2117104960648;1746.1792957310045;1751.474557632705;1776.9822301777076;1780.8486278666458;802.6989878795451;849.1466076592984;852.0669866496177;907.5643691028343;912.6531917871166;15128.697426051418;15244.390224391122;15565.688686226213;15691.215439227994;15772.211389430482;828.7099515169642;842.309306368784;848.4569875279826;883.5460571880773;912.2018234045211;8420.326373890073;8503.404761666625;8913.598888050054;8961.372703910663;9120.315976301805;379384;397321;397817;398523;400445.9977700151;76758.61620691861;77261.2273877254;77499.83750243638;78261.21738782653;78913.60543197248;859.1108203009854;876.1545108969875;885.5793498088357;886.1537231943479;900.2482926756101;13846.861531384557;13906.652333691334;14182.43270269219;14188.787168192279;14712.04371715835;33758.662413375554;34496;35130;37185.814070929475;37944;48124;48477;48661;49132.26301605407;49545;7092.219855815959;7194.784156475314;7301.160366557914;7418.629068546443;7615.677218448205;9712.562934668098;11062.280951738112;11115;11297.491612877277;11504;9459.202751477198;9578.233741300819;9625.855612165684;9649.517524123907;10251.897481025393;9550.761230969281;9648.469334186688;9933.552990115317;10004.599816007278;10034.448105354275;9415.670451534163;9883.950580247052;9921;9953.303268771117;10019.54912028975;7364.5581265124265;7468.551886886804;7486.625668716433;7672;7761.883571746541;8891.955540222516;8982.416142950688;9563.139317461462;10199.847002294822;10361.585536578452 20:28:35 INFO - PROCESS | 13758 | |3;mootools.html;1233.2353940556857;1330.521012435523;1371.9451221951122;1428.9428422863086;1648.6620242850208;6322.747090116395;6743.595384276947;6945.027696122541;6953.165620125592;7082.681279342429;6924.965375173117;7002.369786719207;7009.334113259232;7010.929890701092;7014.333638304366;1757.7714897063363;1821.089455272364;1993.800619938009;2027.2803154880025;2030.6852437872153;2087.0712532922857;2151.1610471915965;2154.913803447868;2163.891805409723;2175.260411460103;2046.7748547659746;2064.8038436348597;2066.71066050753;2081.250749730096;2082.822960048398;2045.5499790046167;2061.6186005589016;2064.649009668345;2067.9276225332114;2068.162394230339;2044.6830741235133;2050.5283784729595;2052.1688716070016;2065.2048961149917;2066.380085974217;7193.64031798408;7354.669039893164;7358.705651773923;7359.227281135511;7361.116666000061;4294.892627684333;4434.578715022068;4437.733735975852;4440.1563702896665;4444.822207111712;2615.4246065865477;2780.110364683302;2827.9010234641687;2850.059480371493;2863.985680071586;780.6409051836106;808.3775492870457;820.2003047029099;849.02362283374;849.5964416901923;9652.22782177424;9684.934657187703;9719.951400242953;9725.173360264385;9742;4014.6788256939376;4033.2336855997855;4149.937750933738;4181.853635122756;4185.518665353462;8438.324934005264;8442.19799119095;8446.324294056461;8446.957765211257;8447.66209351619;4539.114872599877;4540.977295113504;4543.545645435496;4544.136614043321;4545.909081818411;3486.442169252907;3610.115521697201;3886.766793992313;4051.169510250392;4113.958860411418;3317.817520036373;3361.3277344531193;3479.6520347965507;3493.7729047611824;3525.823708814549;1156.2831044752306;1165.3182888010608;1165.3532289579364;1165.7843298989715;1170.4791367841228;782.9765107046798;784.8234147316808;793.920607939213;799.1209669363653;801.7514570483169;4644.9767751161025;4793.089313030513;4797.136515427256;4903.33804936329;5088.847334579968;402.6838931438865;403.824336413661;403.91517781266265;404.8218783735147;406.83116506649407;3240.7893486923276;3258.2668899497426;3259.5273685315497;3269.1173383186406;3383.3064221834466;8471.364647651451;8722.389432739774;8793.340499462565;8797.692080777142;8800;8753.649854005896;8757.518336491554;8761.34289928258;8768.561571921378;8809.295256379473;6761.154855643044;6812.557183783038;6826;6831.077804496329;6832.453403727591;4779.330893674819;4779.808807647655;4821.445533763662;4879.80480780779;4912.631552633496;7848.568328741974;7894.921050789419;7968.322692571196;8025.759227223192;8042.798930026796;8114.756557303054;8130.2682758549645;8212.507249564806;8300;8301.418900676894;5650.85872853182;6170.382961703974;6222.782202622887;6360.204974378203;6458.38645328693;6257.937420625735;6463.64449955257;6469.935300647122;6474.417302442803;6708.295628958889;6331.271903730945;6381.553291269566;6509.967450162719;6564.343565643398;6628.801135965929;6440.774572889926;6447.967760161357;6453.612783233021;6616.735330586916;6636.634985075867;5943.514121469632;6160.476359509492;6163.630182189083;6168.907466388097;6170.876582468415;4436.778161091868;4637.60580350674;4650.069986002745;4685.906281874275;4724.48030716614;4438.733675979452;4471.8658440246845;4488.304312831517;4621.376114224537;4666.743329116795 20:28:35 INFO - PROCESS | 13758 | |4;prototype.html;283.8041751191678;285.23841343612554;288.7704275101294;290.7731969064131;291.9591257223988;4759.452662943762;4786.186348320785;4801.615870730342;4804.639652026094;4810.783514741836;4689.929651055237;4703.623710103192;4732.90534189316;4733.952660473395;4741.407324084489;3497.1956450016446;3594.173340131771;3639.909002274938;3695.928180827557;3771.4908487354132;3718.345336325336;3722.702183825301;3736.4021756518828;3744.6068162842917;3745.5879853216125;3687.815609219542;3688.9077773055756;3700.4079347304437;3701.870434534792;3711.9443208351763;3498.1634641813;3620.475031120486;3646.3801153803915;3691.409374500094;3700.0759605005514;3245.172481017349;3250.756193285513;3257.1694217974264;3260.3209347186216;3264.657210992859;4581.4502259728715;4582.839600613996;4586.908261834745;4590.839320623795;4608.769561521944;4078.6940979426663;4201.516825565069;4217.662586993033;4218.8523401681105;4237.152569486084;4871.4154301483695;4907.656464047518;4913.852584422437;4930.753462326869;4972.17142800042;3560.6973407260157;3560.857565697369;3565.6612621800887;3570.785752854811;3579.158897659048;5056.418511871182;5130.486951304877;5146.202338637517;5175.3697585260525;5192.221166824968;3620.945685814715;3638.69071128957;3650.795237571595;3653.342398368266;3654.634536546324;3677.1358730698266;3688.819577735099;3690.9261814763554;3699.2231631357176;3705.444183372462;4172.311568591209;4172.645325147336;4194.119234960693;4195.72030530685;4210.45264115663;4849.199882019498;4891.070696567641;4903.436104847917;4997.700137991732;5010.423801262901;1237.1401875696486;1247.3887794980394;1248.5505218121468;1249.537671061713;1255.253124390986;797.4258533855615;822.8890997153794;856.3748463621591;863.4042510667745;872.6945569050908;4110.609492098306;4280.743155410685;4385.495667998157;4404.185225733249;4406.294992801137;5046.369203849519;5052.69683818972;5064.683182372536;5077.619178561623;5096.235564665256;4332.393464914914;4339.958409981582;4351.6301114405;4362.280223763107;4377.802998865059;2450.7868605040617;2582.715901250861;2591.8854892396075;2592.727763584834;2616.762667918902;4627.976860115745;4631.282151266559;4641.837535686234;4684.250519916797;4696.121551379407;4982.975085124551;4998.925016124761;5026.874328141826;5037.546620804145;5038.546530812245;4538.931916021263;4845.830395936126;4851.466338702739;4866.513348665105;4869.366982292279;5089.389273287229;5109.846704598868;5121.411037730709;5121.487851214849;5146.6911985281;4890.706557606555;5027.9748601258225;5043.722595257296;5051.4695956924;5054.924176137288;4810.374651295309;4855.514448555116;4856.320115183948;4857.927131092966;4863.610911127031;3562.59030211529;3571.607123216496;3593.2274560969518;3603.585587657453;3625.1662117712544;5066.164082926423;5071.644984851025;5091.9490805092955;5114.846554603368;5158.38099428056;4787.880302992453;4926.926096108489;4943.283223932582;4949.7030178189425;4950.603951683928;4946.169917130685;4955.925661115159;4968.378952630921;4971.975140124277;4975.97992411562;4884.291777692144;4885.511448855086;4888.364512613338;4896.363472748662;4913.287573301923;4787.880302992314;4837.879053023703;4844.951550484591;4876.341693871282;4947.18371468718;4862.246351815475;4869.269609558594;4873.658843880894;4878.390201224847;4901.803927842846 20:28:35 INFO - PROCESS | 13758 | |5;yui.html;603.7403916315982;615.375393975115;635.9904601430978;699.5802518488907;727.6034561164166;12914.74170516589;13707.725845483084;13719;13731.519396821088;13749.10630808998;12761.106722529426;12824.525179604349;12839.1012629116;12907.612771616867;12912.806307905388;599.3616798110021;623.834683808791;717.3579646216633;744.2743325257884;748.4611080022376;762.1920763990161;764.7552783109379;765.081901717938;765.2577000309718;765.6439755513685;820.3560205238889;821.6672247739646;822.1737154160061;822.2394285286116;822.313368337439;639.8144538083974;656.5404217048085;658.9670516474205;660.379243511098;815.7511958852548;480.5290815001283;570.1931766550326;586.2027642406324;588.3028611095822;589.4783116941495;13389.129706569041;13408.592097829685;13450.192988420726;13454;13456.730865382735;12806.29565373904;12838.101332906701;12936.741265174738;13134.540291089766;13341.866581334256;11016.394098324668;11318.20772545922;11319.264247823947;11647.59233426826;11660.76678466426;4095.1809638072505;4134.669226461876;4178.143480586503;4287.721298115644;4300.505441874162;62858;65675.3432465674;66461.66769166171;66609;66744;9886.752831179134;9929.453880036668;9993.850092248622;10011.349262297927;10088.394696318097;18612.813871861108;18806.247750090115;18926.62146757057;18968.52578685544;19260.614787704166;6623.4701223901975;6687.799366019027;6842.726290948406;6852.5203235774015;6864.7940561783225;3456.4296891013205;3540.6459354064905;3551.4140166872176;3646.5441819772527;3650.233450975272;2701.378682902904;2783.498970185386;2881.8270903745843;2900.318425170083;2930.4725149473297;465.7182404645209;469.4108893338838;470.6540692590943;472.5085910652951;483.2799129297322;540.7863893761942;547.8657728856376;561.6012631032013;566.3628418029716;566.6704642834152;7262.600556969312;7373.188949215582;7557.659905304275;7776;7810.804729881798;506.2558039681662;513.6301862658954;517.1054076447691;530.9734513274398;552.0559842669081;3608.1881576645046;3653.926921461556;3735.7758534488016;3802.239552089593;3840.807959602009;68508;69694.65152674305;70590.29409705837;72301;72303.6384818083;57937.71031144902;62742;62916;62976.37023629797;63079;56874;57515.424845751004;57714.7114264426;58108;58752.11871821926;6910.343517365842;7099.609521476368;7205.747798827016;7257.564546127249;7387.482876198615;38577.61422385852;38824;39636;40358.79820600878;41268.79365603153;47140;48012;51030.74484627702;51645.48354516407;53198.73400632972;9286.62853485853;9353.485558294358;9432.528373581155;9455.527223638928;9947.154491868272;10354.5340459678;10585.153187745116;10591.099756520782;10628.66988147455;10705.19711021661;9327;9355;9649.807003860024;9796.363236389612;10019.799604007732;8997.730068097968;9172.082791720775;9419.395917067897;9439.52802359893;9465.716028519155;9380.67167649129;9434.374317536809;9490.098440648128;9495.762605934908;9507.239420846177;7777.183395743592;8288.58557072156;8312.958435207785;8511.787205319917;8605;7731.265529774662;8038.598070096355;8151.79620509492;8174.468659537111;8252.252970731357 20:28:35 INFO - PROCESS | 13758 | __end_tp_report 20:28:35 INFO - PROCESS | 13758 | __start_cc_report 20:28:35 INFO - PROCESS | 13758 | _x_x_mozilla_cycle_collect,3250 20:28:35 INFO - PROCESS | 13758 | __end_cc_report 20:28:35 INFO - PROCESS | 13758 | __startTimestamp1480912115039__endTimestamp 20:28:35 INFO - PROCESS | 13758 | 20:28:35 INFO - PROCESS | 13758 | ------- Summary: start ------- 20:28:35 INFO - PROCESS | 13758 | Number of tests: 6 20:28:35 INFO - PROCESS | 13758 | 20:28:35 INFO - PROCESS | 13758 | [#0] dojo.html Cycles:165 Average:4678.05 Median:4822.08 stddev:481.86 (10.0%) stddev-sans-first:455.64 20:28:35 INFO - PROCESS | 13758 | Values: 2625.2 2645.6 2661.4 2679.1 2689.0 4594.8 4649.6 4690.8 4697.7 4722.5 4678.3 4713.1 4728.4 4772.2 4801.5 4301.8 4314.8 4354.4 4385.2 4455.9 4041.0 4354.8 4406.5 4428.6 4480.0 4240.9 4266.1 4414.5 4460.9 4500.7 4313.1 4314.4 4325.3 4358.7 4419.4 4318.1 4334.3 4339.1 4341.6 4377.1 4694.2 4713.0 4745.2 4745.3 4771.7 4940.6 4985.0 4989.7 5028.3 5061.8 5099.2 5113.9 5114.2 5121.9 5150.7 4771.7 4774.5 4775.4 4781.5 4819.9 5058.5 5094.7 5112.9 5218.1 5279.6 4909.9 4931.9 4944.8 4962.7 5012.5 5034.8 5037.6 5038.6 5041.6 5088.6 4819.8 4953.8 4993.3 4999.6 5069.2 4863.4 4916.4 4922.0 4922.7 4923.1 4247.3 4248.7 4249.3 4266.4 4300.8 3750.4 3790.5 3791.4 3806.1 3814.2 4409.6 4410.9 4418.2 4453.0 4455.7 4943.3 5053.2 5103.2 5106.4 5117.7 4326.5 4340.0 4373.0 4375.1 4387.9 4575.6 4579.7 4583.1 4584.8 4586.3 4780.7 4782.7 4787.9 4791.4 4793.1 5074.4 5075.0 5077.9 5081.6 5084.5 4822.1 4832.5 4841.1 4843.7 4843.7 5032.0 5032.4 5037.0 5041.6 5041.7 5041.4 5043.8 5046.9 5103.9 5105.7 4945.4 4945.5 4945.6 4947.5 4986.9 4814.4 4845.5 4847.8 4910.2 4979.3 4836.5 4849.6 4851.0 4852.7 4857.3 4856.2 4946.7 4963.2 4964.7 5003.9 4918.9 4922.6 4926.6 4956.8 4973.2 20:28:35 INFO - PROCESS | 13758 | 20:28:35 INFO - PROCESS | 13758 | [#1] ext.html Cycles:180 Average:47511.54 Median:35000.30 stddev:88515.14 (252.9%) stddev-sans-first:88693.19 20:28:35 INFO - PROCESS | 13758 | Values: 539.0 563.9 573.4 575.3 585.4 27196.5 36698.3 37715.4 37767.8 41449.4 37337.3 37600.2 37630.8 37761.0 37773.4 7350.5 7479.4 7503.6 7514.0 7517.6 7098.6 7296.6 9380.3 9618.1 9637.0 9578.5 9642.1 9660.5 9665.9 9680.5 9541.2 9585.5 9603.1 9606.4 9609.3 9533.1 9595.7 9600.0 9606.7 9608.0 34916.1 35084.5 35178.1 35293.0 35309.0 3073.8 3098.1 3130.9 3176.7 3403.6 25989.7 26391.6 26493.5 26693.1 27564.0 3312.3 3314.9 3323.6 3341.4 3354.1 257974.0 263353.0 264153.0 379763.0 380497.0 49450.3 49934.0 49990.8 50013.7 50094.7 53852.0 54184.0 54213.7 54224.0 54408.5 13888.2 14106.7 14157.4 14396.5 14616.4 10160.9 10479.6 11140.3 11175.4 11203.7 16384.2 16979.2 17184.7 17697.5 17720.5 6564.4 6609.8 6732.2 6788.2 6871.1 799.6 871.6 890.0 909.9 967.6 25363.4 27106.0 29103.6 30235.8 30435.0 929.6 968.2 986.1 993.9 1002.2 13153.9 13819.1 14204.7 14209.0 14240.0 378091.0 382328.0 383548.0 383986.0 383992.0 44215.0 44407.0 44719.0 44734.6 44752.0 1076.6 1119.9 1141.2 1165.6 1210.8 25161.5 27309.7 27400.6 27418.0 27665.4 39542.4 40100.2 40109.0 40187.8 40207.6 301683.0 304819.0 306311.0 306311.0 307080.0 21396.8 21929.5 21934.4 21958.1 23907.2 38416.2 38608.4 38688.0 38786.8 38818.6 32815.7 33328.0 33377.0 33683.5 34693.1 33440.3 33479.0 33690.7 33729.2 34676.8 33177.5 33694.5 33753.3 33866.8 33996.8 28219.4 30236.5 30748.0 30837.1 31060.0 22204.9 24208.2 24224.3 24313.1 24514.4 20:28:35 INFO - PROCESS | 13758 | 20:28:35 INFO - PROCESS | 13758 | [#2] jquery.html Cycles:180 Average:23750.40 Median:5152.04 stddev:65162.44 (1264.8%) stddev-sans-first:65321.53 20:28:35 INFO - PROCESS | 13758 | Values: 341.2 349.4 361.1 367.3 382.6 12875.9 15492.6 16172.7 16618.8 17530.6 16190.7 16316.6 16317.8 16666.5 17037.9 4794.3 5014.1 5065.5 5323.1 5361.3 3324.8 3518.3 5338.3 5379.2 5381.2 5077.8 5354.5 5382.8 5431.2 5440.9 5204.8 5312.1 5419.9 5422.1 5433.6 5118.1 5150.2 5153.8 5168.5 5168.9 11890.3 11936.1 12003.5 12105.0 12126.8 1736.5 1847.6 1877.6 1942.5 2021.5 9012.2 9258.8 10454.1 11692.2 12435.9 1666.4 1696.8 1697.4 1707.7 1764.1 64595.4 64834.7 65108.0 65686.0 69313.0 9389.6 9461.1 9658.3 9709.8 9734.3 12993.8 13002.9 13032.4 13034.2 13041.7 6895.7 6965.7 7030.3 7079.8 7098.3 6449.2 6483.7 6636.8 6658.8 6668.6 3902.9 4017.9 4062.7 4133.7 4185.4 1677.2 1746.2 1751.5 1777.0 1780.8 802.7 849.1 852.1 907.6 912.7 15128.7 15244.4 15565.7 15691.2 15772.2 828.7 842.3 848.5 883.5 912.2 8420.3 8503.4 8913.6 8961.4 9120.3 379384.0 397321.0 397817.0 398523.0 400446.0 76758.6 77261.2 77499.8 78261.2 78913.6 859.1 876.2 885.6 886.2 900.2 13846.9 13906.7 14182.4 14188.8 14712.0 33758.7 34496.0 35130.0 37185.8 37944.0 48124.0 48477.0 48661.0 49132.3 49545.0 7092.2 7194.8 7301.2 7418.6 7615.7 9712.6 11062.3 11115.0 11297.5 11504.0 9459.2 9578.2 9625.9 9649.5 10251.9 9550.8 9648.5 9933.6 10004.6 10034.4 9415.7 9884.0 9921.0 9953.3 10019.5 7364.6 7468.6 7486.6 7672.0 7761.9 8892.0 8982.4 9563.1 10199.8 10361.6 20:28:35 INFO - PROCESS | 13758 | 20:28:35 INFO - PROCESS | 13758 | [#3] mootools.html Cycles:180 Average:4766.81 Median:4850.63 stddev:2619.24 (54.0%) stddev-sans-first:2613.13 20:28:35 INFO - PROCESS | 13758 | Values: 1233.2 1330.5 1371.9 1428.9 1648.7 6322.7 6743.6 6945.0 6953.2 7082.7 6925.0 7002.4 7009.3 7010.9 7014.3 1757.8 1821.1 1993.8 2027.3 2030.7 2087.1 2151.2 2154.9 2163.9 2175.3 2046.8 2064.8 2066.7 2081.3 2082.8 2045.5 2061.6 2064.6 2067.9 2068.2 2044.7 2050.5 2052.2 2065.2 2066.4 7193.6 7354.7 7358.7 7359.2 7361.1 4294.9 4434.6 4437.7 4440.2 4444.8 2615.4 2780.1 2827.9 2850.1 2864.0 780.6 808.4 820.2 849.0 849.6 9652.2 9684.9 9720.0 9725.2 9742.0 4014.7 4033.2 4149.9 4181.9 4185.5 8438.3 8442.2 8446.3 8447.0 8447.7 4539.1 4541.0 4543.5 4544.1 4545.9 3486.4 3610.1 3886.8 4051.2 4114.0 3317.8 3361.3 3479.7 3493.8 3525.8 1156.3 1165.3 1165.4 1165.8 1170.5 783.0 784.8 793.9 799.1 801.8 4645.0 4793.1 4797.1 4903.3 5088.8 402.7 403.8 403.9 404.8 406.8 3240.8 3258.3 3259.5 3269.1 3383.3 8471.4 8722.4 8793.3 8797.7 8800.0 8753.6 8757.5 8761.3 8768.6 8809.3 6761.2 6812.6 6826.0 6831.1 6832.5 4779.3 4779.8 4821.4 4879.8 4912.6 7848.6 7894.9 7968.3 8025.8 8042.8 8114.8 8130.3 8212.5 8300.0 8301.4 5650.9 6170.4 6222.8 6360.2 6458.4 6257.9 6463.6 6469.9 6474.4 6708.3 6331.3 6381.6 6510.0 6564.3 6628.8 6440.8 6448.0 6453.6 6616.7 6636.6 5943.5 6160.5 6163.6 6168.9 6170.9 4436.8 4637.6 4650.1 4685.9 4724.5 4438.7 4471.9 4488.3 4621.4 4666.7 20:28:35 INFO - PROCESS | 13758 | 20:28:35 INFO - PROCESS | 13758 | [#4] prototype.html Cycles:180 Average:4101.72 Median:4693.03 stddev:1192.97 (25.4%) stddev-sans-first:1161.39 20:28:35 INFO - PROCESS | 13758 | Values: 283.8 285.2 288.8 290.8 292.0 4759.5 4786.2 4801.6 4804.6 4810.8 4689.9 4703.6 4732.9 4734.0 4741.4 3497.2 3594.2 3639.9 3695.9 3771.5 3718.3 3722.7 3736.4 3744.6 3745.6 3687.8 3688.9 3700.4 3701.9 3711.9 3498.2 3620.5 3646.4 3691.4 3700.1 3245.2 3250.8 3257.2 3260.3 3264.7 4581.5 4582.8 4586.9 4590.8 4608.8 4078.7 4201.5 4217.7 4218.9 4237.2 4871.4 4907.7 4913.9 4930.8 4972.2 3560.7 3560.9 3565.7 3570.8 3579.2 5056.4 5130.5 5146.2 5175.4 5192.2 3620.9 3638.7 3650.8 3653.3 3654.6 3677.1 3688.8 3690.9 3699.2 3705.4 4172.3 4172.6 4194.1 4195.7 4210.5 4849.2 4891.1 4903.4 4997.7 5010.4 1237.1 1247.4 1248.6 1249.5 1255.3 797.4 822.9 856.4 863.4 872.7 4110.6 4280.7 4385.5 4404.2 4406.3 5046.4 5052.7 5064.7 5077.6 5096.2 4332.4 4340.0 4351.6 4362.3 4377.8 2450.8 2582.7 2591.9 2592.7 2616.8 4628.0 4631.3 4641.8 4684.3 4696.1 4983.0 4998.9 5026.9 5037.5 5038.5 4538.9 4845.8 4851.5 4866.5 4869.4 5089.4 5109.8 5121.4 5121.5 5146.7 4890.7 5028.0 5043.7 5051.5 5054.9 4810.4 4855.5 4856.3 4857.9 4863.6 3562.6 3571.6 3593.2 3603.6 3625.2 5066.2 5071.6 5091.9 5114.8 5158.4 4787.9 4926.9 4943.3 4949.7 4950.6 4946.2 4955.9 4968.4 4972.0 4976.0 4884.3 4885.5 4888.4 4896.4 4913.3 4787.9 4837.9 4845.0 4876.3 4947.2 4862.2 4869.3 4873.7 4878.4 4901.8 20:28:35 INFO - PROCESS | 13758 | 20:28:35 INFO - PROCESS | 13758 | [#5] yui.html Cycles:180 Average:15154.27 Median:29669.16 stddev:20078.06 (67.7%) stddev-sans-first:20104.65 20:28:35 INFO - PROCESS | 13758 | Values: 603.7 615.4 636.0 699.6 727.6 12914.7 13707.7 13719.0 13731.5 13749.1 12761.1 12824.5 12839.1 12907.6 12912.8 599.4 623.8 717.4 744.3 748.5 762.2 764.8 765.1 765.3 765.6 820.4 821.7 822.2 822.2 822.3 639.8 656.5 659.0 660.4 815.8 480.5 570.2 586.2 588.3 589.5 13389.1 13408.6 13450.2 13454.0 13456.7 12806.3 12838.1 12936.7 13134.5 13341.9 11016.4 11318.2 11319.3 11647.6 11660.8 4095.2 4134.7 4178.1 4287.7 4300.5 62858.0 65675.3 66461.7 66609.0 66744.0 9886.8 9929.5 9993.9 10011.3 10088.4 18612.8 18806.2 18926.6 18968.5 19260.6 6623.5 6687.8 6842.7 6852.5 6864.8 3456.4 3540.6 3551.4 3646.5 3650.2 2701.4 2783.5 2881.8 2900.3 2930.5 465.7 469.4 470.7 472.5 483.3 540.8 547.9 561.6 566.4 566.7 7262.6 7373.2 7557.7 7776.0 7810.8 506.3 513.6 517.1 531.0 552.1 3608.2 3653.9 3735.8 3802.2 3840.8 68508.0 69694.7 70590.3 72301.0 72303.6 57937.7 62742.0 62916.0 62976.4 63079.0 56874.0 57515.4 57714.7 58108.0 58752.1 6910.3 7099.6 7205.7 7257.6 7387.5 38577.6 38824.0 39636.0 40358.8 41268.8 47140.0 48012.0 51030.7 51645.5 53198.7 9286.6 9353.5 9432.5 9455.5 9947.2 10354.5 10585.2 10591.1 10628.7 10705.2 9327.0 9355.0 9649.8 9796.4 10019.8 8997.7 9172.1 9419.4 9439.5 9465.7 9380.7 9434.4 9490.1 9495.8 9507.2 7777.2 8288.6 8313.0 8511.8 8605.0 7731.3 8038.6 8151.8 8174.5 8252.3 20:28:35 INFO - PROCESS | 13758 | -------- Summary: end -------- 20:28:35 INFO - PROCESS | 13758 | 20:28:35 INFO - TEST-INFO | 13758: exit 0 20:28:35 INFO - TEST-OK | dromaeo_css | took 1124063ms 20:28:35 INFO - TEST-START | kraken 20:28:35 INFO - operating with platform_type : linux_ 20:28:35 INFO - Initialising browser for kraken test... 20:28:35 INFO - TEST-INFO | started process 14066 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2aTWRR/profile http://localhost:38229/getInfo.html) 20:28:40 INFO - PROCESS | 14066 | __metrics Screen width/height:1600/1200 20:28:40 INFO - PROCESS | 14066 | colorDepth:24 20:28:40 INFO - PROCESS | 14066 | Browser inner width/height: 1024/697 20:28:40 INFO - PROCESS | 14066 | __metrics 20:28:41 INFO - PROCESS | 14066 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:28:41 INFO - PROCESS | 14066 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:28:41 INFO - PROCESS | 14066 | console.error: PushService: 20:28:41 INFO - PROCESS | 14066 | stateChangeProcessEnqueue: Error transitioning state 20:28:41 INFO - PROCESS | 14066 | UnknownError 20:28:42 INFO - TEST-INFO | 14066: exit 0 20:28:42 INFO - Browser initialized. 20:28:42 INFO - Running cycle 1/1 for kraken test... 20:28:42 INFO - TEST-INFO | started process 14148 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2aTWRR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:28:54 INFO - PROCESS | 14148 | RSS: Main: 173522944 20:28:54 INFO - PROCESS | 14148 | 20:28:57 INFO - PROCESS | 14148 | Cycle 1(1): loaded http://localhost:38229/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38229/tests/kraken/driver.html?testName=audio-beat-detection) 20:28:58 INFO - PROCESS | 14148 | RSS: Main: 235671552 20:28:58 INFO - PROCESS | 14148 | 20:29:01 INFO - PROCESS | 14148 | Cycle 1(1): loaded http://localhost:38229/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38229/tests/kraken/driver.html?testName=audio-dft) 20:29:02 INFO - PROCESS | 14148 | RSS: Main: 217612288 20:29:02 INFO - PROCESS | 14148 | 20:29:05 INFO - PROCESS | 14148 | Cycle 1(1): loaded http://localhost:38229/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38229/tests/kraken/driver.html?testName=audio-fft) 20:29:05 INFO - PROCESS | 14148 | RSS: Main: 300273664 20:29:05 INFO - PROCESS | 14148 | 20:29:07 INFO - PROCESS | 14148 | Cycle 1(1): loaded http://localhost:38229/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38229/tests/kraken/driver.html?testName=audio-oscillator) 20:29:08 INFO - PROCESS | 14148 | RSS: Main: 211456000 20:29:08 INFO - PROCESS | 14148 | 20:29:10 INFO - PROCESS | 14148 | Cycle 1(1): loaded http://localhost:38229/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38229/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:29:11 INFO - PROCESS | 14148 | RSS: Main: 214573056 20:29:11 INFO - PROCESS | 14148 | 20:29:14 INFO - PROCESS | 14148 | Cycle 1(1): loaded http://localhost:38229/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38229/tests/kraken/driver.html?testName=imaging-darkroom) 20:29:15 INFO - PROCESS | 14148 | RSS: Main: 254091264 20:29:15 INFO - PROCESS | 14148 | 20:29:18 INFO - PROCESS | 14148 | Cycle 1(1): loaded http://localhost:38229/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38229/tests/kraken/driver.html?testName=imaging-desaturate) 20:29:19 INFO - PROCESS | 14148 | RSS: Main: 247578624 20:29:19 INFO - PROCESS | 14148 | 20:29:22 INFO - PROCESS | 14148 | Cycle 1(1): loaded http://localhost:38229/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38229/tests/kraken/driver.html?testName=json-parse-financial) 20:29:22 INFO - PROCESS | 14148 | RSS: Main: 249815040 20:29:22 INFO - PROCESS | 14148 | 20:29:24 INFO - PROCESS | 14148 | Cycle 1(1): loaded http://localhost:38229/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38229/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:29:25 INFO - PROCESS | 14148 | RSS: Main: 213385216 20:29:25 INFO - PROCESS | 14148 | 20:29:27 INFO - PROCESS | 14148 | Cycle 1(1): loaded http://localhost:38229/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38229/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:29:27 INFO - PROCESS | 14148 | RSS: Main: 220770304 20:29:27 INFO - PROCESS | 14148 | 20:29:29 INFO - PROCESS | 14148 | Cycle 1(1): loaded http://localhost:38229/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38229/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:29:30 INFO - PROCESS | 14148 | RSS: Main: 229883904 20:29:30 INFO - PROCESS | 14148 | 20:29:33 INFO - PROCESS | 14148 | Cycle 1(1): loaded http://localhost:38229/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:29:34 INFO - PROCESS | 14148 | RSS: Main: 237432832 20:29:34 INFO - PROCESS | 14148 | 20:29:37 INFO - PROCESS | 14148 | Cycle 1(1): loaded http://localhost:38229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:29:37 INFO - PROCESS | 14148 | RSS: Main: 234401792 20:29:37 INFO - PROCESS | 14148 | 20:29:39 INFO - PROCESS | 14148 | Cycle 1(1): loaded http://localhost:38229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38229/tests/kraken/driver.html?testName=ai-astar) 20:29:39 INFO - PROCESS | 14148 | RSS: Main: 284069888 20:29:39 INFO - PROCESS | 14148 | 20:29:39 INFO - PROCESS | 14148 | __start_tp_report 20:29:39 INFO - PROCESS | 14148 | _x_x_mozilla_page_load 20:29:39 INFO - PROCESS | 14148 | _x_x_mozilla_page_load_details 20:29:39 INFO - PROCESS | 14148 | |i|pagename|runs| 20:29:39 INFO - PROCESS | 14148 | |0;ai-astar;108;115;114;118;115;115;114;115;114;115 20:29:39 INFO - PROCESS | 14148 | |1;audio-beat-detection;166;140;130;175;131;131;130;130;161;128 20:29:39 INFO - PROCESS | 14148 | |2;audio-dft;161;161;166;163;161;162;161;161;159;161 20:29:39 INFO - PROCESS | 14148 | |3;audio-fft;76;77;76;116;80;78;77;77;91;76 20:29:39 INFO - PROCESS | 14148 | |4;audio-oscillator;83;83;105;84;84;84;104;84;84;106 20:29:39 INFO - PROCESS | 14148 | |5;imaging-gaussian-blur;117;118;117;117;117;116;118;117;118;117 20:29:39 INFO - PROCESS | 14148 | |6;imaging-darkroom;146;146;148;154;146;147;148;155;147;146 20:29:39 INFO - PROCESS | 14148 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;96;95 20:29:39 INFO - PROCESS | 14148 | |8;json-parse-financial;67;65;65;64;67;65;73;66;66;65 20:29:39 INFO - PROCESS | 14148 | |9;json-stringify-tinderbox;65;73;65;66;66;66;67;67;67;66 20:29:39 INFO - PROCESS | 14148 | |10;stanford-crypto-aes;85;84;84;86;86;91;85;85;84;86 20:29:39 INFO - PROCESS | 14148 | |11;stanford-crypto-ccm;148;151;145;140;144;155;142;146;200;157 20:29:39 INFO - PROCESS | 14148 | |12;stanford-crypto-pbkdf2;185;185;184;184;182;186;180;179;183;184 20:29:39 INFO - PROCESS | 14148 | |13;stanford-crypto-sha256-iterative;71;71;72;72;71;74;75;71;74;70 20:29:39 INFO - PROCESS | 14148 | __end_tp_report 20:29:39 INFO - PROCESS | 14148 | __start_cc_report 20:29:39 INFO - PROCESS | 14148 | _x_x_mozilla_cycle_collect,1979 20:29:39 INFO - PROCESS | 14148 | __end_cc_report 20:29:39 INFO - PROCESS | 14148 | __startTimestamp1480912179897__endTimestamp 20:29:39 INFO - PROCESS | 14148 | 20:29:39 INFO - PROCESS | 14148 | ------- Summary: start ------- 20:29:39 INFO - PROCESS | 14148 | Number of tests: 14 20:29:39 INFO - PROCESS | 14148 | 20:29:39 INFO - PROCESS | 14148 | [#0] ai-astar Cycles:10 Average:114.30 Median:115.00 stddev:2.50 (2.2%) stddev-sans-first:1.22 20:29:39 INFO - PROCESS | 14148 | Values: 108.0 115.0 114.0 118.0 115.0 115.0 114.0 115.0 114.0 115.0 20:29:39 INFO - PROCESS | 14148 | 20:29:39 INFO - PROCESS | 14148 | [#1] audio-beat-detection Cycles:10 Average:142.20 Median:135.50 stddev:17.95 (13.2%) stddev-sans-first:16.85 20:29:39 INFO - PROCESS | 14148 | Values: 166.0 140.0 130.0 175.0 131.0 131.0 130.0 130.0 161.0 128.0 20:29:39 INFO - PROCESS | 14148 | 20:29:39 INFO - PROCESS | 14148 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.00 stddev:1.84 (1.1%) stddev-sans-first:1.94 20:29:39 INFO - PROCESS | 14148 | Values: 161.0 161.0 166.0 163.0 161.0 162.0 161.0 161.0 159.0 161.0 20:29:39 INFO - PROCESS | 14148 | 20:29:39 INFO - PROCESS | 14148 | [#3] audio-fft Cycles:10 Average:82.40 Median:77.00 stddev:12.64 (16.4%) stddev-sans-first:13.20 20:29:39 INFO - PROCESS | 14148 | Values: 76.0 77.0 76.0 116.0 80.0 78.0 77.0 77.0 91.0 76.0 20:29:39 INFO - PROCESS | 14148 | 20:29:39 INFO - PROCESS | 14148 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:84.00 stddev:10.30 (12.3%) stddev-sans-first:10.60 20:29:39 INFO - PROCESS | 14148 | Values: 83.0 83.0 105.0 84.0 84.0 84.0 104.0 84.0 84.0 106.0 20:29:39 INFO - PROCESS | 14148 | 20:29:39 INFO - PROCESS | 14148 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 20:29:39 INFO - PROCESS | 14148 | Values: 117.0 118.0 117.0 117.0 117.0 116.0 118.0 117.0 118.0 117.0 20:29:39 INFO - PROCESS | 14148 | 20:29:39 INFO - PROCESS | 14148 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:147.50 stddev:3.37 (2.3%) stddev-sans-first:3.47 20:29:39 INFO - PROCESS | 14148 | Values: 146.0 146.0 148.0 154.0 146.0 147.0 148.0 155.0 147.0 146.0 20:29:39 INFO - PROCESS | 14148 | 20:29:39 INFO - PROCESS | 14148 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 20:29:39 INFO - PROCESS | 14148 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 20:29:39 INFO - PROCESS | 14148 | 20:29:39 INFO - PROCESS | 14148 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:66.00 stddev:2.54 (3.8%) stddev-sans-first:2.68 20:29:39 INFO - PROCESS | 14148 | Values: 67.0 65.0 65.0 64.0 67.0 65.0 73.0 66.0 66.0 65.0 20:29:39 INFO - PROCESS | 14148 | 20:29:39 INFO - PROCESS | 14148 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:66.50 stddev:2.30 (3.5%) stddev-sans-first:2.35 20:29:39 INFO - PROCESS | 14148 | Values: 65.0 73.0 65.0 66.0 66.0 66.0 67.0 67.0 67.0 66.0 20:29:39 INFO - PROCESS | 14148 | 20:29:39 INFO - PROCESS | 14148 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:85.50 stddev:2.07 (2.4%) stddev-sans-first:2.18 20:29:39 INFO - PROCESS | 14148 | Values: 85.0 84.0 84.0 86.0 86.0 91.0 85.0 85.0 84.0 86.0 20:29:39 INFO - PROCESS | 14148 | 20:29:39 INFO - PROCESS | 14148 | [#11] stanford-crypto-ccm Cycles:10 Average:152.80 Median:149.50 stddev:17.45 (11.7%) stddev-sans-first:18.43 20:29:39 INFO - PROCESS | 14148 | Values: 148.0 151.0 145.0 140.0 144.0 155.0 142.0 146.0 200.0 157.0 20:29:39 INFO - PROCESS | 14148 | 20:29:39 INFO - PROCESS | 14148 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.20 Median:184.00 stddev:2.25 (1.2%) stddev-sans-first:2.29 20:29:39 INFO - PROCESS | 14148 | Values: 185.0 185.0 184.0 184.0 182.0 186.0 180.0 179.0 183.0 184.0 20:29:39 INFO - PROCESS | 14148 | 20:29:39 INFO - PROCESS | 14148 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:72.00 stddev:1.66 (2.3%) stddev-sans-first:1.72 20:29:39 INFO - PROCESS | 14148 | Values: 71.0 71.0 72.0 72.0 71.0 74.0 75.0 71.0 74.0 70.0 20:29:39 INFO - PROCESS | 14148 | -------- Summary: end -------- 20:29:39 INFO - PROCESS | 14148 | 20:29:41 INFO - TEST-INFO | 14148: exit 0 20:29:41 INFO - TEST-OK | kraken | took 65314ms 20:29:41 INFO - SUITE-END | took 1189s 20:29:41 INFO - Completed test suite (00:19:49) 20:29:41 INFO - javascript benchmark 20:29:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2625.199314209166, 2645.576707726764, 2661.3745769744105, 2679.102500662278, 2689.045388886944, 4594.77026148692, 4649.558291962267, 4690.835820746274, 4697.694649847762, 4722.456917454494, 4678.345031695557, 4713.080949214905, 4728.385309909716, 4772.236442169254, 4801.5438533339275, 4301.8064187111495, 4314.762688052156, 4354.433923589929, 4385.166818304512, 4455.933161002571, 4040.975885915633, 4354.825806967718, 4406.53731358206, 4428.6014258716705, 4480.0367920897, 4240.9151816963795, 4266.0827921996915, 4414.4702635683925, 4460.8884777880485, 4500.707454015478, 4313.137372525476, 4314.374415709736, 4325.264705000158, 4358.65130789536, 4419.4254746883025, 4318.071614602844, 4334.32817913224, 4339.132173565268, 4341.565843415665, 4377.102693947733, 4694.155052090622, 4712.976435117803, 4745.240761478181, 4745.264484004984, 4771.737554434505, 4940.580050695695, 4984.950150498521, 4989.700617962933, 5028.296038554606, 5061.772220250097, 5099.15863882459, 5113.897722045538, 5114.232865070269, 5121.923171152435, 5150.742462876879, 4771.71369717818, 4774.498677638798, 4775.355327030876, 4781.474037855903, 4819.879503012383, 5058.519440653132, 5094.745262736848, 5112.897742045213, 5218.086834803894, 5279.604029697788, 4909.926351104737, 4931.852044438672, 4944.826931057468, 4962.702237865739, 5012.498750124958, 5034.84895453137, 5037.571806396498, 5038.571721403649, 5041.571466425322, 5088.592912566985, 4819.831305904347, 4953.8266160684925, 4993.325901003391, 4999.600031997432, 5069.1635880079375, 4863.416390033219, 4916.385451818523, 4922.040202160544, 4922.680025798311, 4923.064617722621, 4247.277962746341, 4248.660107191417, 4249.320108782642, 4266.4240327556, 4300.806463709078, 3750.437434384864, 3790.507234059555, 3791.374423220193, 3806.06751345922, 3814.179951310426, 4409.603135717736, 4410.911781764346, 4418.160549495586, 4453.0, 4455.710378825366, 4943.258511223274, 5053.191489361684, 5103.18349064148, 5106.361704786902, 5117.71852548106, 4326.524082350938, 4339.978300108479, 4372.978135109368, 4375.081232941055, 4387.868363949086, 4575.611073058761, 4579.702319349231, 4583.060472603109, 4584.839530616412, 4586.289125185602, 4780.713157210578, 4782.665213435096, 4787.880302992453, 4791.401074865642, 4793.089313030652, 5074.391073071255, 5075.0, 5077.898442031064, 5081.618878584047, 5084.542391184811, 4822.083804077214, 4832.468428472795, 4841.05599408112, 4843.685160464559, 4843.733594652328, 5032.04391165692, 5032.421271553671, 5037.042961837239, 5041.571466425395, 5041.747912604428, 5041.42023667283, 5043.773030213576, 5046.873828154326, 5103.92344114846, 5105.668131571436, 4945.406551213878, 4945.455999839943, 4945.629077819106, 4947.529984651453, 4986.850394488171, 4814.374131362901, 4845.53967373099, 4847.781849816696, 4910.21436570147, 4979.302897594413, 4836.46798852119, 4849.563539281482, 4850.975745121252, 4852.684575502581, 4857.271409288635, 4856.150173719514, 4946.703197808143, 4963.181075122564, 4964.652474326763, 5003.899922001467, 4918.852434426973, 4922.581580565692, 4926.556609905126, 4956.826511072095, 4973.229149481836], "value": 4647.81518582645, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.9676619402836, 563.9295088113986, 573.4380307298848, 575.3268675649495, 585.408737175453, 27196.456070878594, 36698.26603467933, 37715.43426848596, 37767.81116094423, 41449.378259326135, 37337.25325493488, 37600.24799504008, 37630.811845940734, 37761.0, 37773.43339849898, 7350.4854660173805, 7479.364254038386, 7503.587302698349, 7513.962430187841, 7517.586532740697, 7098.574085554857, 7296.562206267615, 9380.343375963685, 9618.134367906887, 9636.95181524095, 9578.473183974878, 9642.13220810127, 9660.468674222915, 9665.90334096657, 9680.467574283412, 9541.236701063934, 9585.520723963775, 9603.087706667855, 9606.423614583147, 9609.327347085708, 9533.094356036165, 9595.712128636153, 9599.952000240024, 9606.66376676813, 9608.039196080406, 34916.127096822784, 35084.473732894025, 35178.12054698653, 35293.0, 35309.0, 3073.754099672043, 3098.0860646109227, 3130.874765009397, 3176.682331766828, 3403.5745531808525, 25989.74010259892, 26391.604125938127, 26493.47013059728, 26693.065742699106, 27564.0, 3312.271300313927, 3314.9171270718184, 3323.5845519310087, 3341.365140623274, 3354.111160542458, 257974.0, 263353.0, 264153.0, 379763.0, 380496.9999999972, 49450.25824612634, 49934.0, 49990.75004624954, 50013.74993125011, 50094.74952625286, 53852.0, 54184.0, 54213.728931355094, 54224.0, 54408.45591544113, 13888.166709997433, 14106.71786564263, 14157.362918668685, 14396.496122635657, 14616.415343386358, 10160.949195254125, 10479.580816767397, 11140.275882067639, 11175.38535380562, 11203.71990700239, 16384.180790960403, 16979.15104244783, 17184.742228866577, 17697.469075927744, 17720.468385948443, 6564.409203171737, 6609.768658096944, 6732.225794033651, 6788.151481064867, 6871.106756121672, 799.5922079739374, 871.6252011634931, 889.973300800977, 909.8953620333614, 967.6371360739722, 25363.365915851882, 27106.0, 29103.56344654832, 30235.848820755757, 30435.0, 929.5770424456856, 968.2496065549255, 986.1469828598355, 993.9254555908336, 1002.2433063037361, 13153.868461315456, 13819.101758385672, 14204.71590568183, 14209.0, 14240.0, 378091.0, 382328.0, 383548.0, 383986.0, 383992.0, 44215.0, 44407.0, 44719.0, 44734.55265447369, 44752.0, 1076.5747529725716, 1119.8992090711874, 1141.2068612314363, 1165.5745652836654, 1210.7941649919535, 25161.496770064132, 27309.726902731512, 27400.588991165547, 27418.0, 27665.446691066467, 39542.40686389649, 40100.19799603933, 40109.0, 40187.79906100451, 40207.59792402039, 301683.0, 304819.0, 306311.0, 306311.0, 307080.0, 21396.823174724916, 21929.451763705398, 21934.367875855, 21958.121675133454, 23907.16324928619, 38416.23167536578, 38608.42087368636, 38688.0, 38786.80606596949, 38818.61181388263, 32815.671843282216, 33328.0, 33377.0, 33683.494747579294, 34693.102172630206, 33440.33119337551, 33479.0, 33690.66309336973, 33729.156771079935, 34676.82661586676, 33177.50233746544, 33694.49458258177, 33753.32493350168, 33866.8306658475, 33996.830015850755, 28219.43561128725, 30236.54645180368, 30748.0, 30837.074887753402, 31060.0, 22204.88897555502, 24208.152714655607, 24224.349031713977, 24313.149039783522, 24514.387140321636], "value": 17258.965456112423, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.224141608019, 349.3693882542014, 361.10446093687654, 367.2709671302465, 382.6059159066163, 12875.871241287585, 15492.612684682888, 16172.676546469078, 16618.75071873923, 17530.561735956606, 16190.676186476263, 16316.592085197875, 16317.83682163178, 16666.500004999838, 17037.91481042593, 4794.304825800257, 5014.147594908856, 5065.544101030907, 5323.148296272597, 5361.303030606015, 3324.7672662913606, 3518.313928783888, 5338.332708411449, 5379.220013098098, 5381.192821076831, 5077.771500282496, 5354.491323324298, 5382.784688612451, 5431.21247419124, 5440.91838622421, 5204.791808327663, 5312.096943519611, 5419.918701219485, 5422.05114105032, 5433.592480563934, 5118.104331741967, 5150.227465880111, 5153.845384638467, 5168.53483186515, 5168.896622067575, 11890.286582804973, 11936.104792140537, 12003.459844306939, 12105.0, 12126.757464850742, 1736.5311365931127, 1847.5658220318348, 1877.6057028024131, 1942.5435022769639, 2021.5350469392122, 9012.188902998696, 9258.814823703555, 10454.13029481785, 11692.240004399688, 12435.875641243652, 1666.441742016426, 1696.8472837444565, 1697.4059079322262, 1707.6584683063436, 1764.0826770079616, 64595.35404645988, 64834.675826620565, 65108.0, 65686.0, 69312.99999999949, 9389.577469013911, 9461.053894610484, 9658.323917325719, 9709.757256068513, 9734.269929755297, 12993.805092923614, 13002.869971300166, 13032.41354139066, 13034.152780069266, 13041.739165216643, 6895.724171033103, 6965.686544105527, 7030.2969703029285, 7079.82300442493, 7098.3256590623805, 6449.193850768654, 6483.675816209265, 6636.767713130017, 6658.800235992928, 6668.633225172565, 3902.941455878164, 4017.879463616096, 4062.73592216505, 4133.731307465066, 4185.372194170899, 1677.2117104960648, 1746.1792957310045, 1751.474557632705, 1776.9822301777076, 1780.8486278666458, 802.6989878795451, 849.1466076592984, 852.0669866496177, 907.5643691028343, 912.6531917871166, 15128.697426051418, 15244.390224391122, 15565.688686226213, 15691.215439227994, 15772.211389430482, 828.7099515169642, 842.309306368784, 848.4569875279826, 883.5460571880773, 912.2018234045211, 8420.326373890073, 8503.404761666625, 8913.598888050054, 8961.372703910663, 9120.315976301805, 379384.0, 397321.0, 397817.0, 398523.0, 400445.9977700151, 76758.61620691861, 77261.2273877254, 77499.83750243638, 78261.21738782653, 78913.60543197248, 859.1108203009854, 876.1545108969875, 885.5793498088357, 886.1537231943479, 900.2482926756101, 13846.861531384557, 13906.652333691334, 14182.43270269219, 14188.787168192279, 14712.04371715835, 33758.662413375554, 34496.0, 35130.0, 37185.814070929475, 37944.0, 48124.0, 48477.0, 48661.0, 49132.26301605407, 49545.0, 7092.219855815959, 7194.784156475314, 7301.160366557914, 7418.629068546443, 7615.677218448205, 9712.562934668098, 11062.280951738112, 11115.0, 11297.491612877277, 11504.0, 9459.202751477198, 9578.233741300819, 9625.855612165684, 9649.517524123907, 10251.897481025393, 9550.761230969281, 9648.469334186688, 9933.552990115317, 10004.599816007278, 10034.448105354275, 9415.670451534163, 9883.950580247052, 9921.0, 9953.303268771117, 10019.54912028975, 7364.5581265124265, 7468.551886886804, 7486.625668716433, 7672.0, 7761.883571746541, 8891.955540222516, 8982.416142950688, 9563.139317461462, 10199.847002294822, 10361.585536578452], "value": 7803.280074164165, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1233.2353940556857, 1330.521012435523, 1371.9451221951122, 1428.9428422863086, 1648.6620242850208, 6322.747090116395, 6743.595384276947, 6945.027696122541, 6953.165620125592, 7082.681279342429, 6924.965375173117, 7002.369786719207, 7009.334113259232, 7010.929890701092, 7014.333638304366, 1757.7714897063363, 1821.089455272364, 1993.800619938009, 2027.2803154880025, 2030.6852437872153, 2087.0712532922857, 2151.1610471915965, 2154.913803447868, 2163.891805409723, 2175.260411460103, 2046.7748547659746, 2064.8038436348597, 2066.71066050753, 2081.250749730096, 2082.822960048398, 2045.5499790046167, 2061.6186005589016, 2064.649009668345, 2067.9276225332114, 2068.162394230339, 2044.6830741235133, 2050.5283784729595, 2052.1688716070016, 2065.2048961149917, 2066.380085974217, 7193.64031798408, 7354.669039893164, 7358.705651773923, 7359.227281135511, 7361.116666000061, 4294.892627684333, 4434.578715022068, 4437.733735975852, 4440.1563702896665, 4444.822207111712, 2615.4246065865477, 2780.110364683302, 2827.9010234641687, 2850.059480371493, 2863.985680071586, 780.6409051836106, 808.3775492870457, 820.2003047029099, 849.02362283374, 849.5964416901923, 9652.22782177424, 9684.934657187703, 9719.951400242953, 9725.173360264385, 9742.0, 4014.6788256939376, 4033.2336855997855, 4149.937750933738, 4181.853635122756, 4185.518665353462, 8438.324934005264, 8442.19799119095, 8446.324294056461, 8446.957765211257, 8447.66209351619, 4539.114872599877, 4540.977295113504, 4543.545645435496, 4544.136614043321, 4545.909081818411, 3486.442169252907, 3610.115521697201, 3886.766793992313, 4051.169510250392, 4113.958860411418, 3317.817520036373, 3361.3277344531193, 3479.6520347965507, 3493.7729047611824, 3525.823708814549, 1156.2831044752306, 1165.3182888010608, 1165.3532289579364, 1165.7843298989715, 1170.4791367841228, 782.9765107046798, 784.8234147316808, 793.920607939213, 799.1209669363653, 801.7514570483169, 4644.9767751161025, 4793.089313030513, 4797.136515427256, 4903.33804936329, 5088.847334579968, 402.6838931438865, 403.824336413661, 403.91517781266265, 404.8218783735147, 406.83116506649407, 3240.7893486923276, 3258.2668899497426, 3259.5273685315497, 3269.1173383186406, 3383.3064221834466, 8471.364647651451, 8722.389432739774, 8793.340499462565, 8797.692080777142, 8800.0, 8753.649854005896, 8757.518336491554, 8761.34289928258, 8768.561571921378, 8809.295256379473, 6761.154855643044, 6812.557183783038, 6826.0, 6831.077804496329, 6832.453403727591, 4779.330893674819, 4779.808807647655, 4821.445533763662, 4879.80480780779, 4912.631552633496, 7848.568328741974, 7894.921050789419, 7968.322692571196, 8025.759227223192, 8042.798930026796, 8114.756557303054, 8130.2682758549645, 8212.507249564806, 8300.0, 8301.418900676894, 5650.85872853182, 6170.382961703974, 6222.782202622887, 6360.204974378203, 6458.38645328693, 6257.937420625735, 6463.64449955257, 6469.935300647122, 6474.417302442803, 6708.295628958889, 6331.271903730945, 6381.553291269566, 6509.967450162719, 6564.343565643398, 6628.801135965929, 6440.774572889926, 6447.967760161357, 6453.612783233021, 6616.735330586916, 6636.634985075867, 5943.514121469632, 6160.476359509492, 6163.630182189083, 6168.907466388097, 6170.876582468415, 4436.778161091868, 4637.60580350674, 4650.069986002745, 4685.906281874275, 4724.48030716614, 4438.733675979452, 4471.8658440246845, 4488.304312831517, 4621.376114224537, 4666.743329116795], "value": 3803.238239850427, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.8041751191678, 285.23841343612554, 288.7704275101294, 290.7731969064131, 291.9591257223988, 4759.452662943762, 4786.186348320785, 4801.615870730342, 4804.639652026094, 4810.783514741836, 4689.929651055237, 4703.623710103192, 4732.90534189316, 4733.952660473395, 4741.407324084489, 3497.1956450016446, 3594.173340131771, 3639.909002274938, 3695.928180827557, 3771.4908487354132, 3718.345336325336, 3722.702183825301, 3736.4021756518828, 3744.6068162842917, 3745.5879853216125, 3687.815609219542, 3688.9077773055756, 3700.4079347304437, 3701.870434534792, 3711.9443208351763, 3498.1634641813, 3620.475031120486, 3646.3801153803915, 3691.409374500094, 3700.0759605005514, 3245.172481017349, 3250.756193285513, 3257.1694217974264, 3260.3209347186216, 3264.657210992859, 4581.4502259728715, 4582.839600613996, 4586.908261834745, 4590.839320623795, 4608.769561521944, 4078.6940979426663, 4201.516825565069, 4217.662586993033, 4218.8523401681105, 4237.152569486084, 4871.4154301483695, 4907.656464047518, 4913.852584422437, 4930.753462326869, 4972.17142800042, 3560.6973407260157, 3560.857565697369, 3565.6612621800887, 3570.785752854811, 3579.158897659048, 5056.418511871182, 5130.486951304877, 5146.202338637517, 5175.3697585260525, 5192.221166824968, 3620.945685814715, 3638.69071128957, 3650.795237571595, 3653.342398368266, 3654.634536546324, 3677.1358730698266, 3688.819577735099, 3690.9261814763554, 3699.2231631357176, 3705.444183372462, 4172.311568591209, 4172.645325147336, 4194.119234960693, 4195.72030530685, 4210.45264115663, 4849.199882019498, 4891.070696567641, 4903.436104847917, 4997.700137991732, 5010.423801262901, 1237.1401875696486, 1247.3887794980394, 1248.5505218121468, 1249.537671061713, 1255.253124390986, 797.4258533855615, 822.8890997153794, 856.3748463621591, 863.4042510667745, 872.6945569050908, 4110.609492098306, 4280.743155410685, 4385.495667998157, 4404.185225733249, 4406.294992801137, 5046.369203849519, 5052.69683818972, 5064.683182372536, 5077.619178561623, 5096.235564665256, 4332.393464914914, 4339.958409981582, 4351.6301114405, 4362.280223763107, 4377.802998865059, 2450.7868605040617, 2582.715901250861, 2591.8854892396075, 2592.727763584834, 2616.762667918902, 4627.976860115745, 4631.282151266559, 4641.837535686234, 4684.250519916797, 4696.121551379407, 4982.975085124551, 4998.925016124761, 5026.874328141826, 5037.546620804145, 5038.546530812245, 4538.931916021263, 4845.830395936126, 4851.466338702739, 4866.513348665105, 4869.366982292279, 5089.389273287229, 5109.846704598868, 5121.411037730709, 5121.487851214849, 5146.6911985281, 4890.706557606555, 5027.9748601258225, 5043.722595257296, 5051.4695956924, 5054.924176137288, 4810.374651295309, 4855.514448555116, 4856.320115183948, 4857.927131092966, 4863.610911127031, 3562.59030211529, 3571.607123216496, 3593.2274560969518, 3603.585587657453, 3625.1662117712544, 5066.164082926423, 5071.644984851025, 5091.9490805092955, 5114.846554603368, 5158.38099428056, 4787.880302992453, 4926.926096108489, 4943.283223932582, 4949.7030178189425, 4950.603951683928, 4946.169917130685, 4955.925661115159, 4968.378952630921, 4971.975140124277, 4975.97992411562, 4884.291777692144, 4885.511448855086, 4888.364512613338, 4896.363472748662, 4913.287573301923, 4787.880302992314, 4837.879053023703, 4844.951550484591, 4876.341693871282, 4947.18371468718, 4862.246351815475, 4869.269609558594, 4873.658843880894, 4878.390201224847, 4901.803927842846], "value": 3720.310984283573, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.7403916315982, 615.375393975115, 635.9904601430978, 699.5802518488907, 727.6034561164166, 12914.74170516589, 13707.725845483084, 13719.0, 13731.519396821088, 13749.10630808998, 12761.106722529426, 12824.525179604349, 12839.1012629116, 12907.612771616867, 12912.806307905388, 599.3616798110021, 623.834683808791, 717.3579646216633, 744.2743325257884, 748.4611080022376, 762.1920763990161, 764.7552783109379, 765.081901717938, 765.2577000309718, 765.6439755513685, 820.3560205238889, 821.6672247739646, 822.1737154160061, 822.2394285286116, 822.313368337439, 639.8144538083974, 656.5404217048085, 658.9670516474205, 660.379243511098, 815.7511958852548, 480.5290815001283, 570.1931766550326, 586.2027642406324, 588.3028611095822, 589.4783116941495, 13389.129706569041, 13408.592097829685, 13450.192988420726, 13454.0, 13456.730865382735, 12806.29565373904, 12838.101332906701, 12936.741265174738, 13134.540291089766, 13341.866581334256, 11016.394098324668, 11318.20772545922, 11319.264247823947, 11647.59233426826, 11660.76678466426, 4095.1809638072505, 4134.669226461876, 4178.143480586503, 4287.721298115644, 4300.505441874162, 62858.0, 65675.3432465674, 66461.66769166171, 66609.0, 66744.0, 9886.752831179134, 9929.453880036668, 9993.850092248622, 10011.349262297927, 10088.394696318097, 18612.813871861108, 18806.247750090115, 18926.62146757057, 18968.52578685544, 19260.614787704166, 6623.4701223901975, 6687.799366019027, 6842.726290948406, 6852.5203235774015, 6864.7940561783225, 3456.4296891013205, 3540.6459354064905, 3551.4140166872176, 3646.5441819772527, 3650.233450975272, 2701.378682902904, 2783.498970185386, 2881.8270903745843, 2900.318425170083, 2930.4725149473297, 465.7182404645209, 469.4108893338838, 470.6540692590943, 472.5085910652951, 483.2799129297322, 540.7863893761942, 547.8657728856376, 561.6012631032013, 566.3628418029716, 566.6704642834152, 7262.600556969312, 7373.188949215582, 7557.659905304275, 7776.0, 7810.804729881798, 506.2558039681662, 513.6301862658954, 517.1054076447691, 530.9734513274398, 552.0559842669081, 3608.1881576645046, 3653.926921461556, 3735.7758534488016, 3802.239552089593, 3840.807959602009, 68508.0, 69694.65152674305, 70590.29409705837, 72301.0, 72303.6384818083, 57937.71031144902, 62742.0, 62916.0, 62976.37023629797, 63079.0, 56874.0, 57515.424845751004, 57714.7114264426, 58108.0, 58752.11871821926, 6910.343517365842, 7099.609521476368, 7205.747798827016, 7257.564546127249, 7387.482876198615, 38577.61422385852, 38824.0, 39636.0, 40358.79820600878, 41268.79365603153, 47140.0, 48012.0, 51030.74484627702, 51645.48354516407, 53198.73400632972, 9286.62853485853, 9353.485558294358, 9432.528373581155, 9455.527223638928, 9947.154491868272, 10354.5340459678, 10585.153187745116, 10591.099756520782, 10628.66988147455, 10705.19711021661, 9327.0, 9355.0, 9649.807003860024, 9796.363236389612, 10019.799604007732, 8997.730068097968, 9172.082791720775, 9419.395917067897, 9439.52802359893, 9465.716028519155, 9380.67167649129, 9434.374317536809, 9490.098440648128, 9495.762605934908, 9507.239420846177, 7777.183395743592, 8288.58557072156, 8312.958435207785, 8511.787205319917, 8605.0, 7731.265529774662, 8038.598070096355, 8151.79620509492, 8174.468659537111, 8252.252970731357], "value": 6010.50993034779, "unit": "score"}], "name": "dromaeo_css", "value": 6133.470020737094, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 115.0, 114.0, 118.0, 115.0, 115.0, 114.0, 115.0, 114.0, 115.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 140.0, 130.0, 175.0, 131.0, 131.0, 130.0, 130.0, 161.0, 128.0], "value": 142.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 166.0, 163.0, 161.0, 162.0, 161.0, 161.0, 159.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 116.0, 80.0, 78.0, 77.0, 77.0, 91.0, 76.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 105.0, 84.0, 84.0, 84.0, 104.0, 84.0, 84.0, 106.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 116.0, 118.0, 117.0, 118.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 148.0, 154.0, 146.0, 147.0, 148.0, 155.0, 147.0, 146.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 65.0, 64.0, 67.0, 65.0, 73.0, 66.0, 66.0, 65.0], "value": 66.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 65.0, 66.0, 66.0, 66.0, 67.0, 67.0, 67.0, 66.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 86.0, 86.0, 91.0, 85.0, 85.0, 84.0, 86.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 151.0, 145.0, 140.0, 144.0, 155.0, 142.0, 146.0, 200.0, 157.0], "value": 152.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 184.0, 184.0, 182.0, 186.0, 180.0, 179.0, 183.0, 184.0], "value": 183.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 72.0, 72.0, 71.0, 74.0, 75.0, 71.0, 74.0, 70.0], "value": 72.1, "unit": "score"}], "name": "kraken", "value": 1578.0, "alertThreshold": 2.0}]} 20:29:41 INFO - Return code: 0 20:29:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:29:41 INFO - # TBPL SUCCESS # 20:29:41 INFO - Running post-action listener: _resource_record_post_action 20:29:41 INFO - [mozharness: 2016-12-05 04:29:41.715856Z] Finished run-tests step (success) 20:29:41 INFO - Running post-run listener: _resource_record_post_run 20:29:41 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 4096; Write bytes: 390144000; Read time: 24; Write time: 337880 20:29:41 INFO - TinderboxPrint: CPU usage
13.0% 20:29:41 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 24 20:29:41 INFO - TinderboxPrint: I/O write bytes / time
390,144,000 / 337,880 20:29:41 INFO - TinderboxPrint: CPU idle
8,365.2 (86.9%) 20:29:41 INFO - TinderboxPrint: CPU user
1,207.0 (12.5%) 20:29:41 INFO - TinderboxPrint: Swap in / out
0 / 0 20:29:41 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99713024; Read time: 0; Write time: 101160 20:29:41 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 290430976; Read time: 0; Write time: 236720 20:29:42 INFO - Running post-run listener: _upload_blobber_files 20:29:42 INFO - Blob upload gear active. 20:29:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:29:42 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 20:29:42 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:29:42 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:29:42 INFO - (blobuploader) - INFO - Open directory for files ... 20:29:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:29:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:29:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:43 INFO - (blobuploader) - INFO - Done attempting. 20:29:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:29:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:29:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:44 INFO - (blobuploader) - INFO - Done attempting. 20:29:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:29:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:29:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:47 INFO - (blobuploader) - INFO - Done attempting. 20:29:47 INFO - (blobuploader) - INFO - Iteration through files over. 20:29:47 INFO - Return code: 0 20:29:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:29:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:29:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a19e5e46805a9d9b837de20004f093325c9bf6d5ca1a1e2a50655938ea71a36c5508b203ee70e6d6f8d4fc12dc5de5dd844e8b3234b684da2353530832358996", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b656a539a950a9cfca938580513d55be85b392cbfe25c11f244b78f3465721b18ce1b92106764c604a5d3f75c5e343109161699827d5ea768a825f6085075bba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ea290a0ccfa11f83b8e757d4dbe6e03868d1dd8b72e72669e1d5dbe744200896f8d92a0ac18ef6c01f2fd75f2af0f173d78e8e6026679015e4f1fd93e1f57b0"} 20:29:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:29:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:29:47 INFO - Contents: 20:29:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a19e5e46805a9d9b837de20004f093325c9bf6d5ca1a1e2a50655938ea71a36c5508b203ee70e6d6f8d4fc12dc5de5dd844e8b3234b684da2353530832358996", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b656a539a950a9cfca938580513d55be85b392cbfe25c11f244b78f3465721b18ce1b92106764c604a5d3f75c5e343109161699827d5ea768a825f6085075bba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ea290a0ccfa11f83b8e757d4dbe6e03868d1dd8b72e72669e1d5dbe744200896f8d92a0ac18ef6c01f2fd75f2af0f173d78e8e6026679015e4f1fd93e1f57b0"} 20:29:47 INFO - Running post-run listener: copy_logs_to_upload_dir 20:29:47 INFO - Copying logs to upload dir... 20:29:47 INFO - mkdir: /builds/slave/test/build/upload/logs 20:29:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.690949 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-12-04 20:29:46.969012) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-04 20:29:46.973039) ========= 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=7de08804244eb36560b44971000001c3-1480906069.544433-512934353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a19e5e46805a9d9b837de20004f093325c9bf6d5ca1a1e2a50655938ea71a36c5508b203ee70e6d6f8d4fc12dc5de5dd844e8b3234b684da2353530832358996", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b656a539a950a9cfca938580513d55be85b392cbfe25c11f244b78f3465721b18ce1b92106764c604a5d3f75c5e343109161699827d5ea768a825f6085075bba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ea290a0ccfa11f83b8e757d4dbe6e03868d1dd8b72e72669e1d5dbe744200896f8d92a0ac18ef6c01f2fd75f2af0f173d78e8e6026679015e4f1fd93e1f57b0"} build_url:https://queue.taskcluster.net/v1/task/TEzR31s_QyyQw1qCcLYHvg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011288 build_url: 'https://queue.taskcluster.net/v1/task/TEzR31s_QyyQw1qCcLYHvg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a19e5e46805a9d9b837de20004f093325c9bf6d5ca1a1e2a50655938ea71a36c5508b203ee70e6d6f8d4fc12dc5de5dd844e8b3234b684da2353530832358996", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b656a539a950a9cfca938580513d55be85b392cbfe25c11f244b78f3465721b18ce1b92106764c604a5d3f75c5e343109161699827d5ea768a825f6085075bba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ea290a0ccfa11f83b8e757d4dbe6e03868d1dd8b72e72669e1d5dbe744200896f8d92a0ac18ef6c01f2fd75f2af0f173d78e8e6026679015e4f1fd93e1f57b0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-04 20:29:47.000660) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 20:29:47.001176) ========= 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=7de08804244eb36560b44971000001c3-1480906069.544433-512934353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 20:29:47.084151) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-04 20:29:47.084475) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-04 20:29:47.084817) ========= ========= Total master_lag: 0.18 =========