builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-059 starttime: 1475754766.37 results: success (0) buildid: 20161006020300 builduid: 602648876c57478489985221c16fb201 revision: d7d42cef7968f3bf0539ffd631cbe8cca88665b6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 04:52:46.367260) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 04:52:46.367866) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 04:52:46.368246) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 04:52:46.383556) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 04:52:46.383909) ========= 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=3a3620fb28aea1604ab609ef000001d2-1475754767.597148-992004852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-06 04:52:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.0M=0s 2016-10-06 04:52:48 (38.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099225 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 04:52:46.497422) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 04:52:46.497791) ========= 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=3a3620fb28aea1604ab609ef000001d2-1475754767.597148-992004852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019743 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 04:52:46.547480) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 04:52:46.547849) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d7d42cef7968f3bf0539ffd631cbe8cca88665b6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d7d42cef7968f3bf0539ffd631cbe8cca88665b6 --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=3a3620fb28aea1604ab609ef000001d2-1475754767.597148-992004852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-06 04:52:48,607 truncating revision to first 12 chars 2016-10-06 04:52:48,607 Setting DEBUG logging. 2016-10-06 04:52:48,607 attempt 1/10 2016-10-06 04:52:48,607 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d7d42cef7968?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 04:52:49,354 unpacking tar archive at: mozilla-aurora-d7d42cef7968/testing/mozharness/ program finished with exit code 0 elapsedTime=1.080267 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 04:52:47.641728) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 04:52:47.642092) ========= script_repo_revision: d7d42cef7968f3bf0539ffd631cbe8cca88665b6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 04:52:47.642562) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 04:52:47.642882) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 04:52:47.653615) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-10-06 04:52:47.653933) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=3a3620fb28aea1604ab609ef000001d2-1475754767.597148-992004852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:52:49 INFO - MultiFileLogger online at 20161006 04:52:49 in /builds/slave/test 04:52:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 04:52:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:52:49 INFO - {'append_to_log': False, 04:52:49 INFO - 'base_work_dir': '/builds/slave/test', 04:52:49 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:52:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:52:49 INFO - 'branch': 'Mozilla-Aurora', 04:52:49 INFO - 'buildbot_json_path': 'buildprops.json', 04:52:49 INFO - 'config_files': ('talos/linux_config.py',), 04:52:49 INFO - 'default_actions': ('clobber', 04:52:49 INFO - 'read-buildbot-config', 04:52:49 INFO - 'download-and-extract', 04:52:49 INFO - 'populate-webroot', 04:52:49 INFO - 'create-virtualenv', 04:52:49 INFO - 'install', 04:52:49 INFO - 'run-tests'), 04:52:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:52:49 INFO - 'download_minidump_stackwalk': True, 04:52:49 INFO - 'download_symbols': 'ondemand', 04:52:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:52:49 INFO - 'tooltool.py': '/tools/tooltool.py', 04:52:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:52:49 INFO - '/tools/misc-python/virtualenv.py')}, 04:52:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:52:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:52:49 INFO - 'installer_path': 'installer.exe', 04:52:49 INFO - 'log_level': 'info', 04:52:49 INFO - 'log_name': 'talos', 04:52:49 INFO - 'log_to_console': True, 04:52:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:52:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:52:49 INFO - 'opt_config_files': (), 04:52:49 INFO - 'pip_index': False, 04:52:49 INFO - 'sps_profile': False, 04:52:49 INFO - 'sps_profile_interval': 0, 04:52:49 INFO - 'suite': 'dromaeojs', 04:52:49 INFO - 'system_bits': '32', 04:52:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:52:49 INFO - 'title': 'talos-linux64-ix-059', 04:52:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:52:49 INFO - 'use_talos_json': True, 04:52:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:52:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:52:49 INFO - 'work_dir': 'build'} 04:52:49 INFO - [mozharness: 2016-10-06 11:52:49.812642Z] Running clobber step. 04:52:49 INFO - Running pre-action listener: _resource_record_pre_action 04:52:49 INFO - Running main action method: clobber 04:52:49 INFO - rmtree: /builds/slave/test/build 04:52:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:52:50 INFO - Running post-action listener: _resource_record_post_action 04:52:50 INFO - [mozharness: 2016-10-06 11:52:50.793194Z] Finished clobber step (success) 04:52:50 INFO - [mozharness: 2016-10-06 11:52:50.793293Z] Running read-buildbot-config step. 04:52:50 INFO - Running pre-action listener: _resource_record_pre_action 04:52:50 INFO - Running main action method: read_buildbot_config 04:52:50 INFO - Using buildbot properties: 04:52:50 INFO - { 04:52:50 INFO - "project": "", 04:52:50 INFO - "product": "firefox", 04:52:50 INFO - "script_repo_revision": "production", 04:52:50 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 04:52:50 INFO - "repository": "", 04:52:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 04:52:50 INFO - "buildid": "20161006020300", 04:52:50 INFO - "pgo_build": "True", 04:52:50 INFO - "basedir": "/builds/slave/test", 04:52:50 INFO - "buildnumber": 812, 04:52:50 INFO - "slavename": "talos-linux64-ix-059", 04:52:50 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:52:50 INFO - "platform": "ubuntu64_hw", 04:52:50 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:52:50 INFO - "branch": "mozilla-aurora", 04:52:50 INFO - "repo_path": "releases/mozilla-aurora", 04:52:50 INFO - "revision": "d7d42cef7968f3bf0539ffd631cbe8cca88665b6", 04:52:50 INFO - "stage_platform": "linux64-pgo", 04:52:50 INFO - "builduid": "602648876c57478489985221c16fb201", 04:52:50 INFO - "slavebuilddir": "test" 04:52:50 INFO - } 04:52:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/N71YWmBXSQu9PvdBULvbCQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 04:52:50 INFO - Running post-action listener: _resource_record_post_action 04:52:50 INFO - [mozharness: 2016-10-06 11:52:50.795717Z] Finished read-buildbot-config step (success) 04:52:50 INFO - [mozharness: 2016-10-06 11:52:50.795807Z] Running download-and-extract step. 04:52:50 INFO - Running pre-action listener: _resource_record_pre_action 04:52:50 INFO - Running main action method: download_and_extract 04:52:50 INFO - mkdir: /builds/slave/test/build/tests 04:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:50 INFO - trying https://queue.taskcluster.net/v1/task/N71YWmBXSQu9PvdBULvbCQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 04:52:50 INFO - Downloading https://queue.taskcluster.net/v1/task/N71YWmBXSQu9PvdBULvbCQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 04:52:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N71YWmBXSQu9PvdBULvbCQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:52:51 INFO - Downloaded 1361 bytes. 04:52:51 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 04:52:51 INFO - Using the following test package requirements: 04:52:51 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 04:52:51 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 04:52:51 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:52:51 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 04:52:51 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:52:51 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 04:52:51 INFO - u'jsshell-linux-x86_64.zip'], 04:52:51 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 04:52:51 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:52:51 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 04:52:51 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 04:52:51 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:52:51 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 04:52:51 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:52:51 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 04:52:51 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:52:51 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 04:52:51 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:52:51 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:52:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N71YWmBXSQu9PvdBULvbCQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 04:52:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N71YWmBXSQu9PvdBULvbCQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:52:51 INFO - Fetch https://queue.taskcluster.net/v1/task/N71YWmBXSQu9PvdBULvbCQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 04:52:51 INFO - Expected file size: 21906514 04:52:56 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:52:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N71YWmBXSQu9PvdBULvbCQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 04:52:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N71YWmBXSQu9PvdBULvbCQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:52:56 INFO - Fetch https://queue.taskcluster.net/v1/task/N71YWmBXSQu9PvdBULvbCQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 04:52:56 INFO - Expected file size: 21906514 04:53:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N71YWmBXSQu9PvdBULvbCQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 04:53:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N71YWmBXSQu9PvdBULvbCQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:53:01 INFO - Fetch https://queue.taskcluster.net/v1/task/N71YWmBXSQu9PvdBULvbCQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 04:53:02 INFO - Expected file size: 14414059 04:53:02 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')]} 04:53:02 INFO - trying https://queue.taskcluster.net/v1/task/N71YWmBXSQu9PvdBULvbCQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 04:53:02 INFO - Downloading https://queue.taskcluster.net/v1/task/N71YWmBXSQu9PvdBULvbCQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 04:53:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N71YWmBXSQu9PvdBULvbCQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:53:03 INFO - Downloaded 63955506 bytes. 04:53:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N71YWmBXSQu9PvdBULvbCQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 04:53:03 INFO - mkdir: /builds/slave/test/properties 04:53:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:53:03 INFO - Writing to file /builds/slave/test/properties/build_url 04:53:03 INFO - Contents: 04:53:03 INFO - build_url:https://queue.taskcluster.net/v1/task/N71YWmBXSQu9PvdBULvbCQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 04:53:04 INFO - Running post-action listener: _resource_record_post_action 04:53:04 INFO - Running post-action listener: set_extra_try_arguments 04:53:04 INFO - [mozharness: 2016-10-06 11:53:04.475360Z] Finished download-and-extract step (success) 04:53:04 INFO - [mozharness: 2016-10-06 11:53:04.475588Z] Running populate-webroot step. 04:53:04 INFO - Running pre-action listener: _resource_record_pre_action 04:53:04 INFO - Running main action method: populate_webroot 04:53:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:53:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:53:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:53:04 INFO - '--tppagecycles', 04:53:04 INFO - '7'], 04:53:04 INFO - 'tests': ['tsvgm']}}, 04:53:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:53:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:53:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:53:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:53:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:53:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:53:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:04 INFO - 'talos_options': ['--disable-e10s'], 04:53:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:53:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:53:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:04 INFO - 'talos_options': ['--disable-e10s'], 04:53:04 INFO - 'tests': ['damp', 'tps']}, 04:53:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:04 INFO - 'tests': ['damp', 'tps']}, 04:53:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:53:04 INFO - 'tests': ['dromaeo_dom']}, 04:53:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:53:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:53:04 INFO - 'tests': ['basic_compositor_video']}, 04:53:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:53:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:53:04 INFO - 'tests': ['a11yr', 04:53:04 INFO - 'ts_paint', 04:53:04 INFO - 'tpaint', 04:53:04 INFO - 'sessionrestore', 04:53:04 INFO - 'sessionrestore_no_auto_restore', 04:53:04 INFO - 'tabpaint']}, 04:53:04 INFO - 'other-e10s': {'tests': ['a11yr', 04:53:04 INFO - 'ts_paint', 04:53:04 INFO - 'tpaint', 04:53:04 INFO - 'sessionrestore', 04:53:04 INFO - 'sessionrestore_no_auto_restore', 04:53:04 INFO - 'tabpaint']}, 04:53:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:53:04 INFO - 'ts_paint', 04:53:04 INFO - 'tpaint', 04:53:04 INFO - 'sessionrestore', 04:53:04 INFO - 'sessionrestore_no_auto_restore', 04:53:04 INFO - 'tabpaint']}, 04:53:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:53:04 INFO - 'ts_paint', 04:53:04 INFO - 'tpaint', 04:53:04 INFO - 'sessionrestore', 04:53:04 INFO - 'sessionrestore_no_auto_restore', 04:53:04 INFO - 'tabpaint']}, 04:53:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:53:04 INFO - 'tests': ['a11yr', 04:53:04 INFO - 'ts_paint', 04:53:04 INFO - 'tpaint', 04:53:04 INFO - 'sessionrestore', 04:53:04 INFO - 'sessionrestore_no_auto_restore', 04:53:04 INFO - 'tabpaint']}, 04:53:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:53:04 INFO - 'tests': ['a11yr', 04:53:04 INFO - 'ts_paint', 04:53:04 INFO - 'tpaint', 04:53:04 INFO - 'sessionrestore', 04:53:04 INFO - 'sessionrestore_no_auto_restore', 04:53:04 INFO - 'tabpaint']}, 04:53:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:53:04 INFO - 'tests': ['tsvgx', 04:53:04 INFO - 'tsvgr_opacity', 04:53:04 INFO - 'tart', 04:53:04 INFO - 'tscrollx', 04:53:04 INFO - 'cart']}, 04:53:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:53:04 INFO - 'tsvgr_opacity', 04:53:04 INFO - 'tart', 04:53:04 INFO - 'tscrollx', 04:53:04 INFO - 'cart']}, 04:53:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:04 INFO - 'talos_options': ['--disable-e10s'], 04:53:04 INFO - 'tests': ['tp5o']}, 04:53:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:04 INFO - 'tests': ['tp5o']}, 04:53:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:04 INFO - 'talos_options': ['--disable-e10s', 04:53:04 INFO - '--xperf_path', 04:53:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:53:04 INFO - 'tests': ['tp5n']}, 04:53:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:04 INFO - 'talos_options': ['--xperf_path', 04:53:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:53:04 INFO - 'tests': ['tp5n']}}, 04:53:04 INFO - 'talos.zip': {'path': '', 04:53:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:53:04 INFO - Running post-action listener: _resource_record_post_action 04:53:04 INFO - [mozharness: 2016-10-06 11:53:04.494309Z] Finished populate-webroot step (success) 04:53:04 INFO - [mozharness: 2016-10-06 11:53:04.494398Z] Running create-virtualenv step. 04:53:04 INFO - Running pre-action listener: _resource_record_pre_action 04:53:04 INFO - Running main action method: create_virtualenv 04:53:04 INFO - Creating virtualenv /builds/slave/test/build/venv 04:53:04 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 04:53:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:53:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:53:04 INFO - Using real prefix '/usr' 04:53:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:53:05 INFO - Installing distribute.............................................................................................................................................................................................done. 04:53:07 INFO - Installing pip.................done. 04:53:07 INFO - Return code: 0 04:53:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:53:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:07 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 0x7f95840fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x132dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132af60>, '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 0x132bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x132c1d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1475754767.597148-992004852', '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 04:53:07 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 04:53:07 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 04:53:07 INFO - Using env: {'DISPLAY': ':0', 04:53:07 INFO - 'HOME': '/home/cltbld', 04:53:07 INFO - 'LANG': 'en_US.UTF-8', 04:53:07 INFO - 'LANGUAGE': 'en_US:en', 04:53:07 INFO - 'LOGNAME': 'cltbld', 04:53:07 INFO - 'MAIL': '/var/mail/cltbld', 04:53:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:07 INFO - 'MOZ_NO_REMOTE': '1', 04:53:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:07 INFO - 'NO_EM_RESTART': '1', 04:53:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:07 INFO - 'PWD': '/builds/slave/test', 04:53:07 INFO - 'SHELL': '/bin/bash', 04:53:07 INFO - 'SHLVL': '1', 04:53:07 INFO - 'TERM': 'linux', 04:53:07 INFO - 'TMOUT': '86400', 04:53:07 INFO - 'USER': 'cltbld', 04:53:07 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1475754767.597148-992004852', 04:53:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:07 INFO - '_': '/tools/buildbot/bin/python'} 04:53:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:07 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 04:53:07 INFO - Cleaning up... 04:53:07 INFO - Return code: 0 04:53:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:53:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:07 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 0x7f95840fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x132dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132af60>, '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 0x132bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x132c1d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1475754767.597148-992004852', '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 04:53:07 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 04:53:07 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 04:53:07 INFO - Using env: {'DISPLAY': ':0', 04:53:07 INFO - 'HOME': '/home/cltbld', 04:53:07 INFO - 'LANG': 'en_US.UTF-8', 04:53:07 INFO - 'LANGUAGE': 'en_US:en', 04:53:07 INFO - 'LOGNAME': 'cltbld', 04:53:07 INFO - 'MAIL': '/var/mail/cltbld', 04:53:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:07 INFO - 'MOZ_NO_REMOTE': '1', 04:53:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:07 INFO - 'NO_EM_RESTART': '1', 04:53:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:07 INFO - 'PWD': '/builds/slave/test', 04:53:07 INFO - 'SHELL': '/bin/bash', 04:53:07 INFO - 'SHLVL': '1', 04:53:07 INFO - 'TERM': 'linux', 04:53:07 INFO - 'TMOUT': '86400', 04:53:07 INFO - 'USER': 'cltbld', 04:53:07 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1475754767.597148-992004852', 04:53:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:07 INFO - '_': '/tools/buildbot/bin/python'} 04:53:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:07 INFO - Downloading/unpacking psutil>=3.1.1 04:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:53:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:53:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:53:09 INFO - Installing collected packages: psutil 04:53:09 INFO - Running setup.py install for psutil 04:53:09 INFO - building 'psutil._psutil_linux' extension 04:53:09 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 04:53:09 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 04:53:09 INFO - building 'psutil._psutil_posix' extension 04:53:09 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 04:53:09 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 04:53:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:53:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:53:10 INFO - Successfully installed psutil 04:53:10 INFO - Cleaning up... 04:53:10 INFO - Return code: 0 04:53:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:53:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95840fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x132dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132af60>, '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 0x132bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x132c1d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1475754767.597148-992004852', '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 04:53:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:53:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:53:10 INFO - Using env: {'DISPLAY': ':0', 04:53:10 INFO - 'HOME': '/home/cltbld', 04:53:10 INFO - 'LANG': 'en_US.UTF-8', 04:53:10 INFO - 'LANGUAGE': 'en_US:en', 04:53:10 INFO - 'LOGNAME': 'cltbld', 04:53:10 INFO - 'MAIL': '/var/mail/cltbld', 04:53:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:10 INFO - 'MOZ_NO_REMOTE': '1', 04:53:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:10 INFO - 'NO_EM_RESTART': '1', 04:53:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:10 INFO - 'PWD': '/builds/slave/test', 04:53:10 INFO - 'SHELL': '/bin/bash', 04:53:10 INFO - 'SHLVL': '1', 04:53:10 INFO - 'TERM': 'linux', 04:53:10 INFO - 'TMOUT': '86400', 04:53:10 INFO - 'USER': 'cltbld', 04:53:10 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1475754767.597148-992004852', 04:53:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:10 INFO - '_': '/tools/buildbot/bin/python'} 04:53:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:53:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:53:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:53:12 INFO - Installing collected packages: mozsystemmonitor 04:53:12 INFO - Running setup.py install for mozsystemmonitor 04:53:12 INFO - Successfully installed mozsystemmonitor 04:53:12 INFO - Cleaning up... 04:53:12 INFO - Return code: 0 04:53:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:53:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:12 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 0x7f95840fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x132dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132af60>, '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 0x132bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x132c1d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1475754767.597148-992004852', '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 04:53:12 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 04:53:12 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 04:53:12 INFO - Using env: {'DISPLAY': ':0', 04:53:12 INFO - 'HOME': '/home/cltbld', 04:53:12 INFO - 'LANG': 'en_US.UTF-8', 04:53:12 INFO - 'LANGUAGE': 'en_US:en', 04:53:12 INFO - 'LOGNAME': 'cltbld', 04:53:12 INFO - 'MAIL': '/var/mail/cltbld', 04:53:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:12 INFO - 'MOZ_NO_REMOTE': '1', 04:53:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:12 INFO - 'NO_EM_RESTART': '1', 04:53:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:12 INFO - 'PWD': '/builds/slave/test', 04:53:12 INFO - 'SHELL': '/bin/bash', 04:53:12 INFO - 'SHLVL': '1', 04:53:12 INFO - 'TERM': 'linux', 04:53:12 INFO - 'TMOUT': '86400', 04:53:12 INFO - 'USER': 'cltbld', 04:53:12 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1475754767.597148-992004852', 04:53:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:12 INFO - '_': '/tools/buildbot/bin/python'} 04:53:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:12 INFO - Downloading/unpacking jsonschema==2.5.1 04:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:53:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:53:14 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 04:53:14 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 04:53:14 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 04:53:14 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 04:53:14 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 04:53:14 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 04:53:14 INFO - Downloading functools32-3.2.3-2.tar.gz 04:53:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:53:14 INFO - warning: no files found matching '*.txt' 04:53:14 INFO - no previously-included directories found matching 'build' 04:53:14 INFO - no previously-included directories found matching 'dist' 04:53:14 INFO - no previously-included directories found matching '.git*' 04:53:14 INFO - Installing collected packages: jsonschema, functools32 04:53:14 INFO - Running setup.py install for functools32 04:53:14 INFO - warning: no files found matching '*.txt' 04:53:14 INFO - no previously-included directories found matching 'build' 04:53:14 INFO - no previously-included directories found matching 'dist' 04:53:14 INFO - no previously-included directories found matching '.git*' 04:53:14 INFO - Successfully installed jsonschema functools32 04:53:14 INFO - Cleaning up... 04:53:14 INFO - Return code: 0 04:53:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:53:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:14 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 0x7f95840fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x132dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132af60>, '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 0x132bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x132c1d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1475754767.597148-992004852', '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 04:53:14 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 04:53:14 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 04:53:14 INFO - Using env: {'DISPLAY': ':0', 04:53:14 INFO - 'HOME': '/home/cltbld', 04:53:14 INFO - 'LANG': 'en_US.UTF-8', 04:53:14 INFO - 'LANGUAGE': 'en_US:en', 04:53:14 INFO - 'LOGNAME': 'cltbld', 04:53:14 INFO - 'MAIL': '/var/mail/cltbld', 04:53:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:14 INFO - 'MOZ_NO_REMOTE': '1', 04:53:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:14 INFO - 'NO_EM_RESTART': '1', 04:53:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:14 INFO - 'PWD': '/builds/slave/test', 04:53:14 INFO - 'SHELL': '/bin/bash', 04:53:14 INFO - 'SHLVL': '1', 04:53:14 INFO - 'TERM': 'linux', 04:53:14 INFO - 'TMOUT': '86400', 04:53:14 INFO - 'USER': 'cltbld', 04:53:14 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1475754767.597148-992004852', 04:53:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:14 INFO - '_': '/tools/buildbot/bin/python'} 04:53:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:53:15 INFO - Cleaning up... 04:53:15 INFO - Return code: 0 04:53:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:53: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')]} 04:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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')]} 04:53:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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', '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 0x7f95840fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x132dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132af60>, '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 0x132bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x132c1d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1475754767.597148-992004852', '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 04:53: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:53: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 blobuploader==1.2.4 04:53:15 INFO - Using env: {'DISPLAY': ':0', 04:53:15 INFO - 'HOME': '/home/cltbld', 04:53:15 INFO - 'LANG': 'en_US.UTF-8', 04:53:15 INFO - 'LANGUAGE': 'en_US:en', 04:53:15 INFO - 'LOGNAME': 'cltbld', 04:53:15 INFO - 'MAIL': '/var/mail/cltbld', 04:53:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:15 INFO - 'MOZ_NO_REMOTE': '1', 04:53:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:15 INFO - 'NO_EM_RESTART': '1', 04:53:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:15 INFO - 'PWD': '/builds/slave/test', 04:53:15 INFO - 'SHELL': '/bin/bash', 04:53:15 INFO - 'SHLVL': '1', 04:53:15 INFO - 'TERM': 'linux', 04:53:15 INFO - 'TMOUT': '86400', 04:53:15 INFO - 'USER': 'cltbld', 04:53:15 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1475754767.597148-992004852', 04:53:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:15 INFO - '_': '/tools/buildbot/bin/python'} 04:53:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:15 INFO - Downloading/unpacking blobuploader==1.2.4 04:53:15 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 04:53:15 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 04:53:15 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 04:53:15 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 04:53:15 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 04:53:15 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 04:53:17 INFO - Downloading blobuploader-1.2.4.tar.gz 04:53:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:53:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:53:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:17 INFO - Downloading docopt-0.6.1.tar.gz 04:53:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:53:18 INFO - Installing collected packages: blobuploader, requests, docopt 04:53:18 INFO - Running setup.py install for blobuploader 04:53:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:53:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:53:18 INFO - Running setup.py install for requests 04:53:18 INFO - Running setup.py install for docopt 04:53:18 INFO - Successfully installed blobuploader requests docopt 04:53:18 INFO - Cleaning up... 04:53:18 INFO - Return code: 0 04:53:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53: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')]} 04:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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')]} 04:53:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:18 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 0x7f95840fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x132dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132af60>, '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 0x132bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x132c1d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1475754767.597148-992004852', '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 04:53:18 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 04:53:18 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 04:53:18 INFO - Using env: {'DISPLAY': ':0', 04:53:18 INFO - 'HOME': '/home/cltbld', 04:53:18 INFO - 'LANG': 'en_US.UTF-8', 04:53:18 INFO - 'LANGUAGE': 'en_US:en', 04:53:18 INFO - 'LOGNAME': 'cltbld', 04:53:18 INFO - 'MAIL': '/var/mail/cltbld', 04:53:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:18 INFO - 'MOZ_NO_REMOTE': '1', 04:53:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:18 INFO - 'NO_EM_RESTART': '1', 04:53:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:18 INFO - 'PWD': '/builds/slave/test', 04:53:18 INFO - 'SHELL': '/bin/bash', 04:53:18 INFO - 'SHLVL': '1', 04:53:18 INFO - 'TERM': 'linux', 04:53:18 INFO - 'TMOUT': '86400', 04:53:18 INFO - 'USER': 'cltbld', 04:53:18 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1475754767.597148-992004852', 04:53:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:18 INFO - '_': '/tools/buildbot/bin/python'} 04:53:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:53:18 INFO - Running setup.py (path:/tmp/pip-vnu4NP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:53:18 INFO - Running setup.py (path:/tmp/pip-u143Dm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:53:19 INFO - Running setup.py (path:/tmp/pip-glr4Hn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:53:19 INFO - Running setup.py (path:/tmp/pip-bIoXro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:53:19 INFO - Running setup.py (path:/tmp/pip-WU7165-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:53:19 INFO - Running setup.py (path:/tmp/pip-663jsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:53:19 INFO - Running setup.py (path:/tmp/pip-xdAidK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:53:19 INFO - Running setup.py (path:/tmp/pip-QsQdjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:53:19 INFO - Running setup.py (path:/tmp/pip-BwUh9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:53:19 INFO - Running setup.py (path:/tmp/pip-md3i_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:53:19 INFO - Running setup.py (path:/tmp/pip-k0OXvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:53:19 INFO - Running setup.py (path:/tmp/pip-wD_LqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:53:19 INFO - Running setup.py (path:/tmp/pip-cr6TSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:53:19 INFO - Running setup.py (path:/tmp/pip-FY4ITg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:19 INFO - Running setup.py (path:/tmp/pip-t2S7if-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:53:19 INFO - Running setup.py (path:/tmp/pip-itfSs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:53:20 INFO - Running setup.py (path:/tmp/pip-UDti8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:53:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:53:20 INFO - Running setup.py install for manifestparser 04:53:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:53:20 INFO - Running setup.py install for mozcrash 04:53:20 INFO - Running setup.py install for mozdebug 04:53:20 INFO - Running setup.py install for mozdevice 04:53:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:53:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:53:20 INFO - Running setup.py install for mozfile 04:53:20 INFO - Running setup.py install for mozhttpd 04:53:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:53:20 INFO - Running setup.py install for mozinfo 04:53:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:53:20 INFO - Running setup.py install for mozInstall 04:53:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:53:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:53:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:53:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:53:20 INFO - Running setup.py install for mozleak 04:53:21 INFO - Running setup.py install for mozlog 04:53:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:53:21 INFO - Running setup.py install for moznetwork 04:53:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:53:21 INFO - Running setup.py install for mozprocess 04:53:21 INFO - Running setup.py install for mozprofile 04:53:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:53:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:53:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:53:21 INFO - Running setup.py install for mozrunner 04:53:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:53:21 INFO - Running setup.py install for mozscreenshot 04:53:21 INFO - Running setup.py install for moztest 04:53:21 INFO - Running setup.py install for mozversion 04:53:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:53:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:53:21 INFO - Cleaning up... 04:53:21 INFO - Return code: 0 04:53:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53: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')]} 04:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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')]} 04:53:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:21 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 0x7f95840fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x132dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132af60>, '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 0x132bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x132c1d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1475754767.597148-992004852', '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 04:53:21 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 04:53:21 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 04:53:21 INFO - Using env: {'DISPLAY': ':0', 04:53:21 INFO - 'HOME': '/home/cltbld', 04:53:21 INFO - 'LANG': 'en_US.UTF-8', 04:53:21 INFO - 'LANGUAGE': 'en_US:en', 04:53:21 INFO - 'LOGNAME': 'cltbld', 04:53:21 INFO - 'MAIL': '/var/mail/cltbld', 04:53:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:21 INFO - 'MOZ_NO_REMOTE': '1', 04:53:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:21 INFO - 'NO_EM_RESTART': '1', 04:53:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:21 INFO - 'PWD': '/builds/slave/test', 04:53:21 INFO - 'SHELL': '/bin/bash', 04:53:21 INFO - 'SHLVL': '1', 04:53:21 INFO - 'TERM': 'linux', 04:53:21 INFO - 'TMOUT': '86400', 04:53:21 INFO - 'USER': 'cltbld', 04:53:21 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1475754767.597148-992004852', 04:53:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:21 INFO - '_': '/tools/buildbot/bin/python'} 04:53:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:53:22 INFO - Running setup.py (path:/tmp/pip-nepRmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:53:22 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)) 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:53:22 INFO - Running setup.py (path:/tmp/pip-1SZ_Tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:53:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:53:22 INFO - Running setup.py (path:/tmp/pip-baJ8Bv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:53:22 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)) 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:53:22 INFO - Running setup.py (path:/tmp/pip-G_kGtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:53:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:53:22 INFO - Running setup.py (path:/tmp/pip-BG414_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:53:22 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)) 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:53:22 INFO - Running setup.py (path:/tmp/pip-_CJ6n2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:53:22 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)) 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:53:22 INFO - Running setup.py (path:/tmp/pip-vrMdBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:53:22 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)) 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:53:22 INFO - Running setup.py (path:/tmp/pip-TWOi9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:53:22 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)) 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:53:22 INFO - Running setup.py (path:/tmp/pip-8IXmLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:53:22 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)) 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:53:22 INFO - Running setup.py (path:/tmp/pip-1iPhQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:53:22 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)) 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:53:22 INFO - Running setup.py (path:/tmp/pip-pvEj9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:53:22 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)) 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:53:22 INFO - Running setup.py (path:/tmp/pip-e2tckr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:53:23 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)) 04:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:53:23 INFO - Running setup.py (path:/tmp/pip-XrLcxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:53:23 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)) 04:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:53:23 INFO - Running setup.py (path:/tmp/pip-X27tbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:53:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:23 INFO - Running setup.py (path:/tmp/pip-KzbDvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:23 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)) 04:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:53:23 INFO - Running setup.py (path:/tmp/pip-gKjsqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:53:23 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)) 04:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:53:23 INFO - Running setup.py (path:/tmp/pip-U5s9dT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:53:23 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)) 04:53:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:53:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:53:23 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)) 04:53:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:53:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:53:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:53: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 04:53: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 04:53: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 04:53: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 04:53: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 04:53: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 04:53:25 INFO - Downloading blessings-1.6.tar.gz 04:53:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:53:25 INFO - Installing collected packages: blessings 04:53:25 INFO - Running setup.py install for blessings 04:53:25 INFO - Successfully installed blessings 04:53:25 INFO - Cleaning up... 04:53:25 INFO - Return code: 0 04:53:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:53:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:53:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:53:25 INFO - Reading from file tmpfile_stdout 04:53:25 INFO - Current package versions: 04:53:25 INFO - argparse == 1.2.1 04:53:25 INFO - blessings == 1.6 04:53:25 INFO - blobuploader == 1.2.4 04:53:25 INFO - docopt == 0.6.1 04:53:25 INFO - functools32 == 3.2.3-2 04:53:25 INFO - jsonschema == 2.5.1 04:53:25 INFO - manifestparser == 1.1 04:53:25 INFO - mozInstall == 1.12 04:53:25 INFO - mozcrash == 0.17 04:53:25 INFO - mozdebug == 0.1 04:53:25 INFO - mozdevice == 0.48 04:53:25 INFO - mozfile == 1.2 04:53:25 INFO - mozhttpd == 0.7 04:53:25 INFO - mozinfo == 0.9 04:53:25 INFO - mozleak == 0.1 04:53:25 INFO - mozlog == 3.4 04:53:25 INFO - moznetwork == 0.27 04:53:25 INFO - mozprocess == 0.23 04:53:25 INFO - mozprofile == 0.28 04:53:25 INFO - mozrunner == 6.12 04:53:25 INFO - mozscreenshot == 0.1 04:53:25 INFO - mozsystemmonitor == 0.3 04:53:25 INFO - moztest == 0.7 04:53:25 INFO - mozversion == 1.4 04:53:25 INFO - psutil == 3.1.1 04:53:25 INFO - requests == 1.2.3 04:53:25 INFO - wsgiref == 0.1.2 04:53:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:25 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 0x7f95840fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x132dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132af60>, '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 0x132bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x132c1d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1475754767.597148-992004852', '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 04:53:25 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 04:53:25 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 04:53:25 INFO - Using env: {'DISPLAY': ':0', 04:53:25 INFO - 'HOME': '/home/cltbld', 04:53:25 INFO - 'LANG': 'en_US.UTF-8', 04:53:25 INFO - 'LANGUAGE': 'en_US:en', 04:53:25 INFO - 'LOGNAME': 'cltbld', 04:53:25 INFO - 'MAIL': '/var/mail/cltbld', 04:53:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:25 INFO - 'MOZ_NO_REMOTE': '1', 04:53:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:25 INFO - 'NO_EM_RESTART': '1', 04:53:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:25 INFO - 'PWD': '/builds/slave/test', 04:53:25 INFO - 'SHELL': '/bin/bash', 04:53:25 INFO - 'SHLVL': '1', 04:53:25 INFO - 'TERM': 'linux', 04:53:25 INFO - 'TMOUT': '86400', 04:53:25 INFO - 'USER': 'cltbld', 04:53:25 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1475754767.597148-992004852', 04:53:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:25 INFO - '_': '/tools/buildbot/bin/python'} 04:53:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:26 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)) 04:53:26 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)) 04:53:26 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)) 04:53:26 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)) 04:53:26 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)) 04:53:26 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)) 04:53:26 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)) 04:53:26 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)) 04:53:26 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)) 04:53:26 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)) 04:53:26 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)) 04:53:26 INFO - Cleaning up... 04:53:26 INFO - Return code: 0 04:53:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:53:26 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')]} 04:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:26 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')]} 04:53:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:26 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 0x7f95840fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x132dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132af60>, '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 0x132bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x132c1d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1475754767.597148-992004852', '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 04:53:26 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 04:53:26 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 04:53:26 INFO - Using env: {'DISPLAY': ':0', 04:53:26 INFO - 'HOME': '/home/cltbld', 04:53:26 INFO - 'LANG': 'en_US.UTF-8', 04:53:26 INFO - 'LANGUAGE': 'en_US:en', 04:53:26 INFO - 'LOGNAME': 'cltbld', 04:53:26 INFO - 'MAIL': '/var/mail/cltbld', 04:53:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:26 INFO - 'MOZ_NO_REMOTE': '1', 04:53:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:26 INFO - 'NO_EM_RESTART': '1', 04:53:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:26 INFO - 'PWD': '/builds/slave/test', 04:53:26 INFO - 'SHELL': '/bin/bash', 04:53:26 INFO - 'SHLVL': '1', 04:53:26 INFO - 'TERM': 'linux', 04:53:26 INFO - 'TMOUT': '86400', 04:53:26 INFO - 'USER': 'cltbld', 04:53:26 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1475754767.597148-992004852', 04:53:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:26 INFO - '_': '/tools/buildbot/bin/python'} 04:53:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:53:26 INFO - Cleaning up... 04:53:26 INFO - Return code: 0 04:53:26 INFO - Running post-action listener: _resource_record_post_action 04:53:26 INFO - Running post-action listener: _start_resource_monitoring 04:53:26 INFO - Starting resource monitoring. 04:53:26 INFO - [mozharness: 2016-10-06 11:53:26.280274Z] Finished create-virtualenv step (success) 04:53:26 INFO - [mozharness: 2016-10-06 11:53:26.280775Z] Running install step. 04:53:26 INFO - Running pre-action listener: _resource_record_pre_action 04:53:26 INFO - Running main action method: install 04:53:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:53:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:53:26 INFO - Reading from file tmpfile_stdout 04:53:26 INFO - Detecting whether we're running mozinstall >=1.0... 04:53:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:53:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:53:26 INFO - Reading from file tmpfile_stdout 04:53:26 INFO - Output received: 04:53:26 INFO - Usage: mozinstall [options] installer 04:53:26 INFO - Options: 04:53:26 INFO - -h, --help show this help message and exit 04:53:26 INFO - -d DEST, --destination=DEST 04:53:26 INFO - Directory to install application into. [default: 04:53:26 INFO - "/builds/slave/test"] 04:53:26 INFO - --app=APP Application being installed. [default: firefox] 04:53:26 INFO - mkdir: /builds/slave/test/build/application 04:53:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:53:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:53:42 INFO - Reading from file tmpfile_stdout 04:53:42 INFO - Output received: 04:53:42 INFO - /builds/slave/test/build/application/firefox/firefox 04:53:42 INFO - Running post-action listener: _resource_record_post_action 04:53:42 INFO - [mozharness: 2016-10-06 11:53:42.548827Z] Finished install step (success) 04:53:42 INFO - [mozharness: 2016-10-06 11:53:42.549071Z] Running run-tests step. 04:53:42 INFO - Running pre-action listener: _resource_record_pre_action 04:53:42 INFO - Running main action method: run_tests 04:53:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:53:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:53:42 INFO - Python 2.7.3 04:53:42 INFO - Return code: 0 04:53:42 INFO - grabbing minidump binary from tooltool 04:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:42 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 0x132af60>, '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 0x132bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x132c1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:53:42 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 04:53:42 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 04:53:42 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 04:53:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:53:42 INFO - Return code: 0 04:53:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:53:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:53:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:53:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:53:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:53:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N71YWmBXSQu9PvdBULvbCQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 04:53:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/N71YWmBXSQu9PvdBULvbCQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 04:53:42 INFO - Using env: {'DISPLAY': ':0', 04:53:42 INFO - 'HOME': '/home/cltbld', 04:53:42 INFO - 'LANG': 'en_US.UTF-8', 04:53:42 INFO - 'LANGUAGE': 'en_US:en', 04:53:42 INFO - 'LOGNAME': 'cltbld', 04:53:42 INFO - 'MAIL': '/var/mail/cltbld', 04:53:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:53:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:53:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:42 INFO - 'MOZ_NO_REMOTE': '1', 04:53:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:53:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:42 INFO - 'NO_EM_RESTART': '1', 04:53:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:42 INFO - 'PWD': '/builds/slave/test', 04:53:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:53:42 INFO - 'SHELL': '/bin/bash', 04:53:42 INFO - 'SHLVL': '1', 04:53:42 INFO - 'TERM': 'linux', 04:53:42 INFO - 'TMOUT': '86400', 04:53:42 INFO - 'USER': 'cltbld', 04:53:42 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1475754767.597148-992004852', 04:53:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:42 INFO - '_': '/tools/buildbot/bin/python'} 04:53:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N71YWmBXSQu9PvdBULvbCQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 04:53:42 INFO - mozversion application_buildid: 20161006020300 04:53:42 INFO - mozversion application_changeset: d7d42cef7968f3bf0539ffd631cbe8cca88665b6 04:53:42 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:53:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:53:42 INFO - mozversion application_name: Firefox 04:53:42 INFO - mozversion application_remotingname: firefox-dev 04:53:42 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:53:42 INFO - mozversion application_vendor: Mozilla 04:53:42 INFO - mozversion application_version: 51.0a2 04:53:42 INFO - mozversion platform_buildid: 20161006020300 04:53:42 INFO - mozversion platform_changeset: d7d42cef7968f3bf0539ffd631cbe8cca88665b6 04:53:42 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:53:42 INFO - mozversion platform_version: 51.0a2 04:53:42 INFO - using testdate: 1475754822 04:53:42 INFO - actual date: 1475754822 04:53:42 INFO - starting webserver on 'localhost:59898' 04:53:42 INFO - SUITE-START | Running 2 tests 04:53:42 INFO - TEST-START | dromaeo_css 04:53:42 INFO - operating with platform_type : linux_ 04:53:42 INFO - Initialising browser for dromaeo_css test... 04:53:42 INFO - TEST-INFO | started process 5239 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVYnDbw/profile http://localhost:59898/getInfo.html) 04:53:46 INFO - PROCESS | 5239 | __metrics Screen width/height:1600/1200 04:53:46 INFO - PROCESS | 5239 | colorDepth:24 04:53:46 INFO - PROCESS | 5239 | Browser inner width/height: 1024/697 04:53:46 INFO - PROCESS | 5239 | __metrics 04:53:46 INFO - PROCESS | 5239 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:53:46 INFO - PROCESS | 5239 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:53:47 INFO - PROCESS | 5239 | console.error: PushService: 04:53:47 INFO - PROCESS | 5239 | stateChangeProcessEnqueue: Error transitioning state 04:53:47 INFO - PROCESS | 5239 | UnknownError 04:53:48 INFO - TEST-INFO | 5239: exit 0 04:53:48 INFO - Browser initialized. 04:53:48 INFO - Running cycle 1/1 for dromaeo_css test... 04:53:48 INFO - TEST-INFO | started process 5330 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVYnDbw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:53:59 INFO - PROCESS | 5330 | RSS: Main: 144474112 04:53:59 INFO - PROCESS | 5330 | 04:54:51 INFO - PROCESS | 5330 | 1475754891688 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] 04:57:00 INFO - PROCESS | 5330 | Cycle 1(1): loaded http://localhost:59898/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59898/tests/dromaeo/cssquery-ext.html) 04:57:01 INFO - PROCESS | 5330 | RSS: Main: 249311232 04:57:01 INFO - PROCESS | 5330 | 05:00:03 INFO - PROCESS | 5330 | Cycle 1(1): loaded http://localhost:59898/tests/dromaeo/cssquery-ext.html (next: http://localhost:59898/tests/dromaeo/cssquery-jquery.html) 05:00:04 INFO - PROCESS | 5330 | RSS: Main: 232337408 05:00:04 INFO - PROCESS | 5330 | 05:03:05 INFO - PROCESS | 5330 | Cycle 1(1): loaded http://localhost:59898/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59898/tests/dromaeo/cssquery-mootools.html) 05:03:06 INFO - PROCESS | 5330 | RSS: Main: 225693696 05:03:06 INFO - PROCESS | 5330 | 05:06:08 INFO - PROCESS | 5330 | Cycle 1(1): loaded http://localhost:59898/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59898/tests/dromaeo/cssquery-prototype.html) 05:06:08 INFO - PROCESS | 5330 | RSS: Main: 186347520 05:06:08 INFO - PROCESS | 5330 | 05:09:11 INFO - PROCESS | 5330 | Cycle 1(1): loaded http://localhost:59898/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59898/tests/dromaeo/cssquery-yui.html) 05:09:12 INFO - PROCESS | 5330 | RSS: Main: 175243264 05:09:12 INFO - PROCESS | 5330 | 05:12:14 INFO - PROCESS | 5330 | Cycle 1(1): loaded http://localhost:59898/tests/dromaeo/cssquery-yui.html (next: http://localhost:59898/tests/dromaeo/cssquery-dojo.html) 05:12:14 INFO - PROCESS | 5330 | RSS: Main: 264159232 05:12:14 INFO - PROCESS | 5330 | 05:12:14 INFO - PROCESS | 5330 | __start_tp_report 05:12:14 INFO - PROCESS | 5330 | _x_x_mozilla_page_load 05:12:14 INFO - PROCESS | 5330 | _x_x_mozilla_page_load_details 05:12:14 INFO - PROCESS | 5330 | |i|pagename|runs| 05:12:14 INFO - PROCESS | 5330 | |0;dojo.html;3169.6037995250595;3208.0055182893307;3218.9195270118257;3236.70869621734;3262.2986057997527;5622.240997465341;5690.743916523756;5714.314282286132;5715.142728590714;5747.080467125255;5664.5468362531;5743.9712801435935;5744.425557444253;5744.511716504102;5754.223179870716;5184.326037615105;5186.429492755803;5204.817831375903;5222.033923724104;5252.290940723011;5084.51697088776;5112.718800465973;5162.664426812264;5259.526642602165;5302.708351040691;5160.767765450545;5208.687478751287;5216.504432078947;5216.713080780555;5224.869378265555;5236.921446178291;5237.528622423981;5242.97378513105;5245.763940622681;5275.762590683428;4882.609391248727;4907.754612269372;5135.743212839343;5142.177251639757;5208.765605547722;5559.388467268597;5569.498745112919;5570.888582228374;5572.7770889164385;5600.719964001824;6042.516598672096;6065.393460653943;6092.299385570672;6146.139540464339;6147.139400483936;5936.465718085393;6160.7535698572;6162.414570615784;6184.196054512884;6185.690715464209;5580.581456390746;5615.859603509904;5626.212330273765;5636.2954630671165;5665.801696940587;6208.1308616793685;6213.440790328892;6214.689265536705;6221.035739460391;6234.501239900797;5785.218995435563;5968.1644569760265;5975.820725378246;5976.491998180203;5984.910226346521;5840;5983.880322393527;6030.6080104793045;6037.849053773603;6124.142620033199;6063.818085457443;6067.271927368655;6069.453749162597;6082.817515474543;6089.878202435926;6049;6050.031994880798;6056.303525094582;6058.878822423527;6096.817095487142;4530.909381812346;4553.954460455419;4630.907381852344;4672.18236808564;4674.415698037746;4135.9172816544105;4154.91690166195;4155.189738001121;4157.189348077157;4178.101708132766;5800.506956908625;5821.155932389865;5827.621204621771;5834.095715164071;5858.50202732764;5981.730822112929;6037.034074548052;6118.192813661829;6127.295361033449;6216.222972128484;5879.20630714848;5880.147378630075;5882.147088672119;5903.704814759245;5917.7928772493615;5268.15709486488;5269.473052694777;5271.182966640177;5277.1292736698015;5281.392639846466;6073.058675905242;6118.694065296718;6293.905591416224;6333.429991300805;6353.745850166034;6113.908291375722;6225.875482490234;6238.844028899314;6244.438000579969;6247.437730604267;6334.651594162366;6405.647689377129;6408.487321014214;6429.38920802523;6441.033844923299;5796.913046304225;5835.299764028344;6062.636241825505;6068.241469816273;6076.51387888959;6004.5496587755215;6036;6041.728122234422;6115.0273862886115;6144.938550614436;5870.207521984648;5912.024515954819;5915.645061296336;5916.615419997686;5916.704164791657;5686.57350698691;5818.505427038749;5822.214001109796;5823.213866128188;5826.213461182686;5753.683547404933;5956.523478121827;6045.667488288186;6061.605995610271;6122.97760420812;6169.5064394849205;6173.783917562864;6179.62922224668;6187.783427580013;6192.783252586138;5714.114312281603;5759.395263497272;5998.3401825798255;6012.549058820518;6063.181470501426 05:12:14 INFO - PROCESS | 5330 | |1;ext.html;582.4437662032759;599.9970000149999;626.6897885546654;641.8202903187109;648.607592406594;34883.3023339533;47233;48445.75777121114;48507.757461212736;48595.75702121484;49132.50867491324;49499.752501237446;49690.50309496913;49713.50286497134;49741.75129124349;8376.874346884802;9321.999999999984;9488.05119488049;9493.430394176337;9499.905000950006;8392.622331995044;11185.776284474347;11607.071434285279;11616.825747613793;11631.069514438866;11309.434528273594;11375.20373573846;11379.374134422604;11385.658430247106;11389.829152562717;11256.155788315868;11294;11304.321740695503;11347.489362978644;11353.148513861412;11041.944790275997;11128.554857805679;11134.721631959184;11134.721631959184;11139.888601113966;46459.07081858378;46694;46836.297455538195;46849;46851.53148468506;3771.283456143324;3774.1130834253927;3843.692504599653;3996.040950171967;4503.301988191835;34973.82513087418;35214.295714085834;35326.116847078774;35673;35972;4693.460252070987;4743.09881122589;4752.786124624366;4763.2278807605235;4801.759912004421;369725;370525;372413;372963.13518432504;373719;60838.391616084155;61187.38812611906;61206;61213;61215.38784612186;41913.58086419097;42522.57477425248;42746.78626606847;44196.337054944204;63649;20034.196922277064;20086.196552138044;20086.296979605642;20203.292884748964;20207.191712331634;14485.85514144845;14653.34059967304;14731;15426;15530.378784848479;20559;21646.350609481742;21719.348419547438;21726.782732172793;21750;7435.367993720486;7690.230976902377;7789.844203115906;7833.451658383972;7861.921380786233;965.6234068713208;1081.416035340907;1098.1763677242068;1123.27548731068;1161.1407558406718;34740.652593474246;35081;35512.64487355145;35603.4659480108;35810.64189358073;1131.588261391904;1146.4898120336536;1172.783035138502;1195.8564972203392;1233.5127624588238;17958.281668733103;18425.907870460564;18427.90786046061;18476.260949561867;18585.25658973626;607391;613443;613539;614390;614767;65386.346136538974;66077.33922660808;66143;66184.33815661781;66236.33763662302;1317.4927652853528;1378.9379477923517;1381.4267079162237;1440.8054912586877;1465.9413623455155;31284;36522;36578;36647.63352366442;36754.448683269235;56399;57102.42897571137;57149.428505716074;57159;57230.42769572251;362918;364672;364700;366016;367755;31370.372592548476;31524.842375788892;31761.682383176798;32093.67906320907;33484.162895927795;52945.7352713234;52982.73508632432;53278.46721532735;53519;54463;43668.56331436645;44424.55575444333;44717.55282447134;45147.83814570901;45692.54307456883;45277;45873.77063114663;45888.77055614834;46082.450151793266;46706.53293467158;43591.782041089595;44587.55412445964;44807.77596111999;45457.77271113623;45481.77259113683;37487.81256093702;38912.41631375475;39838.20323593454;40303.19393612053;40513.59486405216;29453.705462945098;29561;29886.057406268523;30263.546046809755;30268.84865575658 05:12:14 INFO - PROCESS | 5330 | |2;jquery.html;393.64375240407406;413.1221155045528;429.7249760153502;435.13191183588737;442.28129289903904;15805.604859878495;19884.801151988493;20635.690464643023;21217.151313947423;21944.780552194472;20455.795442045575;20463.897680511578;20888.791112088875;21041.158353665873;21043.47391315218;5854.356020837705;5879.823605291848;6125.5712100153005;6130.570860039799;6136.325004249551;5958.553108516857;5991.370906054867;6034.547408944325;6046.244219472566;6050.788222412217;5777.19119323295;5962.135490353896;6003.519718422515;6020.217371741667;6021.608595441304;5960.910586341209;5982.581219314649;6006.879862402728;6009.669468179249;6014.939850601481;5349.598780091509;5397.78408863645;5422.593305502103;5426;5428.37573679028;24271.63592546113;24604.753952460425;24808.503829923302;24823.751762482323;25271.36821579475;2329.1847853251397;2352.7059117610297;2368.656544800994;2369.8104151667826;2392.234484964812;10477.31897426665;14682.853171468363;15013.849861501354;15041.623959401102;15326.923365383213;1895.2324308655018;1949.6295703816372;1994.2920263306607;2015.2342109998108;2052.5894821035704;81687.5915620424;86053.56973215094;86789.56605216934;87092.56453717755;88656.99999999936;10569.788604227871;10984.231103822816;11784.584160247128;12191;12309.692257693629;15702;16518.917405412896;16653;17088.145592720313;17204;8843.292536597057;8907.663850422488;8951.283897288202;9085.273178145733;9305.581248843682;8282.17178282167;8298.70954516589;8310.667573297122;8504.362172837062;8517.403781735344;5069.264956581275;5143.202803565453;5149.382074151126;5169.948300516947;5217.765200565984;2050.846186536016;2074.9481262968243;2104.105755054096;2120.660694288906;2168.5662867426577;1012.7716782433312;1036.968890933258;1040.328987802863;1065.8294672852307;1099.7140743406771;20299.289524866854;20519.794802051787;20537.691934620994;20758.792412075687;20762.896185518977;998.6904059741504;1026.1636766035658;1032.0453580438066;1035.2804800663616;1080.9243352965375;10026;11384.829227561593;11505;11628.360440175871;11734;524701;528731;543971;551251;560074;89880;91453;93527;95951;99410;1002.4286156890648;1030.1501261459325;1038.7610849504506;1054.9103326217357;1056.5668076088766;17892.55268618295;18336.90831545834;18409.778917077652;18795.718064228775;18879.43361699151;31697.683023169473;40078;42151;44537;45579;58362.4163758374;59616.403835961086;60091.69954150376;60267.69866150641;60999;6294.968525157345;8164.346852251924;8333.583320834055;8780.51707156087;9338.299627527827;10163.593456261668;13596.66008349799;13676.863231367957;13840.040286593208;14005.579832605039;6433.420992110732;8697.304215662605;11633.778453262286;11935.880641193477;12002;11398.259113157617;11431.02836258894;11440.885591144315;11658.242214256046;12265.632031039084;12026.879731202576;12140.575079872162;12231.816522751988;12257.93551612097;12341.50633974631;8135.471194372347;8210.958945205235;8223.588820559067;8240.381971352053;8576.399652024547;9312.44125352481;11763.588274410697;11893.524259029542;12007.279563226235;12293.631191064282 05:12:14 INFO - PROCESS | 5330 | |3;mootools.html;1556.987957827412;1599.6800639872024;1730.1435789284305;1789.8657600679953;1837.970736387624;9193.862092068615;9877.308588398815;9886;9886.456244906527;9886.901130988688;8176.754697359089;8437.15628437156;8447.15528447155;8592.742217733477;9643.662471813488;2490.5890528062846;2565.1534993452115;2577.922662320124;2578.6776652918384;2589.9223023309332;2542.580474221751;2551.362159460135;2569.190704927951;2604.1406335909105;2609.504194203105;2561.3724637463847;2565.0381107084845;2567.717551069381;2570.177543186181;2599.974000259992;2501.1371076978503;2510.0587279770084;2510.8870100845506;2513.39678477166;2526.1916186820226;2488.2659615413495;2488.701355837293;2492.4142826435773;2494.3764058985253;2496.0764517128778;9397.62409503619;9450.574724137361;9460.290478214161;9492.95253523728;9494.762630934212;5711.971440142773;5807.709614519257;5846.941530584725;5981.431763982415;5982.282126144847;3569.94645080324;3654.798986055766;3709.2581483703366;3729.738918275722;3745.606711295329;1170.455738081796;1211.8727533608933;1220.2556440571245;1220.6948262934266;1253.5988483685223;13551.186928784304;13622.659433514142;13773.586792396143;13774.311284435838;13782.379792909243;4991.101601711654;5122.897542049138;5167.22491626259;5195.934833359152;5321.909008653217;11501.597444089417;11541.711457213636;11548.364839933884;11549.711257218636;11552.191346605658;5749.913751293734;5757.510611598061;5778.248827652463;5782.045962416154;5794.159846822272;5189.169732842803;5290.470952904756;5291.047611429903;5437.102878025161;5494.862628434241;4380.540043295472;4396.802143903532;4454.354118652777;4503.977480112579;4506.369108324837;1385.923774192409;1402.4530433131088;1407.6551244945053;1415.2994267837487;1416.4546649540002;1031.3502493429241;1034.7723500829804;1040.2250323509033;1048.192891473561;1057.434272664121;6234.189555357774;6288.088227207121;6566.080748695186;6601.405873471314;6719.42884854783;513.6763838781618;539.7571093008162;543.9238506609078;544.9318835145607;547.7370861986269;4520.660950428731;4549.226631472658;4616.261398176276;4706.1999460091865;4722.456917454537;11702.356370399539;12105.757884842254;12220.083493738006;12221.694457638452;12256.938715306367;10784;12141;12154.75690486203;12183.75632487363;12219;8264.504129752235;8609.526476043753;8618.870716939251;8623.353248506388;8630.050694423608;6261.96869015652;6291.245050593958;6352.872942541216;6484.092227088306;6573.96713016451;11368.488418021374;11373.260738052;11492.080633549464;11513.827292590451;11572.24780389272;11182.273152245078;11339.943300283776;11442.027427668741;11618.593349232737;11632.069434445393;8314.62584183701;8448.450850694686;8448.535330556879;8455.95772021136;8462.576871156542;8996.59515321799;9263.814723705624;9324.580393882427;9328.207102396373;9337.159655631025;8163.469374490876;8346.374021948499;8428.704995325133;8446.619902104298;8472.279856212044;7843.960780196063;8160.224778646019;8186.713465028695;8219.465734727224;8336.083030866479;7208.89186662211;7317.268273172853;7346.77959661211;7353;7354.227806080498;5515.172724091419;5715.828525144252;5778.451047150514;5778.595498315078;5813.796517122049;5537.9169312459535;5538.833834984795;5754.884902302014;5767;5841.853953651193 05:12:14 INFO - PROCESS | 5330 | |4;prototype.html;335.8690110856765;335.91770016346;351.3500024953836;357.43882105094997;361.1404856441669;5388.622796404248;5575.553955683546;5642.605017648766;5659.490645841874;5673.744681489333;5368.731563421833;5466.508014278714;5505.9724701376535;5580.302462192226;5583.35791383991;4354;4377.912441751163;4384.934225986613;4390.42924419825;4404.669649776271;4166.458360413142;4233.640140588053;4301.483821941371;4346.066000629721;4359.891002724926;4307.741535507864;4310.676699247553;4315.5900189481945;4329.393884856123;4337.262665346899;4356.956430435686;4379.189849877751;4382.035952090535;4387.934180987288;4389.385486031958;3650.470681751131;3801.8479260829536;3810.466534685146;3813.8939707484797;3939.5075615548058;5340.652857564246;5367.382750983609;5369.047024136748;5370.167624018283;5380.488853558944;4935.555799977983;4941.258811178316;4942.159832828428;4952.4057113146655;5020.623453241022;5517.862053448655;5725.742341594639;5793.275840519935;5794.0739926337355;5860.296764388258;4221;4233.491980962273;4243;4271.700980931336;4274.1451709658195;5906.616069955439;6080.361562036011;6095.573309868311;6112.908306375408;6129.754809807602;4297.527272000078;4298.570142985739;4312.266914624522;4322.3516472528745;4331.242032644274;4135.648469880034;4364.432623758891;4396.780160992002;4411.845585404495;4420.624246938982;4804;4830.565249127595;4930.260460930889;4931.7040977541465;4964.453910069889;5768.779020077301;5787.392323806024;5788.610733423948;5792.160136780228;5808.6224395414165;1462.3638717158071;1497.7229212595705;1511.6296507355548;1515.8938874278915;1517.1579773225744;962.7881865989472;966.2703760269039;970.7281961050917;977.726236653738;983.1053741095569;4694.36626055485;4877.804887804448;4888.926666100011;4925.581325587365;4949.505049495022;5155.7679904404395;5160.948390516121;5172.1380303090855;5198.920431827224;5202.973985130126;4903.632227582874;4909.582685471775;4947.529984651453;4962.047581688889;4965.230389289666;2594;2763.706123917184;2778;2784.5962335461245;2789.9302517437227;5295.761690723926;5349.893002140013;5359.544438722674;5360.721693280419;5401.189821526802;5297.2454323751435;5341.839744807662;5349.903269829676;5381.381141168816;5450.400455949843;5376.865578360573;5756.280464941882;6161.168242287234;6187.741474361916;6194.473469754941;6002;6012.609180403259;6020.006698894808;6041.18444010053;6045.335013148638;5674.77300907959;5875.971704951531;5926.733297001559;6019;6035.486983606443;6151.876962460815;6158.476529494864;6163.229596300463;6169.537284703575;6175.783847565313;4262.190183865056;4279.657627389864;4319.48166220043;4326.83175542608;4329.177456283296;5621.80323688669;5693.430656934273;5931.08068249422;5971.790987315423;6142.416470435302;5854;5861.7655293787775;5864.208331875142;5867.178594996619;5880.353501019721;5642.981005162219;5758.913616295675;5874.647521148745;5912.733926973383;5915.142304365757;5794.3626201117;5801.5938884279385;5816.01127808282;5818.359980402237;5825.854353641193;5845.795397161079;5845.941540584709;5922.407759224043;5953.226080609493;5972.163897054503;5501.834944951498;5748.683822389641;5773.441170883922;5777.422257774189;5805.651660900359 05:12:14 INFO - PROCESS | 5330 | |5;yui.html;779.5011192836583;788.365365880466;801.2708435323852;803.4054799448409;921.3734660430904;14210.360533775978;14303.713925721479;14764.187969661678;16455.60127389172;17053.829461705394;15781.210939453038;15872.444464443717;15926;15962.361505539793;15966.600834979103;724.7608289264556;741.4179868802963;845.0915266088964;866.9812969760507;870.5908223135148;842.3598065470256;849.5921957460423;865.8095219051798;866.800635853754;866.9263112635433;888.6223355074068;892.0544223123477;892.7678803511069;893.5666201892077;893.6380765789833;743.1305372713938;760.6501009535621;889.9911000889973;890.4123278636101;891.0821853490883;646.3181343682413;661.1273119482286;665.930077341877;665.9966700166468;666.3702800853196;15209.239538023165;15237.542873713806;15252.0086194397;15289.235538223156;15305.31126099317;14113.153210807384;14168.149911005372;14182.858171418256;14195.148291102567;14397.928010359987;13031.152975056686;13040.869591304156;13082.803757943639;13102.08285420021;13211.14127581704;4722.76386180693;4747.762611869427;4779.498152693986;4828.179209534387;4839.951600483985;92728.53635731846;93454.72908448172;93492.53253733755;93589;94434.5278273611;11328.32030078198;11516.30902145874;11613.477393517313;11641.41792910368;11852.644420667393;19030.143643536074;19155.904220479086;19185.712214316798;19270.421887343404;19270.61458770845;8541.487510749375;8628.35287353451;8755.430896991675;8908.242799361997;9182.403143795766;4627.8611641650805;4718.3158442025715;4817.349657796222;4962.404511458576;5021.799128034838;3601.405768048295;3694.3719716735;3715.7398982071536;3735.738498305147;3737.7009839213342;640.2604991235131;649.9220093588705;651.212033439534;661.8577005943745;669.2638098092157;705.270045502902;716.9211386747454;724.3697982755037;727.1601300497933;733.5671953547433;8811.867821982676;8987.77530561728;9283.652870388176;9692.17616502591;9746;601.506764453153;638.250056183982;693.1301216972668;722.4328901812053;729.7154109897144;4726.858194254178;4728.38530990969;4894.730789806524;4913.77887995034;4960.255961605716;116020;125813;129783;130952.34523827319;133114.33442832725;113303.4334828337;114738.42630786792;118116.40941795237;118400;119273.40363298128;58097.70951145217;80679.19320806835;80711.19288807154;98039.50980245053;102116;9440.480773557245;9466.810663786824;9661.758456038655;10287.43419111956;10336.689899303034;53424;54503.72748136234;54871.451285488234;56090.719546402004;57761.42238577561;68693;81219.59390203012;83914;85527;85539.5723021381;13715.451381944611;13863.653408664864;13985.58043258704;14049.508267210598;14059.789103163665;15120.319585618454;15756.60608484797;15761.605959851095;16124.516264512084;16235;14534.63663408381;14869.256537173314;14879.256037198313;15000.099994000395;15486.380544778083;14784.852151478348;15059.924700376429;15150.242487875783;15226.543203703906;15709.057456552644;13697.371574658257;13768.586942391745;13989.160650361011;14333.64165895861;14860;12148.939255303667;12337.50649973991;12468.5012599495;12800.74398512006;13351.732965340445;12044.638660840188;12073.818892716792;12270.631881043582;12676.429560669607;12786.232826030468 05:12:14 INFO - PROCESS | 5330 | __end_tp_report 05:12:14 INFO - PROCESS | 5330 | __start_cc_report 05:12:14 INFO - PROCESS | 5330 | _x_x_mozilla_cycle_collect,922 05:12:14 INFO - PROCESS | 5330 | __end_cc_report 05:12:14 INFO - PROCESS | 5330 | __startTimestamp1475755934981__endTimestamp 05:12:14 INFO - PROCESS | 5330 | 05:12:14 INFO - PROCESS | 5330 | ------- Summary: start ------- 05:12:14 INFO - PROCESS | 5330 | Number of tests: 6 05:12:14 INFO - PROCESS | 5330 | 05:12:14 INFO - PROCESS | 5330 | [#0] dojo.html Cycles:165 Average:5660.59 Median:5870.21 stddev:660.06 (11.2%) stddev-sans-first:632.50 05:12:14 INFO - PROCESS | 5330 | Values: 3169.6 3208.0 3218.9 3236.7 3262.3 5622.2 5690.7 5714.3 5715.1 5747.1 5664.5 5744.0 5744.4 5744.5 5754.2 5184.3 5186.4 5204.8 5222.0 5252.3 5084.5 5112.7 5162.7 5259.5 5302.7 5160.8 5208.7 5216.5 5216.7 5224.9 5236.9 5237.5 5243.0 5245.8 5275.8 4882.6 4907.8 5135.7 5142.2 5208.8 5559.4 5569.5 5570.9 5572.8 5600.7 6042.5 6065.4 6092.3 6146.1 6147.1 5936.5 6160.8 6162.4 6184.2 6185.7 5580.6 5615.9 5626.2 5636.3 5665.8 6208.1 6213.4 6214.7 6221.0 6234.5 5785.2 5968.2 5975.8 5976.5 5984.9 5840.0 5983.9 6030.6 6037.8 6124.1 6063.8 6067.3 6069.5 6082.8 6089.9 6049.0 6050.0 6056.3 6058.9 6096.8 4530.9 4554.0 4630.9 4672.2 4674.4 4135.9 4154.9 4155.2 4157.2 4178.1 5800.5 5821.2 5827.6 5834.1 5858.5 5981.7 6037.0 6118.2 6127.3 6216.2 5879.2 5880.1 5882.1 5903.7 5917.8 5268.2 5269.5 5271.2 5277.1 5281.4 6073.1 6118.7 6293.9 6333.4 6353.7 6113.9 6225.9 6238.8 6244.4 6247.4 6334.7 6405.6 6408.5 6429.4 6441.0 5796.9 5835.3 6062.6 6068.2 6076.5 6004.5 6036.0 6041.7 6115.0 6144.9 5870.2 5912.0 5915.6 5916.6 5916.7 5686.6 5818.5 5822.2 5823.2 5826.2 5753.7 5956.5 6045.7 6061.6 6123.0 6169.5 6173.8 6179.6 6187.8 6192.8 5714.1 5759.4 5998.3 6012.5 6063.2 05:12:14 INFO - PROCESS | 5330 | 05:12:14 INFO - PROCESS | 5330 | [#1] ext.html Cycles:180 Average:63026.62 Median:3772.70 stddev:123133.18 (3263.8%) stddev-sans-first:123389.34 05:12:14 INFO - PROCESS | 5330 | Values: 582.4 600.0 626.7 641.8 648.6 34883.3 47233.0 48445.8 48507.8 48595.8 49132.5 49499.8 49690.5 49713.5 49741.8 8376.9 9322.0 9488.1 9493.4 9499.9 8392.6 11185.8 11607.1 11616.8 11631.1 11309.4 11375.2 11379.4 11385.7 11389.8 11256.2 11294.0 11304.3 11347.5 11353.1 11041.9 11128.6 11134.7 11134.7 11139.9 46459.1 46694.0 46836.3 46849.0 46851.5 3771.3 3774.1 3843.7 3996.0 4503.3 34973.8 35214.3 35326.1 35673.0 35972.0 4693.5 4743.1 4752.8 4763.2 4801.8 369725.0 370525.0 372413.0 372963.1 373719.0 60838.4 61187.4 61206.0 61213.0 61215.4 41913.6 42522.6 42746.8 44196.3 63649.0 20034.2 20086.2 20086.3 20203.3 20207.2 14485.9 14653.3 14731.0 15426.0 15530.4 20559.0 21646.4 21719.3 21726.8 21750.0 7435.4 7690.2 7789.8 7833.5 7861.9 965.6 1081.4 1098.2 1123.3 1161.1 34740.7 35081.0 35512.6 35603.5 35810.6 1131.6 1146.5 1172.8 1195.9 1233.5 17958.3 18425.9 18427.9 18476.3 18585.3 607391.0 613443.0 613539.0 614390.0 614767.0 65386.3 66077.3 66143.0 66184.3 66236.3 1317.5 1378.9 1381.4 1440.8 1465.9 31284.0 36522.0 36578.0 36647.6 36754.4 56399.0 57102.4 57149.4 57159.0 57230.4 362918.0 364672.0 364700.0 366016.0 367755.0 31370.4 31524.8 31761.7 32093.7 33484.2 52945.7 52982.7 53278.5 53519.0 54463.0 43668.6 44424.6 44717.6 45147.8 45692.5 45277.0 45873.8 45888.8 46082.5 46706.5 43591.8 44587.6 44807.8 45457.8 45481.8 37487.8 38912.4 39838.2 40303.2 40513.6 29453.7 29561.0 29886.1 30263.5 30268.8 05:12:14 INFO - PROCESS | 5330 | 05:12:14 INFO - PROCESS | 5330 | [#2] jquery.html Cycles:180 Average:31040.27 Median:13331.94 stddev:89172.93 (668.9%) stddev-sans-first:89393.39 05:12:14 INFO - PROCESS | 5330 | Values: 393.6 413.1 429.7 435.1 442.3 15805.6 19884.8 20635.7 21217.2 21944.8 20455.8 20463.9 20888.8 21041.2 21043.5 5854.4 5879.8 6125.6 6130.6 6136.3 5958.6 5991.4 6034.5 6046.2 6050.8 5777.2 5962.1 6003.5 6020.2 6021.6 5960.9 5982.6 6006.9 6009.7 6014.9 5349.6 5397.8 5422.6 5426.0 5428.4 24271.6 24604.8 24808.5 24823.8 25271.4 2329.2 2352.7 2368.7 2369.8 2392.2 10477.3 14682.9 15013.8 15041.6 15326.9 1895.2 1949.6 1994.3 2015.2 2052.6 81687.6 86053.6 86789.6 87092.6 88657.0 10569.8 10984.2 11784.6 12191.0 12309.7 15702.0 16518.9 16653.0 17088.1 17204.0 8843.3 8907.7 8951.3 9085.3 9305.6 8282.2 8298.7 8310.7 8504.4 8517.4 5069.3 5143.2 5149.4 5169.9 5217.8 2050.8 2074.9 2104.1 2120.7 2168.6 1012.8 1037.0 1040.3 1065.8 1099.7 20299.3 20519.8 20537.7 20758.8 20762.9 998.7 1026.2 1032.0 1035.3 1080.9 10026.0 11384.8 11505.0 11628.4 11734.0 524701.0 528731.0 543971.0 551251.0 560074.0 89880.0 91453.0 93527.0 95951.0 99410.0 1002.4 1030.2 1038.8 1054.9 1056.6 17892.6 18336.9 18409.8 18795.7 18879.4 31697.7 40078.0 42151.0 44537.0 45579.0 58362.4 59616.4 60091.7 60267.7 60999.0 6295.0 8164.3 8333.6 8780.5 9338.3 10163.6 13596.7 13676.9 13840.0 14005.6 6433.4 8697.3 11633.8 11935.9 12002.0 11398.3 11431.0 11440.9 11658.2 12265.6 12026.9 12140.6 12231.8 12257.9 12341.5 8135.5 8211.0 8223.6 8240.4 8576.4 9312.4 11763.6 11893.5 12007.3 12293.6 05:12:14 INFO - PROCESS | 5330 | 05:12:14 INFO - PROCESS | 5330 | [#3] mootools.html Cycles:180 Average:6329.55 Median:5057.00 stddev:3641.02 (72.0%) stddev-sans-first:3633.57 05:12:14 INFO - PROCESS | 5330 | Values: 1557.0 1599.7 1730.1 1789.9 1838.0 9193.9 9877.3 9886.0 9886.5 9886.9 8176.8 8437.2 8447.2 8592.7 9643.7 2490.6 2565.2 2577.9 2578.7 2589.9 2542.6 2551.4 2569.2 2604.1 2609.5 2561.4 2565.0 2567.7 2570.2 2600.0 2501.1 2510.1 2510.9 2513.4 2526.2 2488.3 2488.7 2492.4 2494.4 2496.1 9397.6 9450.6 9460.3 9493.0 9494.8 5712.0 5807.7 5846.9 5981.4 5982.3 3569.9 3654.8 3709.3 3729.7 3745.6 1170.5 1211.9 1220.3 1220.7 1253.6 13551.2 13622.7 13773.6 13774.3 13782.4 4991.1 5122.9 5167.2 5195.9 5321.9 11501.6 11541.7 11548.4 11549.7 11552.2 5749.9 5757.5 5778.2 5782.0 5794.2 5189.2 5290.5 5291.0 5437.1 5494.9 4380.5 4396.8 4454.4 4504.0 4506.4 1385.9 1402.5 1407.7 1415.3 1416.5 1031.4 1034.8 1040.2 1048.2 1057.4 6234.2 6288.1 6566.1 6601.4 6719.4 513.7 539.8 543.9 544.9 547.7 4520.7 4549.2 4616.3 4706.2 4722.5 11702.4 12105.8 12220.1 12221.7 12256.9 10784.0 12141.0 12154.8 12183.8 12219.0 8264.5 8609.5 8618.9 8623.4 8630.1 6262.0 6291.2 6352.9 6484.1 6574.0 11368.5 11373.3 11492.1 11513.8 11572.2 11182.3 11339.9 11442.0 11618.6 11632.1 8314.6 8448.5 8448.5 8456.0 8462.6 8996.6 9263.8 9324.6 9328.2 9337.2 8163.5 8346.4 8428.7 8446.6 8472.3 7844.0 8160.2 8186.7 8219.5 8336.1 7208.9 7317.3 7346.8 7353.0 7354.2 5515.2 5715.8 5778.5 5778.6 5813.8 5537.9 5538.8 5754.9 5767.0 5841.9 05:12:14 INFO - PROCESS | 5330 | 05:12:14 INFO - PROCESS | 5330 | [#4] prototype.html Cycles:180 Average:4793.53 Median:5354.72 stddev:1405.43 (26.2%) stddev-sans-first:1368.97 05:12:14 INFO - PROCESS | 5330 | Values: 335.9 335.9 351.4 357.4 361.1 5388.6 5575.6 5642.6 5659.5 5673.7 5368.7 5466.5 5506.0 5580.3 5583.4 4354.0 4377.9 4384.9 4390.4 4404.7 4166.5 4233.6 4301.5 4346.1 4359.9 4307.7 4310.7 4315.6 4329.4 4337.3 4357.0 4379.2 4382.0 4387.9 4389.4 3650.5 3801.8 3810.5 3813.9 3939.5 5340.7 5367.4 5369.0 5370.2 5380.5 4935.6 4941.3 4942.2 4952.4 5020.6 5517.9 5725.7 5793.3 5794.1 5860.3 4221.0 4233.5 4243.0 4271.7 4274.1 5906.6 6080.4 6095.6 6112.9 6129.8 4297.5 4298.6 4312.3 4322.4 4331.2 4135.6 4364.4 4396.8 4411.8 4420.6 4804.0 4830.6 4930.3 4931.7 4964.5 5768.8 5787.4 5788.6 5792.2 5808.6 1462.4 1497.7 1511.6 1515.9 1517.2 962.8 966.3 970.7 977.7 983.1 4694.4 4877.8 4888.9 4925.6 4949.5 5155.8 5160.9 5172.1 5198.9 5203.0 4903.6 4909.6 4947.5 4962.0 4965.2 2594.0 2763.7 2778.0 2784.6 2789.9 5295.8 5349.9 5359.5 5360.7 5401.2 5297.2 5341.8 5349.9 5381.4 5450.4 5376.9 5756.3 6161.2 6187.7 6194.5 6002.0 6012.6 6020.0 6041.2 6045.3 5674.8 5876.0 5926.7 6019.0 6035.5 6151.9 6158.5 6163.2 6169.5 6175.8 4262.2 4279.7 4319.5 4326.8 4329.2 5621.8 5693.4 5931.1 5971.8 6142.4 5854.0 5861.8 5864.2 5867.2 5880.4 5643.0 5758.9 5874.6 5912.7 5915.1 5794.4 5801.6 5816.0 5818.4 5825.9 5845.8 5845.9 5922.4 5953.2 5972.2 5501.8 5748.7 5773.4 5777.4 5805.7 05:12:14 INFO - PROCESS | 5330 | 05:12:14 INFO - PROCESS | 5330 | [#5] yui.html Cycles:180 Average:22619.49 Median:4724.81 stddev:33626.05 (711.7%) stddev-sans-first:33680.39 05:12:14 INFO - PROCESS | 5330 | Values: 779.5 788.4 801.3 803.4 921.4 14210.4 14303.7 14764.2 16455.6 17053.8 15781.2 15872.4 15926.0 15962.4 15966.6 724.8 741.4 845.1 867.0 870.6 842.4 849.6 865.8 866.8 866.9 888.6 892.1 892.8 893.6 893.6 743.1 760.7 890.0 890.4 891.1 646.3 661.1 665.9 666.0 666.4 15209.2 15237.5 15252.0 15289.2 15305.3 14113.2 14168.1 14182.9 14195.1 14397.9 13031.2 13040.9 13082.8 13102.1 13211.1 4722.8 4747.8 4779.5 4828.2 4840.0 92728.5 93454.7 93492.5 93589.0 94434.5 11328.3 11516.3 11613.5 11641.4 11852.6 19030.1 19155.9 19185.7 19270.4 19270.6 8541.5 8628.4 8755.4 8908.2 9182.4 4627.9 4718.3 4817.3 4962.4 5021.8 3601.4 3694.4 3715.7 3735.7 3737.7 640.3 649.9 651.2 661.9 669.3 705.3 716.9 724.4 727.2 733.6 8811.9 8987.8 9283.7 9692.2 9746.0 601.5 638.3 693.1 722.4 729.7 4726.9 4728.4 4894.7 4913.8 4960.3 116020.0 125813.0 129783.0 130952.3 133114.3 113303.4 114738.4 118116.4 118400.0 119273.4 58097.7 80679.2 80711.2 98039.5 102116.0 9440.5 9466.8 9661.8 10287.4 10336.7 53424.0 54503.7 54871.5 56090.7 57761.4 68693.0 81219.6 83914.0 85527.0 85539.6 13715.5 13863.7 13985.6 14049.5 14059.8 15120.3 15756.6 15761.6 16124.5 16235.0 14534.6 14869.3 14879.3 15000.1 15486.4 14784.9 15059.9 15150.2 15226.5 15709.1 13697.4 13768.6 13989.2 14333.6 14860.0 12148.9 12337.5 12468.5 12800.7 13351.7 12044.6 12073.8 12270.6 12676.4 12786.2 05:12:14 INFO - PROCESS | 5330 | -------- Summary: end -------- 05:12:14 INFO - PROCESS | 5330 | 05:12:15 INFO - TEST-INFO | 5330: exit 0 05:12:15 INFO - TEST-OK | dromaeo_css | took 1112890ms 05:12:15 INFO - TEST-START | kraken 05:12:15 INFO - operating with platform_type : linux_ 05:12:15 INFO - Initialising browser for kraken test... 05:12:15 INFO - TEST-INFO | started process 5651 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG_XLi5/profile http://localhost:59898/getInfo.html) 05:12:19 INFO - PROCESS | 5651 | __metrics Screen width/height:1600/1200 05:12:19 INFO - PROCESS | 5651 | colorDepth:24 05:12:19 INFO - PROCESS | 5651 | Browser inner width/height: 1024/697 05:12:19 INFO - PROCESS | 5651 | __metrics 05:12:19 INFO - PROCESS | 5651 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:12:19 INFO - PROCESS | 5651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:12:20 INFO - PROCESS | 5651 | console.error: PushService: 05:12:20 INFO - PROCESS | 5651 | stateChangeProcessEnqueue: Error transitioning state 05:12:20 INFO - PROCESS | 5651 | UnknownError 05:12:21 INFO - TEST-INFO | 5651: exit 0 05:12:21 INFO - Browser initialized. 05:12:21 INFO - Running cycle 1/1 for kraken test... 05:12:21 INFO - TEST-INFO | started process 5743 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG_XLi5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:12:32 INFO - PROCESS | 5743 | RSS: Main: 144830464 05:12:32 INFO - PROCESS | 5743 | 05:12:35 INFO - PROCESS | 5743 | Cycle 1(1): loaded http://localhost:59898/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59898/tests/kraken/driver.html?testName=audio-beat-detection) 05:12:36 INFO - PROCESS | 5743 | RSS: Main: 187019264 05:12:36 INFO - PROCESS | 5743 | 05:12:38 INFO - PROCESS | 5743 | Cycle 1(1): loaded http://localhost:59898/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59898/tests/kraken/driver.html?testName=audio-dft) 05:12:39 INFO - PROCESS | 5743 | RSS: Main: 176361472 05:12:39 INFO - PROCESS | 5743 | 05:12:42 INFO - PROCESS | 5743 | Cycle 1(1): loaded http://localhost:59898/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59898/tests/kraken/driver.html?testName=audio-fft) 05:12:42 INFO - PROCESS | 5743 | RSS: Main: 267952128 05:12:42 INFO - PROCESS | 5743 | 05:12:44 INFO - PROCESS | 5743 | Cycle 1(1): loaded http://localhost:59898/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59898/tests/kraken/driver.html?testName=audio-oscillator) 05:12:45 INFO - PROCESS | 5743 | RSS: Main: 174288896 05:12:45 INFO - PROCESS | 5743 | 05:12:47 INFO - PROCESS | 5743 | Cycle 1(1): loaded http://localhost:59898/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59898/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:12:48 INFO - PROCESS | 5743 | RSS: Main: 175636480 05:12:48 INFO - PROCESS | 5743 | 05:12:51 INFO - PROCESS | 5743 | Cycle 1(1): loaded http://localhost:59898/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59898/tests/kraken/driver.html?testName=imaging-darkroom) 05:12:51 INFO - PROCESS | 5743 | RSS: Main: 210857984 05:12:51 INFO - PROCESS | 5743 | 05:12:55 INFO - PROCESS | 5743 | Cycle 1(1): loaded http://localhost:59898/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59898/tests/kraken/driver.html?testName=imaging-desaturate) 05:12:55 INFO - PROCESS | 5743 | RSS: Main: 209805312 05:12:55 INFO - PROCESS | 5743 | 05:12:58 INFO - PROCESS | 5743 | Cycle 1(1): loaded http://localhost:59898/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59898/tests/kraken/driver.html?testName=json-parse-financial) 05:12:58 INFO - PROCESS | 5743 | RSS: Main: 209731584 05:12:58 INFO - PROCESS | 5743 | 05:13:00 INFO - PROCESS | 5743 | Cycle 1(1): loaded http://localhost:59898/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59898/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:13:01 INFO - PROCESS | 5743 | RSS: Main: 171651072 05:13:01 INFO - PROCESS | 5743 | 05:13:02 INFO - PROCESS | 5743 | Cycle 1(1): loaded http://localhost:59898/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59898/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:13:03 INFO - PROCESS | 5743 | RSS: Main: 179232768 05:13:03 INFO - PROCESS | 5743 | 05:13:05 INFO - PROCESS | 5743 | Cycle 1(1): loaded http://localhost:59898/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59898/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:13:05 INFO - PROCESS | 5743 | RSS: Main: 188579840 05:13:05 INFO - PROCESS | 5743 | 05:13:08 INFO - PROCESS | 5743 | Cycle 1(1): loaded http://localhost:59898/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59898/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:13:09 INFO - PROCESS | 5743 | RSS: Main: 197001216 05:13:09 INFO - PROCESS | 5743 | 05:13:11 INFO - PROCESS | 5743 | Cycle 1(1): loaded http://localhost:59898/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59898/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:13:12 INFO - PROCESS | 5743 | RSS: Main: 193961984 05:13:12 INFO - PROCESS | 5743 | 05:13:14 INFO - PROCESS | 5743 | Cycle 1(1): loaded http://localhost:59898/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59898/tests/kraken/driver.html?testName=ai-astar) 05:13:14 INFO - PROCESS | 5743 | RSS: Main: 244916224 05:13:14 INFO - PROCESS | 5743 | 05:13:14 INFO - PROCESS | 5743 | __start_tp_report 05:13:14 INFO - PROCESS | 5743 | _x_x_mozilla_page_load 05:13:14 INFO - PROCESS | 5743 | _x_x_mozilla_page_load_details 05:13:14 INFO - PROCESS | 5743 | |i|pagename|runs| 05:13:14 INFO - PROCESS | 5743 | |0;ai-astar;109;112;110;111;113;113;111;111;113;111 05:13:14 INFO - PROCESS | 5743 | |1;audio-beat-detection;151;120;141;158;119;120;117;119;147;122 05:13:14 INFO - PROCESS | 5743 | |2;audio-dft;161;161;159;163;160;160;161;161;160;160 05:13:14 INFO - PROCESS | 5743 | |3;audio-fft;74;75;76;118;76;76;76;75;100;75 05:13:14 INFO - PROCESS | 5743 | |4;audio-oscillator;82;81;124;82;82;81;100;80;81;111 05:13:14 INFO - PROCESS | 5743 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 05:13:14 INFO - PROCESS | 5743 | |6;imaging-darkroom;146;147;146;146;147;146;146;146;147;145 05:13:14 INFO - PROCESS | 5743 | |7;imaging-desaturate;95;94;94;94;95;95;95;95;95;94 05:13:14 INFO - PROCESS | 5743 | |8;json-parse-financial;50;49;49;50;48;49;48;51;48;50 05:13:14 INFO - PROCESS | 5743 | |9;json-stringify-tinderbox;59;59;59;59;60;59;60;59;60;60 05:13:14 INFO - PROCESS | 5743 | |10;stanford-crypto-aes;81;75;73;74;80;74;73;79;73;73 05:13:14 INFO - PROCESS | 5743 | |11;stanford-crypto-ccm;133;131;122;122;127;120;121;120;158;119 05:13:14 INFO - PROCESS | 5743 | |12;stanford-crypto-pbkdf2;156;158;154;153;152;155;151;150;152;152 05:13:14 INFO - PROCESS | 5743 | |13;stanford-crypto-sha256-iterative;63;63;63;63;63;68;63;63;61;60 05:13:14 INFO - PROCESS | 5743 | __end_tp_report 05:13:14 INFO - PROCESS | 5743 | __start_cc_report 05:13:14 INFO - PROCESS | 5743 | _x_x_mozilla_cycle_collect,1618 05:13:14 INFO - PROCESS | 5743 | __end_cc_report 05:13:14 INFO - PROCESS | 5743 | __startTimestamp1475755994262__endTimestamp 05:13:14 INFO - PROCESS | 5743 | 05:13:14 INFO - PROCESS | 5743 | ------- Summary: start ------- 05:13:14 INFO - PROCESS | 5743 | Number of tests: 14 05:13:14 INFO - PROCESS | 5743 | 05:13:14 INFO - PROCESS | 5743 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.50 stddev:1.35 (1.2%) stddev-sans-first:1.12 05:13:14 INFO - PROCESS | 5743 | Values: 109.0 112.0 110.0 111.0 113.0 113.0 111.0 111.0 113.0 111.0 05:13:14 INFO - PROCESS | 5743 | 05:13:14 INFO - PROCESS | 5743 | [#1] audio-beat-detection Cycles:10 Average:131.40 Median:131.50 stddev:15.95 (12.1%) stddev-sans-first:15.26 05:13:14 INFO - PROCESS | 5743 | Values: 151.0 120.0 141.0 158.0 119.0 120.0 117.0 119.0 147.0 122.0 05:13:14 INFO - PROCESS | 5743 | 05:13:14 INFO - PROCESS | 5743 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 05:13:14 INFO - PROCESS | 5743 | Values: 161.0 161.0 159.0 163.0 160.0 160.0 161.0 161.0 160.0 160.0 05:13:14 INFO - PROCESS | 5743 | 05:13:14 INFO - PROCESS | 5743 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.50 stddev:14.81 (19.6%) stddev-sans-first:15.42 05:13:14 INFO - PROCESS | 5743 | Values: 74.0 75.0 76.0 118.0 76.0 76.0 76.0 75.0 100.0 75.0 05:13:14 INFO - PROCESS | 5743 | 05:13:14 INFO - PROCESS | 5743 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:81.00 stddev:15.74 (19.4%) stddev-sans-first:16.40 05:13:14 INFO - PROCESS | 5743 | Values: 82.0 81.0 124.0 82.0 82.0 81.0 100.0 80.0 81.0 111.0 05:13:14 INFO - PROCESS | 5743 | 05:13:14 INFO - PROCESS | 5743 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 05:13:14 INFO - PROCESS | 5743 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 05:13:14 INFO - PROCESS | 5743 | 05:13:14 INFO - PROCESS | 5743 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 05:13:14 INFO - PROCESS | 5743 | Values: 146.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 147.0 145.0 05:13:14 INFO - PROCESS | 5743 | 05:13:14 INFO - PROCESS | 5743 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:13:14 INFO - PROCESS | 5743 | Values: 95.0 94.0 94.0 94.0 95.0 95.0 95.0 95.0 95.0 94.0 05:13:14 INFO - PROCESS | 5743 | 05:13:14 INFO - PROCESS | 5743 | [#8] json-parse-financial Cycles:10 Average:49.20 Median:49.50 stddev:1.03 (2.1%) stddev-sans-first:1.05 05:13:14 INFO - PROCESS | 5743 | Values: 50.0 49.0 49.0 50.0 48.0 49.0 48.0 51.0 48.0 50.0 05:13:14 INFO - PROCESS | 5743 | 05:13:14 INFO - PROCESS | 5743 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 05:13:14 INFO - PROCESS | 5743 | Values: 59.0 59.0 59.0 59.0 60.0 59.0 60.0 59.0 60.0 60.0 05:13:14 INFO - PROCESS | 5743 | 05:13:14 INFO - PROCESS | 5743 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:74.50 stddev:3.21 (4.3%) stddev-sans-first:2.71 05:13:14 INFO - PROCESS | 5743 | Values: 81.0 75.0 73.0 74.0 80.0 74.0 73.0 79.0 73.0 73.0 05:13:14 INFO - PROCESS | 5743 | 05:13:14 INFO - PROCESS | 5743 | [#11] stanford-crypto-ccm Cycles:10 Average:127.30 Median:124.50 stddev:11.83 (9.5%) stddev-sans-first:12.37 05:13:14 INFO - PROCESS | 5743 | Values: 133.0 131.0 122.0 122.0 127.0 120.0 121.0 120.0 158.0 119.0 05:13:14 INFO - PROCESS | 5743 | 05:13:14 INFO - PROCESS | 5743 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.30 Median:153.50 stddev:2.45 (1.6%) stddev-sans-first:2.40 05:13:14 INFO - PROCESS | 5743 | Values: 156.0 158.0 154.0 153.0 152.0 155.0 151.0 150.0 152.0 152.0 05:13:14 INFO - PROCESS | 5743 | 05:13:14 INFO - PROCESS | 5743 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:2.05 (3.3%) stddev-sans-first:2.18 05:13:14 INFO - PROCESS | 5743 | Values: 63.0 63.0 63.0 63.0 63.0 68.0 63.0 63.0 61.0 60.0 05:13:14 INFO - PROCESS | 5743 | -------- Summary: end -------- 05:13:14 INFO - PROCESS | 5743 | 05:13:15 INFO - TEST-INFO | 5743: exit 0 05:13:15 INFO - TEST-OK | kraken | took 59541ms 05:13:15 INFO - SUITE-END | took 1172s 05:13:15 INFO - Completed test suite (00:19:32) 05:13:15 INFO - javascript benchmark 05:13:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3169.6037995250595, 3208.0055182893307, 3218.9195270118257, 3236.70869621734, 3262.2986057997527, 5622.240997465341, 5690.743916523756, 5714.314282286132, 5715.142728590714, 5747.080467125255, 5664.5468362531, 5743.9712801435935, 5744.425557444253, 5744.511716504102, 5754.223179870716, 5184.326037615105, 5186.429492755803, 5204.817831375903, 5222.033923724104, 5252.290940723011, 5084.51697088776, 5112.718800465973, 5162.664426812264, 5259.526642602165, 5302.708351040691, 5160.767765450545, 5208.687478751287, 5216.504432078947, 5216.713080780555, 5224.869378265555, 5236.921446178291, 5237.528622423981, 5242.97378513105, 5245.763940622681, 5275.762590683428, 4882.609391248727, 4907.754612269372, 5135.743212839343, 5142.177251639757, 5208.765605547722, 5559.388467268597, 5569.498745112919, 5570.888582228374, 5572.7770889164385, 5600.719964001824, 6042.516598672096, 6065.393460653943, 6092.299385570672, 6146.139540464339, 6147.139400483936, 5936.465718085393, 6160.7535698572, 6162.414570615784, 6184.196054512884, 6185.690715464209, 5580.581456390746, 5615.859603509904, 5626.212330273765, 5636.2954630671165, 5665.801696940587, 6208.1308616793685, 6213.440790328892, 6214.689265536705, 6221.035739460391, 6234.501239900797, 5785.218995435563, 5968.1644569760265, 5975.820725378246, 5976.491998180203, 5984.910226346521, 5840.0, 5983.880322393527, 6030.6080104793045, 6037.849053773603, 6124.142620033199, 6063.818085457443, 6067.271927368655, 6069.453749162597, 6082.817515474543, 6089.878202435926, 6049.0, 6050.031994880798, 6056.303525094582, 6058.878822423527, 6096.817095487142, 4530.909381812346, 4553.954460455419, 4630.907381852344, 4672.18236808564, 4674.415698037746, 4135.9172816544105, 4154.91690166195, 4155.189738001121, 4157.189348077157, 4178.101708132766, 5800.506956908625, 5821.155932389865, 5827.621204621771, 5834.095715164071, 5858.50202732764, 5981.730822112929, 6037.034074548052, 6118.192813661829, 6127.295361033449, 6216.222972128484, 5879.20630714848, 5880.147378630075, 5882.147088672119, 5903.704814759245, 5917.7928772493615, 5268.15709486488, 5269.473052694777, 5271.182966640177, 5277.1292736698015, 5281.392639846466, 6073.058675905242, 6118.694065296718, 6293.905591416224, 6333.429991300805, 6353.745850166034, 6113.908291375722, 6225.875482490234, 6238.844028899314, 6244.438000579969, 6247.437730604267, 6334.651594162366, 6405.647689377129, 6408.487321014214, 6429.38920802523, 6441.033844923299, 5796.913046304225, 5835.299764028344, 6062.636241825505, 6068.241469816273, 6076.51387888959, 6004.5496587755215, 6036.0, 6041.728122234422, 6115.0273862886115, 6144.938550614436, 5870.207521984648, 5912.024515954819, 5915.645061296336, 5916.615419997686, 5916.704164791657, 5686.57350698691, 5818.505427038749, 5822.214001109796, 5823.213866128188, 5826.213461182686, 5753.683547404933, 5956.523478121827, 6045.667488288186, 6061.605995610271, 6122.97760420812, 6169.5064394849205, 6173.783917562864, 6179.62922224668, 6187.783427580013, 6192.783252586138, 5714.114312281603, 5759.395263497272, 5998.3401825798255, 6012.549058820518, 6063.181470501426], "value": 5614.5656585472225, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.4437662032759, 599.9970000149999, 626.6897885546654, 641.8202903187109, 648.607592406594, 34883.3023339533, 47233.0, 48445.75777121114, 48507.757461212736, 48595.75702121484, 49132.50867491324, 49499.752501237446, 49690.50309496913, 49713.50286497134, 49741.75129124349, 8376.874346884802, 9321.999999999984, 9488.05119488049, 9493.430394176337, 9499.905000950006, 8392.622331995044, 11185.776284474347, 11607.071434285279, 11616.825747613793, 11631.069514438866, 11309.434528273594, 11375.20373573846, 11379.374134422604, 11385.658430247106, 11389.829152562717, 11256.155788315868, 11294.0, 11304.321740695503, 11347.489362978644, 11353.148513861412, 11041.944790275997, 11128.554857805679, 11134.721631959184, 11134.721631959184, 11139.888601113966, 46459.07081858378, 46694.0, 46836.297455538195, 46849.0, 46851.53148468506, 3771.283456143324, 3774.1130834253927, 3843.692504599653, 3996.040950171967, 4503.301988191835, 34973.82513087418, 35214.295714085834, 35326.116847078774, 35673.0, 35972.0, 4693.460252070987, 4743.09881122589, 4752.786124624366, 4763.2278807605235, 4801.759912004421, 369725.0, 370525.0, 372413.0, 372963.13518432504, 373719.0, 60838.391616084155, 61187.38812611906, 61206.0, 61213.0, 61215.38784612186, 41913.58086419097, 42522.57477425248, 42746.78626606847, 44196.337054944204, 63649.0, 20034.196922277064, 20086.196552138044, 20086.296979605642, 20203.292884748964, 20207.191712331634, 14485.85514144845, 14653.34059967304, 14731.0, 15426.0, 15530.378784848479, 20559.0, 21646.350609481742, 21719.348419547438, 21726.782732172793, 21750.0, 7435.367993720486, 7690.230976902377, 7789.844203115906, 7833.451658383972, 7861.921380786233, 965.6234068713208, 1081.416035340907, 1098.1763677242068, 1123.27548731068, 1161.1407558406718, 34740.652593474246, 35081.0, 35512.64487355145, 35603.4659480108, 35810.64189358073, 1131.588261391904, 1146.4898120336536, 1172.783035138502, 1195.8564972203392, 1233.5127624588238, 17958.281668733103, 18425.907870460564, 18427.90786046061, 18476.260949561867, 18585.25658973626, 607391.0, 613443.0, 613539.0, 614390.0, 614767.0, 65386.346136538974, 66077.33922660808, 66143.0, 66184.33815661781, 66236.33763662302, 1317.4927652853528, 1378.9379477923517, 1381.4267079162237, 1440.8054912586877, 1465.9413623455155, 31284.0, 36522.0, 36578.0, 36647.63352366442, 36754.448683269235, 56399.0, 57102.42897571137, 57149.428505716074, 57159.0, 57230.42769572251, 362918.0, 364672.0, 364700.0, 366016.0, 367755.0, 31370.372592548476, 31524.842375788892, 31761.682383176798, 32093.67906320907, 33484.162895927795, 52945.7352713234, 52982.73508632432, 53278.46721532735, 53519.0, 54463.0, 43668.56331436645, 44424.55575444333, 44717.55282447134, 45147.83814570901, 45692.54307456883, 45277.0, 45873.77063114663, 45888.77055614834, 46082.450151793266, 46706.53293467158, 43591.782041089595, 44587.55412445964, 44807.77596111999, 45457.77271113623, 45481.77259113683, 37487.81256093702, 38912.41631375475, 39838.20323593454, 40303.19393612053, 40513.59486405216, 29453.705462945098, 29561.0, 29886.057406268523, 30263.546046809755, 30268.84865575658], "value": 22013.836343177976, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.64375240407406, 413.1221155045528, 429.7249760153502, 435.13191183588737, 442.28129289903904, 15805.604859878495, 19884.801151988493, 20635.690464643023, 21217.151313947423, 21944.780552194472, 20455.795442045575, 20463.897680511578, 20888.791112088875, 21041.158353665873, 21043.47391315218, 5854.356020837705, 5879.823605291848, 6125.5712100153005, 6130.570860039799, 6136.325004249551, 5958.553108516857, 5991.370906054867, 6034.547408944325, 6046.244219472566, 6050.788222412217, 5777.19119323295, 5962.135490353896, 6003.519718422515, 6020.217371741667, 6021.608595441304, 5960.910586341209, 5982.581219314649, 6006.879862402728, 6009.669468179249, 6014.939850601481, 5349.598780091509, 5397.78408863645, 5422.593305502103, 5426.0, 5428.37573679028, 24271.63592546113, 24604.753952460425, 24808.503829923302, 24823.751762482323, 25271.36821579475, 2329.1847853251397, 2352.7059117610297, 2368.656544800994, 2369.8104151667826, 2392.234484964812, 10477.31897426665, 14682.853171468363, 15013.849861501354, 15041.623959401102, 15326.923365383213, 1895.2324308655018, 1949.6295703816372, 1994.2920263306607, 2015.2342109998108, 2052.5894821035704, 81687.5915620424, 86053.56973215094, 86789.56605216934, 87092.56453717755, 88656.99999999936, 10569.788604227871, 10984.231103822816, 11784.584160247128, 12191.0, 12309.692257693629, 15702.0, 16518.917405412896, 16653.0, 17088.145592720313, 17204.0, 8843.292536597057, 8907.663850422488, 8951.283897288202, 9085.273178145733, 9305.581248843682, 8282.17178282167, 8298.70954516589, 8310.667573297122, 8504.362172837062, 8517.403781735344, 5069.264956581275, 5143.202803565453, 5149.382074151126, 5169.948300516947, 5217.765200565984, 2050.846186536016, 2074.9481262968243, 2104.105755054096, 2120.660694288906, 2168.5662867426577, 1012.7716782433312, 1036.968890933258, 1040.328987802863, 1065.8294672852307, 1099.7140743406771, 20299.289524866854, 20519.794802051787, 20537.691934620994, 20758.792412075687, 20762.896185518977, 998.6904059741504, 1026.1636766035658, 1032.0453580438066, 1035.2804800663616, 1080.9243352965375, 10026.0, 11384.829227561593, 11505.0, 11628.360440175871, 11734.0, 524701.0, 528731.0, 543971.0, 551251.0, 560074.0, 89880.0, 91453.0, 93527.0, 95951.0, 99410.0, 1002.4286156890648, 1030.1501261459325, 1038.7610849504506, 1054.9103326217357, 1056.5668076088766, 17892.55268618295, 18336.90831545834, 18409.778917077652, 18795.718064228775, 18879.43361699151, 31697.683023169473, 40078.0, 42151.0, 44537.0, 45579.0, 58362.4163758374, 59616.403835961086, 60091.69954150376, 60267.69866150641, 60999.0, 6294.968525157345, 8164.346852251924, 8333.583320834055, 8780.51707156087, 9338.299627527827, 10163.593456261668, 13596.66008349799, 13676.863231367957, 13840.040286593208, 14005.579832605039, 6433.420992110732, 8697.304215662605, 11633.778453262286, 11935.880641193477, 12002.0, 11398.259113157617, 11431.02836258894, 11440.885591144315, 11658.242214256046, 12265.632031039084, 12026.879731202576, 12140.575079872162, 12231.816522751988, 12257.93551612097, 12341.50633974631, 8135.471194372347, 8210.958945205235, 8223.588820559067, 8240.381971352053, 8576.399652024547, 9312.44125352481, 11763.588274410697, 11893.524259029542, 12007.279563226235, 12293.631191064282], "value": 9609.767121051327, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1556.987957827412, 1599.6800639872024, 1730.1435789284305, 1789.8657600679953, 1837.970736387624, 9193.862092068615, 9877.308588398815, 9886.0, 9886.456244906527, 9886.901130988688, 8176.754697359089, 8437.15628437156, 8447.15528447155, 8592.742217733477, 9643.662471813488, 2490.5890528062846, 2565.1534993452115, 2577.922662320124, 2578.6776652918384, 2589.9223023309332, 2542.580474221751, 2551.362159460135, 2569.190704927951, 2604.1406335909105, 2609.504194203105, 2561.3724637463847, 2565.0381107084845, 2567.717551069381, 2570.177543186181, 2599.974000259992, 2501.1371076978503, 2510.0587279770084, 2510.8870100845506, 2513.39678477166, 2526.1916186820226, 2488.2659615413495, 2488.701355837293, 2492.4142826435773, 2494.3764058985253, 2496.0764517128778, 9397.62409503619, 9450.574724137361, 9460.290478214161, 9492.95253523728, 9494.762630934212, 5711.971440142773, 5807.709614519257, 5846.941530584725, 5981.431763982415, 5982.282126144847, 3569.94645080324, 3654.798986055766, 3709.2581483703366, 3729.738918275722, 3745.606711295329, 1170.455738081796, 1211.8727533608933, 1220.2556440571245, 1220.6948262934266, 1253.5988483685223, 13551.186928784304, 13622.659433514142, 13773.586792396143, 13774.311284435838, 13782.379792909243, 4991.101601711654, 5122.897542049138, 5167.22491626259, 5195.934833359152, 5321.909008653217, 11501.597444089417, 11541.711457213636, 11548.364839933884, 11549.711257218636, 11552.191346605658, 5749.913751293734, 5757.510611598061, 5778.248827652463, 5782.045962416154, 5794.159846822272, 5189.169732842803, 5290.470952904756, 5291.047611429903, 5437.102878025161, 5494.862628434241, 4380.540043295472, 4396.802143903532, 4454.354118652777, 4503.977480112579, 4506.369108324837, 1385.923774192409, 1402.4530433131088, 1407.6551244945053, 1415.2994267837487, 1416.4546649540002, 1031.3502493429241, 1034.7723500829804, 1040.2250323509033, 1048.192891473561, 1057.434272664121, 6234.189555357774, 6288.088227207121, 6566.080748695186, 6601.405873471314, 6719.42884854783, 513.6763838781618, 539.7571093008162, 543.9238506609078, 544.9318835145607, 547.7370861986269, 4520.660950428731, 4549.226631472658, 4616.261398176276, 4706.1999460091865, 4722.456917454537, 11702.356370399539, 12105.757884842254, 12220.083493738006, 12221.694457638452, 12256.938715306367, 10784.0, 12141.0, 12154.75690486203, 12183.75632487363, 12219.0, 8264.504129752235, 8609.526476043753, 8618.870716939251, 8623.353248506388, 8630.050694423608, 6261.96869015652, 6291.245050593958, 6352.872942541216, 6484.092227088306, 6573.96713016451, 11368.488418021374, 11373.260738052, 11492.080633549464, 11513.827292590451, 11572.24780389272, 11182.273152245078, 11339.943300283776, 11442.027427668741, 11618.593349232737, 11632.069434445393, 8314.62584183701, 8448.450850694686, 8448.535330556879, 8455.95772021136, 8462.576871156542, 8996.59515321799, 9263.814723705624, 9324.580393882427, 9328.207102396373, 9337.159655631025, 8163.469374490876, 8346.374021948499, 8428.704995325133, 8446.619902104298, 8472.279856212044, 7843.960780196063, 8160.224778646019, 8186.713465028695, 8219.465734727224, 8336.083030866479, 7208.89186662211, 7317.268273172853, 7346.77959661211, 7353.0, 7354.227806080498, 5515.172724091419, 5715.828525144252, 5778.451047150514, 5778.595498315078, 5813.796517122049, 5537.9169312459535, 5538.833834984795, 5754.884902302014, 5767.0, 5841.853953651193], "value": 4985.722790997948, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.8690110856765, 335.91770016346, 351.3500024953836, 357.43882105094997, 361.1404856441669, 5388.622796404248, 5575.553955683546, 5642.605017648766, 5659.490645841874, 5673.744681489333, 5368.731563421833, 5466.508014278714, 5505.9724701376535, 5580.302462192226, 5583.35791383991, 4354.0, 4377.912441751163, 4384.934225986613, 4390.42924419825, 4404.669649776271, 4166.458360413142, 4233.640140588053, 4301.483821941371, 4346.066000629721, 4359.891002724926, 4307.741535507864, 4310.676699247553, 4315.5900189481945, 4329.393884856123, 4337.262665346899, 4356.956430435686, 4379.189849877751, 4382.035952090535, 4387.934180987288, 4389.385486031958, 3650.470681751131, 3801.8479260829536, 3810.466534685146, 3813.8939707484797, 3939.5075615548058, 5340.652857564246, 5367.382750983609, 5369.047024136748, 5370.167624018283, 5380.488853558944, 4935.555799977983, 4941.258811178316, 4942.159832828428, 4952.4057113146655, 5020.623453241022, 5517.862053448655, 5725.742341594639, 5793.275840519935, 5794.0739926337355, 5860.296764388258, 4221.0, 4233.491980962273, 4243.0, 4271.700980931336, 4274.1451709658195, 5906.616069955439, 6080.361562036011, 6095.573309868311, 6112.908306375408, 6129.754809807602, 4297.527272000078, 4298.570142985739, 4312.266914624522, 4322.3516472528745, 4331.242032644274, 4135.648469880034, 4364.432623758891, 4396.780160992002, 4411.845585404495, 4420.624246938982, 4804.0, 4830.565249127595, 4930.260460930889, 4931.7040977541465, 4964.453910069889, 5768.779020077301, 5787.392323806024, 5788.610733423948, 5792.160136780228, 5808.6224395414165, 1462.3638717158071, 1497.7229212595705, 1511.6296507355548, 1515.8938874278915, 1517.1579773225744, 962.7881865989472, 966.2703760269039, 970.7281961050917, 977.726236653738, 983.1053741095569, 4694.36626055485, 4877.804887804448, 4888.926666100011, 4925.581325587365, 4949.505049495022, 5155.7679904404395, 5160.948390516121, 5172.1380303090855, 5198.920431827224, 5202.973985130126, 4903.632227582874, 4909.582685471775, 4947.529984651453, 4962.047581688889, 4965.230389289666, 2594.0, 2763.706123917184, 2778.0, 2784.5962335461245, 2789.9302517437227, 5295.761690723926, 5349.893002140013, 5359.544438722674, 5360.721693280419, 5401.189821526802, 5297.2454323751435, 5341.839744807662, 5349.903269829676, 5381.381141168816, 5450.400455949843, 5376.865578360573, 5756.280464941882, 6161.168242287234, 6187.741474361916, 6194.473469754941, 6002.0, 6012.609180403259, 6020.006698894808, 6041.18444010053, 6045.335013148638, 5674.77300907959, 5875.971704951531, 5926.733297001559, 6019.0, 6035.486983606443, 6151.876962460815, 6158.476529494864, 6163.229596300463, 6169.537284703575, 6175.783847565313, 4262.190183865056, 4279.657627389864, 4319.48166220043, 4326.83175542608, 4329.177456283296, 5621.80323688669, 5693.430656934273, 5931.08068249422, 5971.790987315423, 6142.416470435302, 5854.0, 5861.7655293787775, 5864.208331875142, 5867.178594996619, 5880.353501019721, 5642.981005162219, 5758.913616295675, 5874.647521148745, 5912.733926973383, 5915.142304365757, 5794.3626201117, 5801.5938884279385, 5816.01127808282, 5818.359980402237, 5825.854353641193, 5845.795397161079, 5845.941540584709, 5922.407759224043, 5953.226080609493, 5972.163897054503, 5501.834944951498, 5748.683822389641, 5773.441170883922, 5777.422257774189, 5805.651660900359], "value": 4348.41946743079, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [779.5011192836583, 788.365365880466, 801.2708435323852, 803.4054799448409, 921.3734660430904, 14210.360533775978, 14303.713925721479, 14764.187969661678, 16455.60127389172, 17053.829461705394, 15781.210939453038, 15872.444464443717, 15926.0, 15962.361505539793, 15966.600834979103, 724.7608289264556, 741.4179868802963, 845.0915266088964, 866.9812969760507, 870.5908223135148, 842.3598065470256, 849.5921957460423, 865.8095219051798, 866.800635853754, 866.9263112635433, 888.6223355074068, 892.0544223123477, 892.7678803511069, 893.5666201892077, 893.6380765789833, 743.1305372713938, 760.6501009535621, 889.9911000889973, 890.4123278636101, 891.0821853490883, 646.3181343682413, 661.1273119482286, 665.930077341877, 665.9966700166468, 666.3702800853196, 15209.239538023165, 15237.542873713806, 15252.0086194397, 15289.235538223156, 15305.31126099317, 14113.153210807384, 14168.149911005372, 14182.858171418256, 14195.148291102567, 14397.928010359987, 13031.152975056686, 13040.869591304156, 13082.803757943639, 13102.08285420021, 13211.14127581704, 4722.76386180693, 4747.762611869427, 4779.498152693986, 4828.179209534387, 4839.951600483985, 92728.53635731846, 93454.72908448172, 93492.53253733755, 93589.0, 94434.5278273611, 11328.32030078198, 11516.30902145874, 11613.477393517313, 11641.41792910368, 11852.644420667393, 19030.143643536074, 19155.904220479086, 19185.712214316798, 19270.421887343404, 19270.61458770845, 8541.487510749375, 8628.35287353451, 8755.430896991675, 8908.242799361997, 9182.403143795766, 4627.8611641650805, 4718.3158442025715, 4817.349657796222, 4962.404511458576, 5021.799128034838, 3601.405768048295, 3694.3719716735, 3715.7398982071536, 3735.738498305147, 3737.7009839213342, 640.2604991235131, 649.9220093588705, 651.212033439534, 661.8577005943745, 669.2638098092157, 705.270045502902, 716.9211386747454, 724.3697982755037, 727.1601300497933, 733.5671953547433, 8811.867821982676, 8987.77530561728, 9283.652870388176, 9692.17616502591, 9746.0, 601.506764453153, 638.250056183982, 693.1301216972668, 722.4328901812053, 729.7154109897144, 4726.858194254178, 4728.38530990969, 4894.730789806524, 4913.77887995034, 4960.255961605716, 116020.0, 125813.0, 129783.0, 130952.34523827319, 133114.33442832725, 113303.4334828337, 114738.42630786792, 118116.40941795237, 118400.0, 119273.40363298128, 58097.70951145217, 80679.19320806835, 80711.19288807154, 98039.50980245053, 102116.0, 9440.480773557245, 9466.810663786824, 9661.758456038655, 10287.43419111956, 10336.689899303034, 53424.0, 54503.72748136234, 54871.451285488234, 56090.719546402004, 57761.42238577561, 68693.0, 81219.59390203012, 83914.0, 85527.0, 85539.5723021381, 13715.451381944611, 13863.653408664864, 13985.58043258704, 14049.508267210598, 14059.789103163665, 15120.319585618454, 15756.60608484797, 15761.605959851095, 16124.516264512084, 16235.0, 14534.63663408381, 14869.256537173314, 14879.256037198313, 15000.099994000395, 15486.380544778083, 14784.852151478348, 15059.924700376429, 15150.242487875783, 15226.543203703906, 15709.057456552644, 13697.371574658257, 13768.586942391745, 13989.160650361011, 14333.64165895861, 14860.0, 12148.939255303667, 12337.50649973991, 12468.5012599495, 12800.74398512006, 13351.732965340445, 12044.638660840188, 12073.818892716792, 12270.631881043582, 12676.429560669607, 12786.232826030468], "value": 7957.480189850319, "unit": "score"}], "name": "dromaeo_css", "value": 7678.340906352791, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 110.0, 111.0, 113.0, 113.0, 111.0, 111.0, 113.0, 111.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 120.0, 141.0, 158.0, 119.0, 120.0, 117.0, 119.0, 147.0, 122.0], "value": 131.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 159.0, 163.0, 160.0, 160.0, 161.0, 161.0, 160.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 118.0, 76.0, 76.0, 76.0, 75.0, 100.0, 75.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 124.0, 82.0, 82.0, 81.0, 100.0, 80.0, 81.0, 111.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 145.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 49.0, 50.0, 48.0, 49.0, 48.0, 51.0, 48.0, 50.0], "value": 49.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 60.0, 59.0, 60.0, 59.0, 60.0, 60.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 75.0, 73.0, 74.0, 80.0, 74.0, 73.0, 79.0, 73.0, 73.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 131.0, 122.0, 122.0, 127.0, 120.0, 121.0, 120.0, 158.0, 119.0], "value": 127.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 158.0, 154.0, 153.0, 152.0, 155.0, 151.0, 150.0, 152.0, 152.0], "value": 153.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 63.0, 68.0, 63.0, 63.0, 61.0, 60.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1461.3999999999999, "alertThreshold": 2.0}]} 05:13:15 INFO - Return code: 0 05:13:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:13:15 INFO - # TBPL SUCCESS # 05:13:15 INFO - Running post-action listener: _resource_record_post_action 05:13:15 INFO - [mozharness: 2016-10-06 12:13:15.599491Z] Finished run-tests step (success) 05:13:15 INFO - Running post-run listener: _resource_record_post_run 05:13:15 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 358219776; Read time: 8; Write time: 223604 05:13:15 INFO - TinderboxPrint: CPU usage
13.0% 05:13:15 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 05:13:15 INFO - TinderboxPrint: I/O write bytes / time
358,219,776 / 223,604 05:13:15 INFO - TinderboxPrint: CPU idle
8,258.8 (87.0%) 05:13:15 INFO - TinderboxPrint: CPU user
1,187.5 (12.5%) 05:13:15 INFO - TinderboxPrint: Swap in / out
0 / 0 05:13:15 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107962368; Read time: 0; Write time: 91040 05:13:15 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 249790464; Read time: 0; Write time: 132560 05:13:16 INFO - Running post-run listener: _upload_blobber_files 05:13:16 INFO - Blob upload gear active. 05:13:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:13:16 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 05:13:16 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:13:16 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:13:16 INFO - (blobuploader) - INFO - Open directory for files ... 05:13:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:13:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:13:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:20 INFO - (blobuploader) - INFO - Done attempting. 05:13:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:13:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:13:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:20 INFO - (blobuploader) - INFO - Done attempting. 05:13:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:13:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:13:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:21 INFO - (blobuploader) - INFO - Done attempting. 05:13:21 INFO - (blobuploader) - INFO - Iteration through files over. 05:13:21 INFO - Return code: 0 05:13:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:13:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:13:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b0d508c8c2c03e3a4ead32403f6aa2902258131336427e960f51116e2249aeb4e6cb3f51dc3542fcc27e8bd1087457bca3d01c6537cefab071b3465dbbf674d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/17663e8cca5c7a5a6a0b93b6a633a9920ef368afcac21e73b51ec6ab305b5d246228d188e5c8e0c13e3729ae5bf893a0d6844fe86b6f80828e5dc5d4efcf45e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2bd206321efef7b90f12acc6e0da8335a7d26669b5d8d5cd744115cb016fcfe3d85d0ce92351a9bc74d3a134f2d21fcae7f9d54548ef521c4a19a9606d084cf8"} 05:13:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:13:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:13:21 INFO - Contents: 05:13:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b0d508c8c2c03e3a4ead32403f6aa2902258131336427e960f51116e2249aeb4e6cb3f51dc3542fcc27e8bd1087457bca3d01c6537cefab071b3465dbbf674d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/17663e8cca5c7a5a6a0b93b6a633a9920ef368afcac21e73b51ec6ab305b5d246228d188e5c8e0c13e3729ae5bf893a0d6844fe86b6f80828e5dc5d4efcf45e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2bd206321efef7b90f12acc6e0da8335a7d26669b5d8d5cd744115cb016fcfe3d85d0ce92351a9bc74d3a134f2d21fcae7f9d54548ef521c4a19a9606d084cf8"} 05:13:21 INFO - Running post-run listener: copy_logs_to_upload_dir 05:13:21 INFO - Copying logs to upload dir... 05:13:21 INFO - mkdir: /builds/slave/test/build/upload/logs 05:13:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.115095 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-10-06 05:13:19.765048) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 05:13:19.769102) ========= 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=3a3620fb28aea1604ab609ef000001d2-1475754767.597148-992004852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b0d508c8c2c03e3a4ead32403f6aa2902258131336427e960f51116e2249aeb4e6cb3f51dc3542fcc27e8bd1087457bca3d01c6537cefab071b3465dbbf674d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/17663e8cca5c7a5a6a0b93b6a633a9920ef368afcac21e73b51ec6ab305b5d246228d188e5c8e0c13e3729ae5bf893a0d6844fe86b6f80828e5dc5d4efcf45e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2bd206321efef7b90f12acc6e0da8335a7d26669b5d8d5cd744115cb016fcfe3d85d0ce92351a9bc74d3a134f2d21fcae7f9d54548ef521c4a19a9606d084cf8"} build_url:https://queue.taskcluster.net/v1/task/N71YWmBXSQu9PvdBULvbCQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011307 build_url: 'https://queue.taskcluster.net/v1/task/N71YWmBXSQu9PvdBULvbCQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b0d508c8c2c03e3a4ead32403f6aa2902258131336427e960f51116e2249aeb4e6cb3f51dc3542fcc27e8bd1087457bca3d01c6537cefab071b3465dbbf674d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/17663e8cca5c7a5a6a0b93b6a633a9920ef368afcac21e73b51ec6ab305b5d246228d188e5c8e0c13e3729ae5bf893a0d6844fe86b6f80828e5dc5d4efcf45e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2bd206321efef7b90f12acc6e0da8335a7d26669b5d8d5cd744115cb016fcfe3d85d0ce92351a9bc74d3a134f2d21fcae7f9d54548ef521c4a19a9606d084cf8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 05:13:19.797749) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 05:13:19.798322) ========= 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=3a3620fb28aea1604ab609ef000001d2-1475754767.597148-992004852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004539 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 05:13:19.880726) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 05:13:19.881092) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 05:13:19.881412) ========= ========= Total master_lag: 0.15 =========