builder: date_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-057 starttime: 1474920017.98 results: success (0) buildid: 20160926094650 builduid: 301d4a31454d4e878d33469099f07efe revision: 40ee5ff8fad82e4581e49361beb1d00179521420 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 13:00:17.984883) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 13:00:17.985348) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 13:00:17.985638) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 13:00:18.043118) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 13:00:18.043394) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1474919847.180215-1454381279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-26 13:00:18-- 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% 160M=0s 2016-09-26 13:00:18 (160 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100032 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 13:00:18.161421) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 13:00:18.161704) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1474919847.180215-1454381279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015900 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 13:00:18.212301) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-26 13:00:18.212596) ========= bash -c 'python archiver_client.py mozharness --repo projects/date --rev 40ee5ff8fad82e4581e49361beb1d00179521420 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/date --rev 40ee5ff8fad82e4581e49361beb1d00179521420 --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=934fc3100db09dcb9af4d4b6000001ab-1474919847.180215-1454381279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-26 13:00:18,619 truncating revision to first 12 chars 2016-09-26 13:00:18,619 Setting DEBUG logging. 2016-09-26 13:00:18,619 attempt 1/10 2016-09-26 13:00:18,619 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/date/40ee5ff8fad8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-26 13:00:19,503 unpacking tar archive at: date-40ee5ff8fad8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.310570 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-26 13:00:19.536569) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 13:00:19.536875) ========= script_repo_revision: 40ee5ff8fad82e4581e49361beb1d00179521420 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 13:00:19.537252) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 13:00:19.537519) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 13:00:19.546677) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-09-26 13:00:19.547017) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Date --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Date 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', 'Date', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Date'] 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=934fc3100db09dcb9af4d4b6000001ab-1474919847.180215-1454381279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:00:20 INFO - MultiFileLogger online at 20160926 13:00:20 in /builds/slave/test 13:00:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Date --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Date 13:00:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:00:20 INFO - {'append_to_log': False, 13:00:20 INFO - 'base_work_dir': '/builds/slave/test', 13:00:20 INFO - 'blob_upload_branch': 'Date', 13:00:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:00:20 INFO - 'branch': 'Date', 13:00:20 INFO - 'buildbot_json_path': 'buildprops.json', 13:00:20 INFO - 'config_files': ('talos/linux_config.py',), 13:00:20 INFO - 'default_actions': ('clobber', 13:00:20 INFO - 'read-buildbot-config', 13:00:20 INFO - 'download-and-extract', 13:00:20 INFO - 'populate-webroot', 13:00:20 INFO - 'create-virtualenv', 13:00:20 INFO - 'install', 13:00:20 INFO - 'run-tests'), 13:00:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:00:20 INFO - 'download_minidump_stackwalk': True, 13:00:20 INFO - 'download_symbols': 'ondemand', 13:00:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:00:20 INFO - 'tooltool.py': '/tools/tooltool.py', 13:00:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:00:20 INFO - '/tools/misc-python/virtualenv.py')}, 13:00:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:00:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:00:20 INFO - 'installer_path': 'installer.exe', 13:00:20 INFO - 'log_level': 'info', 13:00:20 INFO - 'log_name': 'talos', 13:00:20 INFO - 'log_to_console': True, 13:00:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:00:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:00:20 INFO - 'opt_config_files': (), 13:00:20 INFO - 'pip_index': False, 13:00:20 INFO - 'sps_profile': False, 13:00:20 INFO - 'sps_profile_interval': 0, 13:00:20 INFO - 'suite': 'dromaeojs', 13:00:20 INFO - 'system_bits': '32', 13:00:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:00:20 INFO - 'title': 'talos-linux64-ix-057', 13:00:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:00:20 INFO - 'use_talos_json': True, 13:00:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:00:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:00:20 INFO - 'work_dir': 'build'} 13:00:20 INFO - [mozharness: 2016-09-26 20:00:20.050743Z] Running clobber step. 13:00:20 INFO - Running pre-action listener: _resource_record_pre_action 13:00:20 INFO - Running main action method: clobber 13:00:20 INFO - rmtree: /builds/slave/test/build 13:00:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:00:21 INFO - Running post-action listener: _resource_record_post_action 13:00:21 INFO - [mozharness: 2016-09-26 20:00:21.045560Z] Finished clobber step (success) 13:00:21 INFO - [mozharness: 2016-09-26 20:00:21.045659Z] Running read-buildbot-config step. 13:00:21 INFO - Running pre-action listener: _resource_record_pre_action 13:00:21 INFO - Running main action method: read_buildbot_config 13:00:21 INFO - Using buildbot properties: 13:00:21 INFO - { 13:00:21 INFO - "project": "", 13:00:21 INFO - "product": "firefox", 13:00:21 INFO - "script_repo_revision": "production", 13:00:21 INFO - "builddir": "date_ubuntu64_hw_test-dromaeojs", 13:00:21 INFO - "repository": "", 13:00:21 INFO - "buildername": "Ubuntu HW 12.04 x64 date talos dromaeojs", 13:00:21 INFO - "buildid": "20160926094650", 13:00:21 INFO - "pgo_build": "False", 13:00:21 INFO - "basedir": "/builds/slave/test", 13:00:21 INFO - "buildnumber": 0, 13:00:21 INFO - "slavename": "talos-linux64-ix-057", 13:00:21 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:00:21 INFO - "platform": "ubuntu64_hw", 13:00:21 INFO - "scheduler": "tests-date-linux64-talos", 13:00:21 INFO - "branch": "date", 13:00:21 INFO - "repo_path": "projects/date", 13:00:21 INFO - "revision": "40ee5ff8fad82e4581e49361beb1d00179521420", 13:00:21 INFO - "stage_platform": "linux64", 13:00:21 INFO - "builduid": "301d4a31454d4e878d33469099f07efe", 13:00:21 INFO - "slavebuilddir": "test" 13:00:21 INFO - } 13:00:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/BqSTVOBRRryDw_b8Ip7pDg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 13:00:21 INFO - Running post-action listener: _resource_record_post_action 13:00:21 INFO - [mozharness: 2016-09-26 20:00:21.048080Z] Finished read-buildbot-config step (success) 13:00:21 INFO - [mozharness: 2016-09-26 20:00:21.048168Z] Running download-and-extract step. 13:00:21 INFO - Running pre-action listener: _resource_record_pre_action 13:00:21 INFO - Running main action method: download_and_extract 13:00:21 INFO - mkdir: /builds/slave/test/build/tests 13:00: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')]} 13:00:21 INFO - trying https://queue.taskcluster.net/v1/task/BqSTVOBRRryDw_b8Ip7pDg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:00:21 INFO - Downloading https://queue.taskcluster.net/v1/task/BqSTVOBRRryDw_b8Ip7pDg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:00:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BqSTVOBRRryDw_b8Ip7pDg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:00:21 INFO - Downloaded 1361 bytes. 13:00:21 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:00:21 INFO - Using the following test package requirements: 13:00:21 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:00:21 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:00:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:00:21 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:00:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:00:21 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:00:21 INFO - u'jsshell-linux-x86_64.zip'], 13:00:21 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:00:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:00:21 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:00:21 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:00:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:00:21 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:00:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:00:21 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:00:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:00:21 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:00:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:00:21 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:00:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BqSTVOBRRryDw_b8Ip7pDg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 13:00:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BqSTVOBRRryDw_b8Ip7pDg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:00:21 INFO - Fetch https://queue.taskcluster.net/v1/task/BqSTVOBRRryDw_b8Ip7pDg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:00:22 INFO - Expected file size: 21940934 13:00:26 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:00:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BqSTVOBRRryDw_b8Ip7pDg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 13:00:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BqSTVOBRRryDw_b8Ip7pDg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:00:26 INFO - Fetch https://queue.taskcluster.net/v1/task/BqSTVOBRRryDw_b8Ip7pDg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:00:27 INFO - Expected file size: 21940934 13:00:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BqSTVOBRRryDw_b8Ip7pDg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 13:00:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BqSTVOBRRryDw_b8Ip7pDg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:00:31 INFO - Fetch https://queue.taskcluster.net/v1/task/BqSTVOBRRryDw_b8Ip7pDg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 13:00:32 INFO - Expected file size: 14414057 13:00:32 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')]} 13:00:32 INFO - trying https://queue.taskcluster.net/v1/task/BqSTVOBRRryDw_b8Ip7pDg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:00:32 INFO - Downloading https://queue.taskcluster.net/v1/task/BqSTVOBRRryDw_b8Ip7pDg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:00:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BqSTVOBRRryDw_b8Ip7pDg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:00:33 INFO - Downloaded 52681263 bytes. 13:00:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BqSTVOBRRryDw_b8Ip7pDg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:00:33 INFO - mkdir: /builds/slave/test/properties 13:00:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:00:33 INFO - Writing to file /builds/slave/test/properties/build_url 13:00:33 INFO - Contents: 13:00:33 INFO - build_url:https://queue.taskcluster.net/v1/task/BqSTVOBRRryDw_b8Ip7pDg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:00:34 INFO - Running post-action listener: _resource_record_post_action 13:00:34 INFO - Running post-action listener: set_extra_try_arguments 13:00:34 INFO - [mozharness: 2016-09-26 20:00:34.733873Z] Finished download-and-extract step (success) 13:00:34 INFO - [mozharness: 2016-09-26 20:00:34.734101Z] Running populate-webroot step. 13:00:34 INFO - Running pre-action listener: _resource_record_pre_action 13:00:34 INFO - Running main action method: populate_webroot 13:00:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:00:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:00:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:00:34 INFO - '--tppagecycles', 13:00:34 INFO - '7'], 13:00:34 INFO - 'tests': ['tsvgm']}}, 13:00:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:00:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:00:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:00:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:00:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:00:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:00:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:34 INFO - 'talos_options': ['--disable-e10s'], 13:00:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:00:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:00:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:34 INFO - 'talos_options': ['--disable-e10s'], 13:00:34 INFO - 'tests': ['damp', 'tps']}, 13:00:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:34 INFO - 'tests': ['damp', 'tps']}, 13:00:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:00:34 INFO - 'tests': ['dromaeo_dom']}, 13:00:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:00:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:00:34 INFO - 'tests': ['basic_compositor_video']}, 13:00:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:00:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:00:34 INFO - 'tests': ['a11yr', 13:00:34 INFO - 'ts_paint', 13:00:34 INFO - 'tpaint', 13:00:34 INFO - 'sessionrestore', 13:00:34 INFO - 'sessionrestore_no_auto_restore', 13:00:34 INFO - 'tabpaint']}, 13:00:34 INFO - 'other-e10s': {'tests': ['a11yr', 13:00:34 INFO - 'ts_paint', 13:00:34 INFO - 'tpaint', 13:00:34 INFO - 'sessionrestore', 13:00:34 INFO - 'sessionrestore_no_auto_restore', 13:00:34 INFO - 'tabpaint']}, 13:00:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:00:34 INFO - 'ts_paint', 13:00:34 INFO - 'tpaint', 13:00:34 INFO - 'sessionrestore', 13:00:34 INFO - 'sessionrestore_no_auto_restore', 13:00:34 INFO - 'tabpaint']}, 13:00:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:00:34 INFO - 'ts_paint', 13:00:34 INFO - 'tpaint', 13:00:34 INFO - 'sessionrestore', 13:00:34 INFO - 'sessionrestore_no_auto_restore', 13:00:34 INFO - 'tabpaint']}, 13:00:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:00:34 INFO - 'tests': ['a11yr', 13:00:34 INFO - 'ts_paint', 13:00:34 INFO - 'tpaint', 13:00:34 INFO - 'sessionrestore', 13:00:34 INFO - 'sessionrestore_no_auto_restore', 13:00:34 INFO - 'tabpaint']}, 13:00:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:00:34 INFO - 'tests': ['a11yr', 13:00:34 INFO - 'ts_paint', 13:00:34 INFO - 'tpaint', 13:00:34 INFO - 'sessionrestore', 13:00:34 INFO - 'sessionrestore_no_auto_restore', 13:00:34 INFO - 'tabpaint']}, 13:00:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:00:34 INFO - 'tests': ['tsvgx', 13:00:34 INFO - 'tsvgr_opacity', 13:00:34 INFO - 'tart', 13:00:34 INFO - 'tscrollx', 13:00:34 INFO - 'cart']}, 13:00:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:00:34 INFO - 'tsvgr_opacity', 13:00:34 INFO - 'tart', 13:00:34 INFO - 'tscrollx', 13:00:34 INFO - 'cart']}, 13:00:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:34 INFO - 'talos_options': ['--disable-e10s'], 13:00:34 INFO - 'tests': ['tp5o']}, 13:00:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:34 INFO - 'tests': ['tp5o']}, 13:00:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:34 INFO - 'talos_options': ['--disable-e10s', 13:00:34 INFO - '--xperf_path', 13:00:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:00:34 INFO - 'tests': ['tp5n']}, 13:00:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:34 INFO - 'talos_options': ['--xperf_path', 13:00:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:00:34 INFO - 'tests': ['tp5n']}}, 13:00:34 INFO - 'talos.zip': {'path': '', 13:00:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:00:34 INFO - Running post-action listener: _resource_record_post_action 13:00:34 INFO - [mozharness: 2016-09-26 20:00:34.749477Z] Finished populate-webroot step (success) 13:00:34 INFO - [mozharness: 2016-09-26 20:00:34.749571Z] Running create-virtualenv step. 13:00:34 INFO - Running pre-action listener: _resource_record_pre_action 13:00:34 INFO - Running main action method: create_virtualenv 13:00:34 INFO - Creating virtualenv /builds/slave/test/build/venv 13:00:34 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:00:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:00:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:00:34 INFO - Using real prefix '/usr' 13:00:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:00:35 INFO - Installing distribute.............................................................................................................................................................................................done. 13:00:37 INFO - Installing pip.................done. 13:00:37 INFO - Return code: 0 13:00:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:00:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:00:37 INFO - Reading from file tmpfile_stdout 13:00:37 INFO - Output received: 13:00:37 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 13:00:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:37 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 0x7f48388edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c9790>, '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 0x28ca690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28cab20>, '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': '934fc3100db09dcb9af4d4b6000001ab-1474919847.180215-1454381279', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:00:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:00:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:00:37 INFO - Using env: {'DISPLAY': ':0', 13:00:37 INFO - 'HOME': '/home/cltbld', 13:00:37 INFO - 'LANG': 'en_US.UTF-8', 13:00:37 INFO - 'LANGUAGE': 'en_US:en', 13:00:37 INFO - 'LOGNAME': 'cltbld', 13:00:37 INFO - 'MAIL': '/var/mail/cltbld', 13:00:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:37 INFO - 'MOZ_NO_REMOTE': '1', 13:00:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:37 INFO - 'NO_EM_RESTART': '1', 13:00:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:37 INFO - 'PWD': '/builds/slave/test', 13:00:37 INFO - 'SHELL': '/bin/bash', 13:00:37 INFO - 'SHLVL': '1', 13:00:37 INFO - 'TERM': 'linux', 13:00:37 INFO - 'TMOUT': '86400', 13:00:37 INFO - 'USER': 'cltbld', 13:00:37 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1474919847.180215-1454381279', 13:00:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:37 INFO - '_': '/tools/buildbot/bin/python'} 13:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:00:37 INFO - Cleaning up... 13:00:37 INFO - Return code: 0 13:00:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:37 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 0x7f48388edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c9790>, '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 0x28ca690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28cab20>, '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': '934fc3100db09dcb9af4d4b6000001ab-1474919847.180215-1454381279', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:00:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:00:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:00:37 INFO - Using env: {'DISPLAY': ':0', 13:00:37 INFO - 'HOME': '/home/cltbld', 13:00:37 INFO - 'LANG': 'en_US.UTF-8', 13:00:37 INFO - 'LANGUAGE': 'en_US:en', 13:00:37 INFO - 'LOGNAME': 'cltbld', 13:00:37 INFO - 'MAIL': '/var/mail/cltbld', 13:00:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:37 INFO - 'MOZ_NO_REMOTE': '1', 13:00:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:37 INFO - 'NO_EM_RESTART': '1', 13:00:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:37 INFO - 'PWD': '/builds/slave/test', 13:00:37 INFO - 'SHELL': '/bin/bash', 13:00:37 INFO - 'SHLVL': '1', 13:00:37 INFO - 'TERM': 'linux', 13:00:37 INFO - 'TMOUT': '86400', 13:00:37 INFO - 'USER': 'cltbld', 13:00:37 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1474919847.180215-1454381279', 13:00:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:37 INFO - '_': '/tools/buildbot/bin/python'} 13:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:37 INFO - Downloading/unpacking psutil>=3.1.1 13:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:00:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:00:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:00:39 INFO - Installing collected packages: psutil 13:00:39 INFO - Running setup.py install for psutil 13:00:40 INFO - building 'psutil._psutil_linux' extension 13:00:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:00:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:00:40 INFO - building 'psutil._psutil_posix' extension 13:00:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:00:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:00:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:00:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:00:40 INFO - Successfully installed psutil 13:00:40 INFO - Cleaning up... 13:00:40 INFO - Return code: 0 13:00:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:00:40 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')]} 13:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:40 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')]} 13:00:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:40 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 0x7f48388edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c9790>, '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 0x28ca690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28cab20>, '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': '934fc3100db09dcb9af4d4b6000001ab-1474919847.180215-1454381279', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:00:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:00:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:00:40 INFO - Using env: {'DISPLAY': ':0', 13:00:40 INFO - 'HOME': '/home/cltbld', 13:00:40 INFO - 'LANG': 'en_US.UTF-8', 13:00:40 INFO - 'LANGUAGE': 'en_US:en', 13:00:40 INFO - 'LOGNAME': 'cltbld', 13:00:40 INFO - 'MAIL': '/var/mail/cltbld', 13:00:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:40 INFO - 'MOZ_NO_REMOTE': '1', 13:00:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:40 INFO - 'NO_EM_RESTART': '1', 13:00:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:40 INFO - 'PWD': '/builds/slave/test', 13:00:40 INFO - 'SHELL': '/bin/bash', 13:00:40 INFO - 'SHLVL': '1', 13:00:40 INFO - 'TERM': 'linux', 13:00:40 INFO - 'TMOUT': '86400', 13:00:40 INFO - 'USER': 'cltbld', 13:00:40 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1474919847.180215-1454381279', 13:00:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:40 INFO - '_': '/tools/buildbot/bin/python'} 13:00:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:00:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:00:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:00:42 INFO - Installing collected packages: mozsystemmonitor 13:00:42 INFO - Running setup.py install for mozsystemmonitor 13:00:42 INFO - Successfully installed mozsystemmonitor 13:00:42 INFO - Cleaning up... 13:00:42 INFO - Return code: 0 13:00:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:00: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')]} 13:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00: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')]} 13:00:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:42 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 0x7f48388edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c9790>, '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 0x28ca690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28cab20>, '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': '934fc3100db09dcb9af4d4b6000001ab-1474919847.180215-1454381279', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:00:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:00:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:00:42 INFO - Using env: {'DISPLAY': ':0', 13:00:42 INFO - 'HOME': '/home/cltbld', 13:00:42 INFO - 'LANG': 'en_US.UTF-8', 13:00:42 INFO - 'LANGUAGE': 'en_US:en', 13:00:42 INFO - 'LOGNAME': 'cltbld', 13:00:42 INFO - 'MAIL': '/var/mail/cltbld', 13:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:42 INFO - 'MOZ_NO_REMOTE': '1', 13:00:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:42 INFO - 'NO_EM_RESTART': '1', 13:00:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:42 INFO - 'PWD': '/builds/slave/test', 13:00:42 INFO - 'SHELL': '/bin/bash', 13:00:42 INFO - 'SHLVL': '1', 13:00:42 INFO - 'TERM': 'linux', 13:00:42 INFO - 'TMOUT': '86400', 13:00:42 INFO - 'USER': 'cltbld', 13:00:42 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1474919847.180215-1454381279', 13:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:42 INFO - '_': '/tools/buildbot/bin/python'} 13:00:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:43 INFO - Downloading/unpacking jsonschema==2.5.1 13:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:00:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:45 INFO - Downloading functools32-3.2.3-2.tar.gz 13:00:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:00:45 INFO - warning: no files found matching '*.txt' 13:00:45 INFO - no previously-included directories found matching 'build' 13:00:45 INFO - no previously-included directories found matching 'dist' 13:00:45 INFO - no previously-included directories found matching '.git*' 13:00:45 INFO - Installing collected packages: jsonschema, functools32 13:00:45 INFO - Running setup.py install for functools32 13:00:45 INFO - warning: no files found matching '*.txt' 13:00:45 INFO - no previously-included directories found matching 'build' 13:00:45 INFO - no previously-included directories found matching 'dist' 13:00:45 INFO - no previously-included directories found matching '.git*' 13:00:45 INFO - Successfully installed jsonschema functools32 13:00:45 INFO - Cleaning up... 13:00:45 INFO - Return code: 0 13:00:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:00:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:45 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 0x7f48388edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c9790>, '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 0x28ca690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28cab20>, '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': '934fc3100db09dcb9af4d4b6000001ab-1474919847.180215-1454381279', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:00:45 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 13:00:45 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 13:00:45 INFO - Using env: {'DISPLAY': ':0', 13:00:45 INFO - 'HOME': '/home/cltbld', 13:00:45 INFO - 'LANG': 'en_US.UTF-8', 13:00:45 INFO - 'LANGUAGE': 'en_US:en', 13:00:45 INFO - 'LOGNAME': 'cltbld', 13:00:45 INFO - 'MAIL': '/var/mail/cltbld', 13:00:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:45 INFO - 'MOZ_NO_REMOTE': '1', 13:00:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:45 INFO - 'NO_EM_RESTART': '1', 13:00:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:45 INFO - 'PWD': '/builds/slave/test', 13:00:45 INFO - 'SHELL': '/bin/bash', 13:00:45 INFO - 'SHLVL': '1', 13:00:45 INFO - 'TERM': 'linux', 13:00:45 INFO - 'TMOUT': '86400', 13:00:45 INFO - 'USER': 'cltbld', 13:00:45 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1474919847.180215-1454381279', 13:00:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:45 INFO - '_': '/tools/buildbot/bin/python'} 13:00:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:00:45 INFO - Cleaning up... 13:00:45 INFO - Return code: 0 13:00:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:00:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:45 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 0x7f48388edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c9790>, '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 0x28ca690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28cab20>, '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': '934fc3100db09dcb9af4d4b6000001ab-1474919847.180215-1454381279', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:00:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:00:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:00:45 INFO - Using env: {'DISPLAY': ':0', 13:00:45 INFO - 'HOME': '/home/cltbld', 13:00:45 INFO - 'LANG': 'en_US.UTF-8', 13:00:45 INFO - 'LANGUAGE': 'en_US:en', 13:00:45 INFO - 'LOGNAME': 'cltbld', 13:00:45 INFO - 'MAIL': '/var/mail/cltbld', 13:00:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:45 INFO - 'MOZ_NO_REMOTE': '1', 13:00:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:45 INFO - 'NO_EM_RESTART': '1', 13:00:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:45 INFO - 'PWD': '/builds/slave/test', 13:00:45 INFO - 'SHELL': '/bin/bash', 13:00:45 INFO - 'SHLVL': '1', 13:00:45 INFO - 'TERM': 'linux', 13:00:45 INFO - 'TMOUT': '86400', 13:00:45 INFO - 'USER': 'cltbld', 13:00:45 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1474919847.180215-1454381279', 13:00:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:45 INFO - '_': '/tools/buildbot/bin/python'} 13:00:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:45 INFO - Downloading/unpacking blobuploader==1.2.4 13:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:47 INFO - Downloading blobuploader-1.2.4.tar.gz 13:00:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:00:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:00:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:48 INFO - Downloading docopt-0.6.1.tar.gz 13:00:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:00:48 INFO - Installing collected packages: blobuploader, requests, docopt 13:00:48 INFO - Running setup.py install for blobuploader 13:00:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:00:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:00:48 INFO - Running setup.py install for requests 13:00:48 INFO - Running setup.py install for docopt 13:00:49 INFO - Successfully installed blobuploader requests docopt 13:00:49 INFO - Cleaning up... 13:00:49 INFO - Return code: 0 13:00:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:49 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 0x7f48388edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c9790>, '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 0x28ca690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28cab20>, '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': '934fc3100db09dcb9af4d4b6000001ab-1474919847.180215-1454381279', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:00:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:00:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:00:49 INFO - Using env: {'DISPLAY': ':0', 13:00:49 INFO - 'HOME': '/home/cltbld', 13:00:49 INFO - 'LANG': 'en_US.UTF-8', 13:00:49 INFO - 'LANGUAGE': 'en_US:en', 13:00:49 INFO - 'LOGNAME': 'cltbld', 13:00:49 INFO - 'MAIL': '/var/mail/cltbld', 13:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:49 INFO - 'MOZ_NO_REMOTE': '1', 13:00:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:49 INFO - 'NO_EM_RESTART': '1', 13:00:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:49 INFO - 'PWD': '/builds/slave/test', 13:00:49 INFO - 'SHELL': '/bin/bash', 13:00:49 INFO - 'SHLVL': '1', 13:00:49 INFO - 'TERM': 'linux', 13:00:49 INFO - 'TMOUT': '86400', 13:00:49 INFO - 'USER': 'cltbld', 13:00:49 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1474919847.180215-1454381279', 13:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:49 INFO - '_': '/tools/buildbot/bin/python'} 13:00:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:00:49 INFO - Running setup.py (path:/tmp/pip-fBuns4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:00:49 INFO - Running setup.py (path:/tmp/pip-DYFcbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:00:49 INFO - Running setup.py (path:/tmp/pip-Zedo_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:00:49 INFO - Running setup.py (path:/tmp/pip-cjUosI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:00:49 INFO - Running setup.py (path:/tmp/pip-ByyaN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:00:49 INFO - Running setup.py (path:/tmp/pip-ijkiNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:00:49 INFO - Running setup.py (path:/tmp/pip-_Ag7xg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:00:49 INFO - Running setup.py (path:/tmp/pip-kzAFRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:00:49 INFO - Running setup.py (path:/tmp/pip-1yqoAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:00:49 INFO - Running setup.py (path:/tmp/pip-Q4sXM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:00:50 INFO - Running setup.py (path:/tmp/pip-Bqq25Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:00:50 INFO - Running setup.py (path:/tmp/pip-N3ZWj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:00:50 INFO - Running setup.py (path:/tmp/pip-CWO8ec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:00:50 INFO - Running setup.py (path:/tmp/pip-nhZ1US-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:00:50 INFO - Running setup.py (path:/tmp/pip-FkQ6I_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:00:50 INFO - Running setup.py (path:/tmp/pip-2EmOCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:00:50 INFO - Running setup.py (path:/tmp/pip-kyGcaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:00:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:00:50 INFO - Running setup.py install for manifestparser 13:00:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:00:50 INFO - Running setup.py install for mozcrash 13:00:50 INFO - Running setup.py install for mozdebug 13:00:50 INFO - Running setup.py install for mozdevice 13:00:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:00:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:00:50 INFO - Running setup.py install for mozfile 13:00:51 INFO - Running setup.py install for mozhttpd 13:00:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:00:51 INFO - Running setup.py install for mozinfo 13:00:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:00:51 INFO - Running setup.py install for mozInstall 13:00:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:00:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:00:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:00:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:00:51 INFO - Running setup.py install for mozleak 13:00:51 INFO - Running setup.py install for mozlog 13:00:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:00:51 INFO - Running setup.py install for moznetwork 13:00:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:00:51 INFO - Running setup.py install for mozprocess 13:00:51 INFO - Running setup.py install for mozprofile 13:00:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:00:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:00:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:00:51 INFO - Running setup.py install for mozrunner 13:00:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:00:52 INFO - Running setup.py install for mozscreenshot 13:00:52 INFO - Running setup.py install for moztest 13:00:52 INFO - Running setup.py install for mozversion 13:00:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:00:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:00:52 INFO - Cleaning up... 13:00:52 INFO - Return code: 0 13:00:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:52 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 0x7f48388edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c9790>, '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 0x28ca690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28cab20>, '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': '934fc3100db09dcb9af4d4b6000001ab-1474919847.180215-1454381279', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:00:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:00:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:00:52 INFO - Using env: {'DISPLAY': ':0', 13:00:52 INFO - 'HOME': '/home/cltbld', 13:00:52 INFO - 'LANG': 'en_US.UTF-8', 13:00:52 INFO - 'LANGUAGE': 'en_US:en', 13:00:52 INFO - 'LOGNAME': 'cltbld', 13:00:52 INFO - 'MAIL': '/var/mail/cltbld', 13:00:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:52 INFO - 'MOZ_NO_REMOTE': '1', 13:00:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:52 INFO - 'NO_EM_RESTART': '1', 13:00:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:52 INFO - 'PWD': '/builds/slave/test', 13:00:52 INFO - 'SHELL': '/bin/bash', 13:00:52 INFO - 'SHLVL': '1', 13:00:52 INFO - 'TERM': 'linux', 13:00:52 INFO - 'TMOUT': '86400', 13:00:52 INFO - 'USER': 'cltbld', 13:00:52 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1474919847.180215-1454381279', 13:00:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:52 INFO - '_': '/tools/buildbot/bin/python'} 13:00:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:00:52 INFO - Running setup.py (path:/tmp/pip-m6DMcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:00:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:00:52 INFO - Running setup.py (path:/tmp/pip-XgqXM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:00:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:00:52 INFO - Running setup.py (path:/tmp/pip-0FodtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:00:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:00:52 INFO - Running setup.py (path:/tmp/pip-HPC2xe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:00:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:00:52 INFO - Running setup.py (path:/tmp/pip-yYxqjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:00:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:00:52 INFO - Running setup.py (path:/tmp/pip-yfYlCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:00:53 INFO - Running setup.py (path:/tmp/pip-i75p1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:00:53 INFO - Running setup.py (path:/tmp/pip-V5OXmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:00:53 INFO - Running setup.py (path:/tmp/pip-uY4QQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:00:53 INFO - Running setup.py (path:/tmp/pip-1CMzrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:00:53 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)) 13:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:00:53 INFO - Running setup.py (path:/tmp/pip-ZDs6DH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:00:53 INFO - Running setup.py (path:/tmp/pip-qgQQCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:00:53 INFO - Running setup.py (path:/tmp/pip-W1TMeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:00:53 INFO - Running setup.py (path:/tmp/pip-FiJwWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:00:53 INFO - Running setup.py (path:/tmp/pip-ew8ksy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:00:53 INFO - Running setup.py (path:/tmp/pip-Th3zyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:00:53 INFO - Running setup.py (path:/tmp/pip-X9UZJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:00:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:55 INFO - Downloading blessings-1.6.tar.gz 13:00:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:00:55 INFO - Installing collected packages: blessings 13:00:55 INFO - Running setup.py install for blessings 13:00:55 INFO - Successfully installed blessings 13:00:55 INFO - Cleaning up... 13:00:56 INFO - Return code: 0 13:00:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:00:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:00:56 INFO - Reading from file tmpfile_stdout 13:00:56 INFO - Current package versions: 13:00:56 INFO - argparse == 1.2.1 13:00:56 INFO - blessings == 1.6 13:00:56 INFO - blobuploader == 1.2.4 13:00:56 INFO - docopt == 0.6.1 13:00:56 INFO - functools32 == 3.2.3-2 13:00:56 INFO - jsonschema == 2.5.1 13:00:56 INFO - manifestparser == 1.1 13:00:56 INFO - mozInstall == 1.12 13:00:56 INFO - mozcrash == 0.17 13:00:56 INFO - mozdebug == 0.1 13:00:56 INFO - mozdevice == 0.48 13:00:56 INFO - mozfile == 1.2 13:00:56 INFO - mozhttpd == 0.7 13:00:56 INFO - mozinfo == 0.9 13:00:56 INFO - mozleak == 0.1 13:00:56 INFO - mozlog == 3.4 13:00:56 INFO - moznetwork == 0.27 13:00:56 INFO - mozprocess == 0.23 13:00:56 INFO - mozprofile == 0.28 13:00:56 INFO - mozrunner == 6.12 13:00:56 INFO - mozscreenshot == 0.1 13:00:56 INFO - mozsystemmonitor == 0.3 13:00:56 INFO - moztest == 0.7 13:00:56 INFO - mozversion == 1.4 13:00:56 INFO - psutil == 3.1.1 13:00:56 INFO - requests == 1.2.3 13:00:56 INFO - wsgiref == 0.1.2 13:00:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:56 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 0x7f48388edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c9790>, '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 0x28ca690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28cab20>, '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': '934fc3100db09dcb9af4d4b6000001ab-1474919847.180215-1454381279', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:00:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:00:56 INFO - Using env: {'DISPLAY': ':0', 13:00:56 INFO - 'HOME': '/home/cltbld', 13:00:56 INFO - 'LANG': 'en_US.UTF-8', 13:00:56 INFO - 'LANGUAGE': 'en_US:en', 13:00:56 INFO - 'LOGNAME': 'cltbld', 13:00:56 INFO - 'MAIL': '/var/mail/cltbld', 13:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:56 INFO - 'MOZ_NO_REMOTE': '1', 13:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:56 INFO - 'NO_EM_RESTART': '1', 13:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:56 INFO - 'PWD': '/builds/slave/test', 13:00:56 INFO - 'SHELL': '/bin/bash', 13:00:56 INFO - 'SHLVL': '1', 13:00:56 INFO - 'TERM': 'linux', 13:00:56 INFO - 'TMOUT': '86400', 13:00:56 INFO - 'USER': 'cltbld', 13:00:56 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1474919847.180215-1454381279', 13:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:56 INFO - '_': '/tools/buildbot/bin/python'} 13:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:00:56 INFO - Cleaning up... 13:00:56 INFO - Return code: 0 13:00:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:56 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 0x7f48388edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c9790>, '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 0x28ca690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28cab20>, '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': '934fc3100db09dcb9af4d4b6000001ab-1474919847.180215-1454381279', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:00:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:00:56 INFO - Using env: {'DISPLAY': ':0', 13:00:56 INFO - 'HOME': '/home/cltbld', 13:00:56 INFO - 'LANG': 'en_US.UTF-8', 13:00:56 INFO - 'LANGUAGE': 'en_US:en', 13:00:56 INFO - 'LOGNAME': 'cltbld', 13:00:56 INFO - 'MAIL': '/var/mail/cltbld', 13:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:56 INFO - 'MOZ_NO_REMOTE': '1', 13:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:56 INFO - 'NO_EM_RESTART': '1', 13:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:56 INFO - 'PWD': '/builds/slave/test', 13:00:56 INFO - 'SHELL': '/bin/bash', 13:00:56 INFO - 'SHLVL': '1', 13:00:56 INFO - 'TERM': 'linux', 13:00:56 INFO - 'TMOUT': '86400', 13:00:56 INFO - 'USER': 'cltbld', 13:00:56 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1474919847.180215-1454381279', 13:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:56 INFO - '_': '/tools/buildbot/bin/python'} 13:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:00:56 INFO - Cleaning up... 13:00:56 INFO - Return code: 0 13:00:56 INFO - Running post-action listener: _resource_record_post_action 13:00:56 INFO - Running post-action listener: _start_resource_monitoring 13:00:56 INFO - Starting resource monitoring. 13:00:56 INFO - [mozharness: 2016-09-26 20:00:56.687848Z] Finished create-virtualenv step (success) 13:00:56 INFO - [mozharness: 2016-09-26 20:00:56.688322Z] Running install step. 13:00:56 INFO - Running pre-action listener: _resource_record_pre_action 13:00:56 INFO - Running main action method: install 13:00:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:00:56 INFO - Reading from file tmpfile_stdout 13:00:56 INFO - Detecting whether we're running mozinstall >=1.0... 13:00:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:00:56 INFO - Reading from file tmpfile_stdout 13:00:56 INFO - Output received: 13:00:56 INFO - Usage: mozinstall [options] installer 13:00:56 INFO - Options: 13:00:56 INFO - -h, --help show this help message and exit 13:00:56 INFO - -d DEST, --destination=DEST 13:00:56 INFO - Directory to install application into. [default: 13:00:56 INFO - "/builds/slave/test"] 13:00:56 INFO - --app=APP Application being installed. [default: firefox] 13:00:56 INFO - mkdir: /builds/slave/test/build/application 13:00:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:01:12 INFO - Reading from file tmpfile_stdout 13:01:12 INFO - Output received: 13:01:12 INFO - /builds/slave/test/build/application/firefox/firefox 13:01:12 INFO - Running post-action listener: _resource_record_post_action 13:01:12 INFO - [mozharness: 2016-09-26 20:01:12.064727Z] Finished install step (success) 13:01:12 INFO - [mozharness: 2016-09-26 20:01:12.064972Z] Running run-tests step. 13:01:12 INFO - Running pre-action listener: _resource_record_pre_action 13:01:12 INFO - Running main action method: run_tests 13:01:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:01:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:01:12 INFO - Python 2.7.3 13:01:12 INFO - Return code: 0 13:01:12 INFO - grabbing minidump binary from tooltool 13:01: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')]} 13:01:12 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 0x28c9790>, '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 0x28ca690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28cab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:01:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:01:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:01:12 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:01:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:01:12 INFO - Return code: 0 13:01:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:01:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:01:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:01:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:01:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:01:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Date', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BqSTVOBRRryDw_b8Ip7pDg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:01:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Date --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BqSTVOBRRryDw_b8Ip7pDg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:01:12 INFO - Using env: {'DISPLAY': ':0', 13:01:12 INFO - 'HOME': '/home/cltbld', 13:01:12 INFO - 'LANG': 'en_US.UTF-8', 13:01:12 INFO - 'LANGUAGE': 'en_US:en', 13:01:12 INFO - 'LOGNAME': 'cltbld', 13:01:12 INFO - 'MAIL': '/var/mail/cltbld', 13:01:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:01:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:01:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:12 INFO - 'MOZ_NO_REMOTE': '1', 13:01:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:01:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:01:12 INFO - 'NO_EM_RESTART': '1', 13:01:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:01:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:01:12 INFO - 'PWD': '/builds/slave/test', 13:01:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:01:12 INFO - 'SHELL': '/bin/bash', 13:01:12 INFO - 'SHLVL': '1', 13:01:12 INFO - 'TERM': 'linux', 13:01:12 INFO - 'TMOUT': '86400', 13:01:12 INFO - 'USER': 'cltbld', 13:01:12 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1474919847.180215-1454381279', 13:01:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:12 INFO - '_': '/tools/buildbot/bin/python'} 13:01:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Date', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BqSTVOBRRryDw_b8Ip7pDg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:01:12 INFO - mozversion application_buildid: 20160926094650 13:01:12 INFO - mozversion application_changeset: 40ee5ff8fad82e4581e49361beb1d00179521420 13:01:12 INFO - mozversion application_display_name: Firefox 13:01:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:01:12 INFO - mozversion application_name: Firefox 13:01:12 INFO - mozversion application_remotingname: firefox 13:01:12 INFO - mozversion application_repository: https://hg.mozilla.org/projects/date 13:01:12 INFO - mozversion application_vendor: Mozilla 13:01:12 INFO - mozversion application_version: 52.0a1 13:01:12 INFO - mozversion platform_buildid: 20160926094650 13:01:12 INFO - mozversion platform_changeset: 40ee5ff8fad82e4581e49361beb1d00179521420 13:01:12 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/date 13:01:12 INFO - mozversion platform_version: 52.0a1 13:01:12 INFO - using testdate: 1474920072 13:01:12 INFO - actual date: 1474920072 13:01:12 INFO - starting webserver on 'localhost:48059' 13:01:12 INFO - SUITE-START | Running 2 tests 13:01:12 INFO - TEST-START | dromaeo_css 13:01:12 INFO - operating with platform_type : linux_ 13:01:12 INFO - Initialising browser for dromaeo_css test... 13:01:12 INFO - TEST-INFO | started process 9475 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7O5dRg/profile http://localhost:48059/getInfo.html) 13:01:16 INFO - PROCESS | 9475 | __metrics Screen width/height:1600/1200 13:01:16 INFO - PROCESS | 9475 | colorDepth:24 13:01:16 INFO - PROCESS | 9475 | Browser inner width/height: 1024/697 13:01:16 INFO - PROCESS | 9475 | __metrics 13:01:17 INFO - PROCESS | 9475 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:01:17 INFO - PROCESS | 9475 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:01:17 INFO - PROCESS | 9475 | console.error: PushService: 13:01:17 INFO - PROCESS | 9475 | stateChangeProcessEnqueue: Error transitioning state 13:01:17 INFO - PROCESS | 9475 | UnknownError 13:01:18 INFO - TEST-INFO | 9475: exit 0 13:01:18 INFO - Browser initialized. 13:01:18 INFO - Running cycle 1/1 for dromaeo_css test... 13:01:18 INFO - TEST-INFO | started process 9557 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7O5dRg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:01:30 INFO - PROCESS | 9557 | RSS: Main: 173408256 13:01:30 INFO - PROCESS | 9557 | 13:02:22 INFO - PROCESS | 9557 | 1474920142099 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:04:31 INFO - PROCESS | 9557 | Cycle 1(1): loaded http://localhost:48059/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48059/tests/dromaeo/cssquery-ext.html) 13:04:32 INFO - PROCESS | 9557 | RSS: Main: 323391488 13:04:32 INFO - PROCESS | 9557 | 13:07:35 INFO - PROCESS | 9557 | Cycle 1(1): loaded http://localhost:48059/tests/dromaeo/cssquery-ext.html (next: http://localhost:48059/tests/dromaeo/cssquery-jquery.html) 13:07:35 INFO - PROCESS | 9557 | RSS: Main: 275177472 13:07:35 INFO - PROCESS | 9557 | 13:10:37 INFO - PROCESS | 9557 | Cycle 1(1): loaded http://localhost:48059/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48059/tests/dromaeo/cssquery-mootools.html) 13:10:38 INFO - PROCESS | 9557 | RSS: Main: 216461312 13:10:38 INFO - PROCESS | 9557 | 13:13:40 INFO - PROCESS | 9557 | Cycle 1(1): loaded http://localhost:48059/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48059/tests/dromaeo/cssquery-prototype.html) 13:13:41 INFO - PROCESS | 9557 | RSS: Main: 256880640 13:13:41 INFO - PROCESS | 9557 | 13:16:43 INFO - PROCESS | 9557 | Cycle 1(1): loaded http://localhost:48059/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48059/tests/dromaeo/cssquery-yui.html) 13:16:44 INFO - PROCESS | 9557 | RSS: Main: 216641536 13:16:44 INFO - PROCESS | 9557 | 13:19:47 INFO - PROCESS | 9557 | Cycle 1(1): loaded http://localhost:48059/tests/dromaeo/cssquery-yui.html (next: http://localhost:48059/tests/dromaeo/cssquery-dojo.html) 13:19:47 INFO - PROCESS | 9557 | RSS: Main: 314249216 13:19:47 INFO - PROCESS | 9557 | 13:19:47 INFO - PROCESS | 9557 | __start_tp_report 13:19:47 INFO - PROCESS | 9557 | _x_x_mozilla_page_load 13:19:47 INFO - PROCESS | 9557 | _x_x_mozilla_page_load_details 13:19:47 INFO - PROCESS | 9557 | |i|pagename|runs| 13:19:47 INFO - PROCESS | 9557 | |0;dojo.html;2891.624088868447;2905.6658484274317;2922.9415411691766;2950.6459224893015;2954.8079374840636;5574.721263936807;5655.208270842086;5666.631668941521;5677.574181936356;5744.712764361776;5619.971900140504;5665.093585026386;5710.14347847822;5742.39704830993;5759.856003599912;4805.831795887145;5004.424491183506;5037.319961805155;5139.280500729901;5152.355955505562;5126.92309615356;5173.586113110942;5174.586033117342;5183.455737147602;5248.134057880445;5025;5208.973955130238;5216.087184742655;5241.554467870235;5330.38700549436;5022.397312322508;5054.721990290533;5090.032893750175;5090.261912022773;5093.745312734385;5031.195008798574;5044.117279476113;5049.166887463564;5139.126348520723;5192.92210616841;5707.600467967244;5729.512991395736;5737.627054241461;5742.856428589277;5755.194272801811;5915.645061296336;5976.701164941735;5992.2809262888295;6035.879282414371;6074.696265186767;6117;6123.969380153116;6142.232220972379;6148.292946311187;6155.907661385083;5683;5688.345840228385;5690.9146362804595;5692;5700.37295897451;5996.370381110008;6042.667653279112;6052.425019623129;6083.726232319556;6093.671727366957;5856.033754430471;5861.325947516005;5882.735276912549;5888.411158884163;5963.016102343065;6145.586515101551;6155.938440615626;6160.753569857246;6163.722632481549;6165.722542485599;6099.756009759649;6133.26400831903;6152.969235153795;6160.507159427235;6162.907556386658;5903.144044113579;5968.791092311748;6155.599886007395;6175.876482470326;6192.380761923861;4620.19146649335;4652.302154676758;4654.2785868190485;4678.60231880294;4735.076660051257;4056.1887622475033;4083.0200751819943;4085.428040074392;4115.814788334532;4128.814203360856;5622.550195984311;5770.567207459458;5844.327902291291;5846.123081537803;5849.61977471463;5932.495737862244;6055.515558755289;6070.696465176724;6072.392760723892;6076.118962750376;5701.629394089371;5723.227364305765;5751.769929202868;5758.510526605285;5769.624974376652;5196.168613021899;5249.42256351801;5260.658057226268;5323.920141197885;5336.17289320156;6393.488520918316;6416.7433302668305;6428.5178611604315;6447.323031081763;6449.097126402307;6143.6006659568775;6157.846053848511;6163.691815409122;6163.876722465436;6165.229346331708;6106.551676171979;6118.5411094169;6228.626282423069;6271.843203919756;6328.177336946167;5999.700014999145;6001.879962400815;6065.878682426415;6075.058365953284;6077.24034495688;6097.512199023979;6107.206063211754;6110.419510146529;6125.234345706786;6136.754529818757;5807.070868660994;5861.912071318849;5977.551683623833;5978.970105149447;5986.88026239464;5899.764009439575;5927.347991720821;5937.317208520903;5994.3705910878725;6073.392660734068;5903.085021821625;5944.108383742473;5947.078202878561;5955;5955.315138759098;5819.621724587888;5917.822465326047;5969.940300596939;5981.491573216152;5983.252093488314;5741.368449470639;5803.506701930383;5854.619449735754;5879.764809407576;5935.139404786196 13:19:47 INFO - PROCESS | 9557 | |1;ext.html;584.8654809393839;604.5828378418892;619.1332135010987;628.8365025093477;644.2687549631167;35976.64023359769;36838;36853.99999999996;43337;44547.55452445475;46514.30228546566;46823.76588117055;46900.76549617247;46944.530554694444;47002.76498617502;8862.202401783838;9003.414778039407;9011.729648110535;9013.05362936892;9019.639214431447;8042.276195142436;8240.752777416657;10333.58665653373;10512.894871051269;10558.260921735482;10679.572817087308;10768.623098191565;10784;10790.136789056856;10799.676009719682;10582.894171058306;10595.311304765166;10650.094741946943;10660.253782235208;10665.733356666067;10394.376337419779;10523.78952420955;10535.525901334458;10535.947320263427;10539.209559283085;42714.78642606798;43126.78436607828;43130.76519261068;43148.568514315084;43175.56824431747;3660.2496488220117;3668.853245870162;3732.5520937487404;3734.804862444019;3802.5817160112365;32224.838875805704;32355.6764432355;32584.674153258402;34314;34733;4473.194824931511;4536.160810250114;4589.862304130881;4611.193041217807;4798.5201479852085;317957;319283;320234;320477.39761301276;320700.9999999977;53524.732376338645;53683.463165367844;53696.463035369925;53730;53797;38917.22165556673;39936.400953985714;40354.394684079765;42668.359974600404;66930.9960350595;17353.479395618153;17611.207495662726;17634.735478967825;17641.7353739694;17665.7350139748;12203.389830508439;13463.932680336535;13729.244891531062;13736.793948090786;13751.793723094162;17446;19612.11745471457;20602.27892023772;20647.077055359434;20686.17255309771;7348.63256837156;7371.557706537517;7490.962545187348;7550;7610.1628820829665;871.9476831390136;941.4727752458645;990.4750482244422;1094.3871431998107;1130.5421304371744;33095.834520827724;33396.18522120545;33521.497177542355;33537.16157096043;33993;1034.1984961654628;1072.3512275073467;1090.7164137324353;1136.5624234669713;1153.6250718516517;16978.23597938071;17594;17621.471355859343;17688.646227075387;17699.82300176982;577313;579885;583239;583889;589811;59456.405435945955;59786;59862.10206846901;59957;60046.39953600495;1272.5864094169247;1286.6075846866609;1306.7582497238232;1361;1364.092878235962;28945.42109157847;33404.33191336208;33740.084203401275;33951.66048339485;34206.65793342035;51790;52406.47593524016;52418.213726793365;52449.21326180034;52476.73761631167;300259;300807;301251;301432;302158;29558.408831822813;30403.847980759954;30614.234644134074;30986.211240988418;32673.18317041998;46099.76950115228;48580.75709621429;48976.51023489719;49748;50978;39835.87841442163;42447.78776106223;42743.572564273956;43230.13539729125;43377.56622433735;40901.38647920343;43465.13069738651;44292.33561496645;46765.53234467748;47013.76493117512;42307.7884610575;42678.35982460328;42817.78591107149;42931.35602966021;44138.11723765571;35225.82387088048;38141.427878581286;38438.423423648106;39065;39202.6079739199;28357.291067723472;28762.280942976595;28962.710372896003;29109.70890291155;29170.270743231587 13:19:47 INFO - PROCESS | 9557 | |2;jquery.html;376.8549108593191;422.7642276422764;433.32185130271125;433.4776594203984;438.12812503118784;14745.48390806322;19438.319658811943;19440.708389374136;20120.396388108344;20147.496312592157;19028.429147125607;19069.80930190698;19075.61848763024;19232.71150932737;19387.806121938775;5479.3972663007235;5537.446255374471;5749.568782341341;5777.277840269966;5781.884362312751;5769.567282453832;5791.420857914196;5796.304443466769;5800.245968024151;5804.59367844251;5783.913241301384;5795.739191736361;6068.544859135561;6234.563580549363;6314.557980941313;6167.105769663419;6342.556021078526;6375.362463753588;6377.234731832186;6388.680565971683;5631.71841407928;5695.515881150066;5702.401247868997;5703.17303990919;5708.457696518824;14190.290485475685;14466.566003019927;22441.55116897653;23585;23766.64350034751;2288.439332363582;2338.5790557699606;2339.894704738291;2456.803455723538;2936.0017594017922;9787.608495660237;10163.695089147264;10296.124829389511;10638.521266542946;10876.836847447295;1931.4302280827048;1969.7931717169777;2005.8796472211568;2011.9497012574657;2060.8454365922616;79926.60036699838;86673.99999999937;87217.56391218003;87227.56386218028;90235.54882225547;11244.49399777012;11455.942720286512;11533.250338728123;11580.305181689126;11851.348175850238;16540.105481540922;16547.83452165463;16554.42059527935;16571.337146514245;16578;8289.917100829036;8397.790055248668;8555.657773689107;8646.697365592174;8767.824643507094;7802.414818888493;7809.180036096242;8044.678212871537;8086.7169649062;8269.503829770232;4730.455997560256;4790.520947905182;4860.416749990024;4899.706017638953;5065.240213967934;1976.723258743777;1986.8409229325441;2061.1655626492434;2103.347962131744;2110.2614085070104;863.6977058029639;1003.2575893838507;1027.429776474064;1030.6547306652205;1035.5443604813859;19736;19776.901115494617;19869.205231790856;19909;19986.400407987785;958.1281034258791;973.8636590877283;977.2670497127154;987.5852142100335;1012.5190534496055;10360.533775980099;10927.289726167774;10947.56209751617;10989.670309890716;10999.34003959765;446785;448678;450263;454132;455527;94286.5285673581;94435.52782236045;95327;96588;102134;997.3915911294105;1019.5666841592442;1046.2885238038054;1051.9000694933968;1058.2010582010532;16544.50366489007;17098.658026839144;17447.214875330388;17811.287548498432;18299.634007320044;43124.35313470363;43483.56516434922;43798.56201437945;43876.34185487156;45567.31649025201;57401.42598573961;58188.4181158183;58616;60334.39665603288;62063.37936620576;7960.721374751856;8265.917340826756;8279.172082791672;8284.627191776504;8524.531150786766;9079.046700096394;11617.825732613848;12219.69450763738;12385.752284954431;12429.378531073591;10584.259101862795;10795;11006.174536909924;11186.496607652512;11385.544578216779;10492.895071049497;10769.246152769545;10790.514426850968;10913.727156821144;11015.173861960226;10836.078933290759;10999.835002474809;11198.21612487118;11209.495572699085;11534.480948357512;8079.83840323202;8181.140980196994;8246.711365102192;8292.419530633038;8717.607707653298;10702.571897124028;11027;11083.501242443948;11127.499262533043;11224.94387528057 13:19:47 INFO - PROCESS | 9557 | |3;mootools.html;1338.4092562510584;1502.6919481506288;1541.57606658169;1678.622309980254;1826.9086545672722;7998.320142787863;8839.823203535925;9249.260059195265;9254.167124958753;9634;9389.295802814799;9422.293328000393;9446.149846513812;9468.479233642147;9490.383125096863;2483.354327874752;2500.4874000829877;2500.862452565108;2506.736792636774;2514.5976643737004;2398.136670798511;2485.689288838895;2487.6641653376832;2489.2781093482868;2495.089292408276;2483.205374280222;2494.1270555305678;2507.72415034347;2510.686164229471;2512.932003898336;2411.1078900806638;2436.0864675746593;2439.743826898177;2471.270975062361;2474.134053081425;2401.087586717054;2409.3374322061572;2418.3349578865777;2424.175780234729;2471.369800700828;9272.490013049279;9279.072092790735;9287.164155225995;9306.581203845775;9394.34239603228;5440.646357986758;5629.3526244482;5641.097424412074;5642.689652069134;5756.366799652035;3551.7691350062164;3571.089372210096;3631.7457777955556;3661.9450708239397;3736.0846592584717;1154.2958795135046;1157.1090260499368;1172;1174.448009435564;1184.2953442701578;12839.807402888964;13099.279539625317;13117.409716562683;13138.605841824761;13140.6714832129;4757.35775670287;4862.927056094161;4877.219644856806;4931.852044438672;4966.180580204298;10920.50857711405;10956.616518421817;10958.452077396098;10964.451777411097;10987.39569323695;5623.044082505902;5625.943740562542;5634.60557760961;5638.097904335286;5638.223959452759;4370.082282720664;4471.463424389029;4514.6614003949835;4627.120847039052;5138.511841375063;4126.133511962462;4146.1914926589025;4331.047169622678;4348.456442944632;4353.73877567347;1382.6336020954454;1439.9568012959628;1448.739226939161;1450.7461194290956;1460.773580095087;846.204567706354;868.1969178509853;891.4294851295176;943.254828685331;956.8277710012126;5771.624844385102;5792.739326730307;5835.416458354131;5979.760809567569;6036.758529658852;438.19591050422196;466.2912373192728;468.0148287854086;472.5380766208026;478.4760687047677;4030.8790736277374;4145.564715704808;4149.149424367997;4157.812898419578;4161.83352665896;11449.828252576219;11493.71265718347;11531.769364612828;11555.653330400102;11598.536058557733;10809.83785243222;11341.659750207507;11354.886451135548;11372.601958931398;11382.146339024606;8305.792355191168;8734.388592798443;8734.606942687595;8742.475451472932;8744.606492707844;5666.603337766317;5676.631018983753;5708;5779.739911703899;5903.675297858659;10668.83996740034;10760.784784304427;10771.89228107709;10787.137029037502;10798.460076995962;9555;10043.397396156253;10407.323523970917;10584.259101862795;10714.839277410689;7835.647395867086;8199.754007379788;8256.463329883538;8275.50346979183;8279.509688256172;8781.91218087811;8795.340349473687;8847.247983921181;8867.73396798097;8873.955630222066;8012.559309238048;8190.672373105009;8213.876791848246;8217.383696222687;8425.662973480992;7792.61036948139;7842.490238134503;7855.33229675484;7949.682012719427;7983.1617680142745;7327.560346379234;7469.887951680837;7500.1374841893885;7503.624818759149;7507.324340809353;5141.691498509952;5153.175491921274;5187.662801917863;5217.634765566526;5567.4432556744005;5200.869978250574;5252.1596544552685;5265.315508983961;5269.288646032736;5453.454654534515 13:19:47 INFO - PROCESS | 9557 | |4;prototype.html;347.3955317747119;351.09242607858687;361.759429979064;368.7345111519705;369.89827797355724;5387.380451248107;5588.273524441817;5591.440855914407;5645.5483561315095;5685.687287199203;5369.275147855038;5457.836264912049;5482.876010417865;5495.203195536645;5518.33779946406;4353.172897149548;4362.607365337127;4365.432493775805;4374.4313239278845;4414.955850441486;4118.455579157816;4308.246056940038;4387.583179597933;4388.407564978735;4406.1187762447635;4288.9571104289025;4297.59172878576;4299.914541447395;4308.159908817782;4309.590588894066;4320.330348795942;4332.328489084197;4332.591907630032;4333.891652708692;4364.192624364471;3746.6253374662588;3781.773093614392;3866.6326698963553;3867.3425517662067;3875.670568001723;5355.571554275649;5360.624756267063;5376.569874410038;5379.354477462691;5423.864403389907;4924.729139897304;4930.975345123287;4942.802287908479;4943.530364615356;4984.576311013569;5487.780488780444;5756.971215143939;5779.9422005779825;5784.421557844224;5787.768489260467;4179.623833854967;4190.601892820177;4198.685098617585;4210.894727631803;4220.662347012231;6017.458428741391;6028.216331876828;6045.72794224261;6050.8184754457;6083.2395950506625;4232.386303985905;4288.120935208337;4318.30907054876;4339.848105316299;4342.934855977162;4343.609075183249;4348.586884245991;4356.760378179167;4359.17175736609;4362.6946113772365;4935.457099719028;4963.6525443218625;4964.280179373971;4996.850094497171;4999.400071991312;5673.723412232297;5814.186013958049;5826.329972053183;5826.504747096459;5834.27071616048;1483.1397789282191;1496.2817847433294;1499.130504307499;1499.567912643423;1500.7543738696857;927.657230653282;961.423146112327;975.2588033094898;976.9316147869723;977.4379731654327;4992.929348450749;5019.222020586742;5041.773120209599;5043.36957880265;5078.415982162025;5277.472252774692;5281.642644817964;5295.258663787073;5306.814261500829;5325.9733701332025;4760.048380164185;4856.587190088811;4956.801727930914;5061.114304996685;5096.821611243588;2760.2748282323546;2785.2340606333014;2787.7351651593067;2795.5527115661803;2818.788590855694;5463;5468.91796623051;5525.364583072998;5533.723313834373;5561.221428999943;4947.332110165154;5285.418603953562;5290.338707661543;5292.470752924677;5322.456487618547;5421.566274697936;5432.348118225759;5440.510354068153;5456.809011684572;5457.590680698963;5212.166053431584;5212.348456442945;5226.71253081069;5242.292290540729;5293.153095504701;5615.950178185015;5920.940790592039;5947.899638566879;5949.226600542075;5994.580379373402;6294.685265736786;6317.652529110943;6319.24169099711;6329.778457753957;6362.300146983735;4034.9798251009734;4157.230912281238;4173.937390939078;4282.657387409062;4299.269124248823;5893.381194974466;5904.439078287556;5921.134842524591;5927.436893495111;5935.2877654681715;5678.6876721779045;5709.143628455765;5777.826665200051;5819.447152520504;5847.707614619167;5742.36833948257;5750.971245143747;5756.079027355603;5769.2403816834585;5790.2206940667875;5743.712814359349;5743.913841292468;5761.711914404179;5771.769129234784;5800.767969281182;5685.260916080883;5808.651480911159;5817.621854579439;5836.795712150054;5866.882662346815;5584.888302233851;5589.636673616202;5631.239782629293;5682;5693.345265294544 13:19:47 INFO - PROCESS | 9557 | |5;yui.html;778.4161878591058;820.9876851847223;876.3514998900812;878.9736307910765;887.8801361816157;14609;16008.599785005366;16014.83985160148;16064.598385040365;17255.568610784736;16062.919685401586;16132.112733799637;16145.354185832553;16178.433754818583;16290.83709162908;821.2485575698229;844.5186243841013;845.9577021148918;848.1518481518482;848.6944699908029;723.4321057969495;741.5068979128899;834.7913021744564;855.0978717453085;856.2892798976834;895.5432729308067;899.0964081098487;899.9100089990982;899.9325050621197;902.0933961368816;893.7586851550078;894.5124906925709;900.0549423105779;900.9639614415415;901.6078006067381;390.7635880292411;394.9585293544165;644.8387903024244;660.4122331125302;669.364104101101;15680.529584112495;15744.291506882104;15749.685006299924;15758.76361854573;15804.683906321925;13935.233562154179;14221.502247421395;14519.346629401702;14586.708265834624;14655.560333189915;12754.744905101847;12757.234565926074;13051.412686429134;13091.607251782461;13284.335783210898;4395.296752519582;4427.313766366218;4429.335599660077;4477.417935668343;4485.237509623372;77998;78026;78037;78269.60865195695;78546;12279.447424865903;12301.56944506956;12339.197952133083;12490.25058496475;12502.249865008129;23946.52106957851;23987.520249595258;24018.639720404208;24080;24112.87943560306;9317.534123293808;9408.764780880532;9584.808303834025;9618.663346782969;9649.758756031155;4982.078315511642;4989.351384320015;5036.823711170092;5050.671706339076;5200.843974680765;3805.9429108563395;3897.8051097445014;3934.567197608261;3935.2916475034194;3935.5277366716177;646.9842347514451;652.1326635574675;660.920689517261;668.6589839182052;691.7578847403469;663.5952069237761;674.1707699529607;675.5237557521936;707.2573797512591;713.12642013533;9220.950813950616;9326.160645541933;9405.623775049058;9443.338966272433;9505.287103467268;563.9097744360964;611.9357467465852;628.7422156915734;657.8585604095142;681.2370145437142;4235.1317979814685;4526.23054080807;4532.478764942008;4537.478190008125;4613.907721845544;101185.49407252917;118422.40788796001;119784;123032.38483807523;123049;101822;105496;106844;108459.45770271098;112031.43984280189;89420;91868.54065729628;92045;92783;93811;8647.178518040777;8752.78118047054;8943.955280223558;9054.139856713602;9106.575421610074;55301.170482441994;55762.442375577346;55829.44170558242;56104.43895561156;56570.717146414005;74345.6282718583;78950;80051.19180931023;81323;81647.59176204081;11349.659510214376;11364.659060228207;11583.478743456733;11600.477978490819;12006.159568830099;11431;11511.942440287745;12011.399430028288;12393.132480726263;12842.460652400354;10872.07587355052;11275.32348059119;11299.71750706206;11462.369569673414;11890.940545297219;11647.242929209575;11745.29528228309;11783.351915644722;11784.057275418118;11791.469383877575;11739.11956603241;11755.294682319089;11916.880831191924;12063.75872482563;12170.513179472722;9426.151646351862;9560.904390956;9620.903790962;9636.614535418505;9874.851877221703;9358.29812764059;10075.294729369167;10180.541875615763;10208.540615672164;10214.591416343263 13:19:47 INFO - PROCESS | 9557 | __end_tp_report 13:19:47 INFO - PROCESS | 9557 | __start_cc_report 13:19:47 INFO - PROCESS | 9557 | _x_x_mozilla_cycle_collect,1130 13:19:47 INFO - PROCESS | 9557 | __end_cc_report 13:19:47 INFO - PROCESS | 9557 | __startTimestamp1474921187532__endTimestamp 13:19:47 INFO - PROCESS | 9557 | 13:19:47 INFO - PROCESS | 9557 | ------- Summary: start ------- 13:19:47 INFO - PROCESS | 9557 | Number of tests: 6 13:19:47 INFO - PROCESS | 9557 | 13:19:47 INFO - PROCESS | 9557 | [#0] dojo.html Cycles:165 Average:5633.83 Median:5861.91 stddev:695.85 (11.9%) stddev-sans-first:663.90 13:19:47 INFO - PROCESS | 9557 | Values: 2891.6 2905.7 2922.9 2950.6 2954.8 5574.7 5655.2 5666.6 5677.6 5744.7 5620.0 5665.1 5710.1 5742.4 5759.9 4805.8 5004.4 5037.3 5139.3 5152.4 5126.9 5173.6 5174.6 5183.5 5248.1 5025.0 5209.0 5216.1 5241.6 5330.4 5022.4 5054.7 5090.0 5090.3 5093.7 5031.2 5044.1 5049.2 5139.1 5192.9 5707.6 5729.5 5737.6 5742.9 5755.2 5915.6 5976.7 5992.3 6035.9 6074.7 6117.0 6124.0 6142.2 6148.3 6155.9 5683.0 5688.3 5690.9 5692.0 5700.4 5996.4 6042.7 6052.4 6083.7 6093.7 5856.0 5861.3 5882.7 5888.4 5963.0 6145.6 6155.9 6160.8 6163.7 6165.7 6099.8 6133.3 6153.0 6160.5 6162.9 5903.1 5968.8 6155.6 6175.9 6192.4 4620.2 4652.3 4654.3 4678.6 4735.1 4056.2 4083.0 4085.4 4115.8 4128.8 5622.6 5770.6 5844.3 5846.1 5849.6 5932.5 6055.5 6070.7 6072.4 6076.1 5701.6 5723.2 5751.8 5758.5 5769.6 5196.2 5249.4 5260.7 5323.9 5336.2 6393.5 6416.7 6428.5 6447.3 6449.1 6143.6 6157.8 6163.7 6163.9 6165.2 6106.6 6118.5 6228.6 6271.8 6328.2 5999.7 6001.9 6065.9 6075.1 6077.2 6097.5 6107.2 6110.4 6125.2 6136.8 5807.1 5861.9 5977.6 5979.0 5986.9 5899.8 5927.3 5937.3 5994.4 6073.4 5903.1 5944.1 5947.1 5955.0 5955.3 5819.6 5917.8 5969.9 5981.5 5983.3 5741.4 5803.5 5854.6 5879.8 5935.1 13:19:47 INFO - PROCESS | 9557 | 13:19:47 INFO - PROCESS | 9557 | [#1] ext.html Cycles:180 Average:57201.47 Median:20293.28 stddev:111895.52 (551.4%) stddev-sans-first:112128.68 13:19:47 INFO - PROCESS | 9557 | Values: 584.9 604.6 619.1 628.8 644.3 35976.6 36838.0 36854.0 43337.0 44547.6 46514.3 46823.8 46900.8 46944.5 47002.8 8862.2 9003.4 9011.7 9013.1 9019.6 8042.3 8240.8 10333.6 10512.9 10558.3 10679.6 10768.6 10784.0 10790.1 10799.7 10582.9 10595.3 10650.1 10660.3 10665.7 10394.4 10523.8 10535.5 10535.9 10539.2 42714.8 43126.8 43130.8 43148.6 43175.6 3660.2 3668.9 3732.6 3734.8 3802.6 32224.8 32355.7 32584.7 34314.0 34733.0 4473.2 4536.2 4589.9 4611.2 4798.5 317957.0 319283.0 320234.0 320477.4 320701.0 53524.7 53683.5 53696.5 53730.0 53797.0 38917.2 39936.4 40354.4 42668.4 66931.0 17353.5 17611.2 17634.7 17641.7 17665.7 12203.4 13463.9 13729.2 13736.8 13751.8 17446.0 19612.1 20602.3 20647.1 20686.2 7348.6 7371.6 7491.0 7550.0 7610.2 871.9 941.5 990.5 1094.4 1130.5 33095.8 33396.2 33521.5 33537.2 33993.0 1034.2 1072.4 1090.7 1136.6 1153.6 16978.2 17594.0 17621.5 17688.6 17699.8 577313.0 579885.0 583239.0 583889.0 589811.0 59456.4 59786.0 59862.1 59957.0 60046.4 1272.6 1286.6 1306.8 1361.0 1364.1 28945.4 33404.3 33740.1 33951.7 34206.7 51790.0 52406.5 52418.2 52449.2 52476.7 300259.0 300807.0 301251.0 301432.0 302158.0 29558.4 30403.8 30614.2 30986.2 32673.2 46099.8 48580.8 48976.5 49748.0 50978.0 39835.9 42447.8 42743.6 43230.1 43377.6 40901.4 43465.1 44292.3 46765.5 47013.8 42307.8 42678.4 42817.8 42931.4 44138.1 35225.8 38141.4 38438.4 39065.0 39202.6 28357.3 28762.3 28962.7 29109.7 29170.3 13:19:47 INFO - PROCESS | 9557 | 13:19:47 INFO - PROCESS | 9557 | [#2] jquery.html Cycles:180 Average:28176.21 Median:13111.72 stddev:74876.12 (571.1%) stddev-sans-first:75057.07 13:19:47 INFO - PROCESS | 9557 | Values: 376.9 422.8 433.3 433.5 438.1 14745.5 19438.3 19440.7 20120.4 20147.5 19028.4 19069.8 19075.6 19232.7 19387.8 5479.4 5537.4 5749.6 5777.3 5781.9 5769.6 5791.4 5796.3 5800.2 5804.6 5783.9 5795.7 6068.5 6234.6 6314.6 6167.1 6342.6 6375.4 6377.2 6388.7 5631.7 5695.5 5702.4 5703.2 5708.5 14190.3 14466.6 22441.6 23585.0 23766.6 2288.4 2338.6 2339.9 2456.8 2936.0 9787.6 10163.7 10296.1 10638.5 10876.8 1931.4 1969.8 2005.9 2011.9 2060.8 79926.6 86674.0 87217.6 87227.6 90235.5 11244.5 11455.9 11533.3 11580.3 11851.3 16540.1 16547.8 16554.4 16571.3 16578.0 8289.9 8397.8 8555.7 8646.7 8767.8 7802.4 7809.2 8044.7 8086.7 8269.5 4730.5 4790.5 4860.4 4899.7 5065.2 1976.7 1986.8 2061.2 2103.3 2110.3 863.7 1003.3 1027.4 1030.7 1035.5 19736.0 19776.9 19869.2 19909.0 19986.4 958.1 973.9 977.3 987.6 1012.5 10360.5 10927.3 10947.6 10989.7 10999.3 446785.0 448678.0 450263.0 454132.0 455527.0 94286.5 94435.5 95327.0 96588.0 102134.0 997.4 1019.6 1046.3 1051.9 1058.2 16544.5 17098.7 17447.2 17811.3 18299.6 43124.4 43483.6 43798.6 43876.3 45567.3 57401.4 58188.4 58616.0 60334.4 62063.4 7960.7 8265.9 8279.2 8284.6 8524.5 9079.0 11617.8 12219.7 12385.8 12429.4 10584.3 10795.0 11006.2 11186.5 11385.5 10492.9 10769.2 10790.5 10913.7 11015.2 10836.1 10999.8 11198.2 11209.5 11534.5 8079.8 8181.1 8246.7 8292.4 8717.6 10702.6 11027.0 11083.5 11127.5 11224.9 13:19:47 INFO - PROCESS | 9557 | 13:19:47 INFO - PROCESS | 9557 | [#3] mootools.html Cycles:180 Average:6045.14 Median:470.28 stddev:3488.71 (741.8%) stddev-sans-first:3480.56 13:19:47 INFO - PROCESS | 9557 | Values: 1338.4 1502.7 1541.6 1678.6 1826.9 7998.3 8839.8 9249.3 9254.2 9634.0 9389.3 9422.3 9446.1 9468.5 9490.4 2483.4 2500.5 2500.9 2506.7 2514.6 2398.1 2485.7 2487.7 2489.3 2495.1 2483.2 2494.1 2507.7 2510.7 2512.9 2411.1 2436.1 2439.7 2471.3 2474.1 2401.1 2409.3 2418.3 2424.2 2471.4 9272.5 9279.1 9287.2 9306.6 9394.3 5440.6 5629.4 5641.1 5642.7 5756.4 3551.8 3571.1 3631.7 3661.9 3736.1 1154.3 1157.1 1172.0 1174.4 1184.3 12839.8 13099.3 13117.4 13138.6 13140.7 4757.4 4862.9 4877.2 4931.9 4966.2 10920.5 10956.6 10958.5 10964.5 10987.4 5623.0 5625.9 5634.6 5638.1 5638.2 4370.1 4471.5 4514.7 4627.1 5138.5 4126.1 4146.2 4331.0 4348.5 4353.7 1382.6 1440.0 1448.7 1450.7 1460.8 846.2 868.2 891.4 943.3 956.8 5771.6 5792.7 5835.4 5979.8 6036.8 438.2 466.3 468.0 472.5 478.5 4030.9 4145.6 4149.1 4157.8 4161.8 11449.8 11493.7 11531.8 11555.7 11598.5 10809.8 11341.7 11354.9 11372.6 11382.1 8305.8 8734.4 8734.6 8742.5 8744.6 5666.6 5676.6 5708.0 5779.7 5903.7 10668.8 10760.8 10771.9 10787.1 10798.5 9555.0 10043.4 10407.3 10584.3 10714.8 7835.6 8199.8 8256.5 8275.5 8279.5 8781.9 8795.3 8847.2 8867.7 8874.0 8012.6 8190.7 8213.9 8217.4 8425.7 7792.6 7842.5 7855.3 7949.7 7983.2 7327.6 7469.9 7500.1 7503.6 7507.3 5141.7 5153.2 5187.7 5217.6 5567.4 5200.9 5252.2 5265.3 5269.3 5453.5 13:19:47 INFO - PROCESS | 9557 | 13:19:47 INFO - PROCESS | 9557 | [#4] prototype.html Cycles:180 Average:4757.58 Median:5294.21 stddev:1379.56 (26.1%) stddev-sans-first:1343.13 13:19:47 INFO - PROCESS | 9557 | Values: 347.4 351.1 361.8 368.7 369.9 5387.4 5588.3 5591.4 5645.5 5685.7 5369.3 5457.8 5482.9 5495.2 5518.3 4353.2 4362.6 4365.4 4374.4 4415.0 4118.5 4308.2 4387.6 4388.4 4406.1 4289.0 4297.6 4299.9 4308.2 4309.6 4320.3 4332.3 4332.6 4333.9 4364.2 3746.6 3781.8 3866.6 3867.3 3875.7 5355.6 5360.6 5376.6 5379.4 5423.9 4924.7 4931.0 4942.8 4943.5 4984.6 5487.8 5757.0 5779.9 5784.4 5787.8 4179.6 4190.6 4198.7 4210.9 4220.7 6017.5 6028.2 6045.7 6050.8 6083.2 4232.4 4288.1 4318.3 4339.8 4342.9 4343.6 4348.6 4356.8 4359.2 4362.7 4935.5 4963.7 4964.3 4996.9 4999.4 5673.7 5814.2 5826.3 5826.5 5834.3 1483.1 1496.3 1499.1 1499.6 1500.8 927.7 961.4 975.3 976.9 977.4 4992.9 5019.2 5041.8 5043.4 5078.4 5277.5 5281.6 5295.3 5306.8 5326.0 4760.0 4856.6 4956.8 5061.1 5096.8 2760.3 2785.2 2787.7 2795.6 2818.8 5463.0 5468.9 5525.4 5533.7 5561.2 4947.3 5285.4 5290.3 5292.5 5322.5 5421.6 5432.3 5440.5 5456.8 5457.6 5212.2 5212.3 5226.7 5242.3 5293.2 5616.0 5920.9 5947.9 5949.2 5994.6 6294.7 6317.7 6319.2 6329.8 6362.3 4035.0 4157.2 4173.9 4282.7 4299.3 5893.4 5904.4 5921.1 5927.4 5935.3 5678.7 5709.1 5777.8 5819.4 5847.7 5742.4 5751.0 5756.1 5769.2 5790.2 5743.7 5743.9 5761.7 5771.8 5800.8 5685.3 5808.7 5817.6 5836.8 5866.9 5584.9 5589.6 5631.2 5682.0 5693.3 13:19:47 INFO - PROCESS | 9557 | 13:19:47 INFO - PROCESS | 9557 | [#5] yui.html Cycles:180 Average:21440.02 Median:4797.99 stddev:31606.71 (658.7%) stddev-sans-first:31657.30 13:19:47 INFO - PROCESS | 9557 | Values: 778.4 821.0 876.4 879.0 887.9 14609.0 16008.6 16014.8 16064.6 17255.6 16062.9 16132.1 16145.4 16178.4 16290.8 821.2 844.5 846.0 848.2 848.7 723.4 741.5 834.8 855.1 856.3 895.5 899.1 899.9 899.9 902.1 893.8 894.5 900.1 901.0 901.6 390.8 395.0 644.8 660.4 669.4 15680.5 15744.3 15749.7 15758.8 15804.7 13935.2 14221.5 14519.3 14586.7 14655.6 12754.7 12757.2 13051.4 13091.6 13284.3 4395.3 4427.3 4429.3 4477.4 4485.2 77998.0 78026.0 78037.0 78269.6 78546.0 12279.4 12301.6 12339.2 12490.3 12502.2 23946.5 23987.5 24018.6 24080.0 24112.9 9317.5 9408.8 9584.8 9618.7 9649.8 4982.1 4989.4 5036.8 5050.7 5200.8 3805.9 3897.8 3934.6 3935.3 3935.5 647.0 652.1 660.9 668.7 691.8 663.6 674.2 675.5 707.3 713.1 9221.0 9326.2 9405.6 9443.3 9505.3 563.9 611.9 628.7 657.9 681.2 4235.1 4526.2 4532.5 4537.5 4613.9 101185.5 118422.4 119784.0 123032.4 123049.0 101822.0 105496.0 106844.0 108459.5 112031.4 89420.0 91868.5 92045.0 92783.0 93811.0 8647.2 8752.8 8944.0 9054.1 9106.6 55301.2 55762.4 55829.4 56104.4 56570.7 74345.6 78950.0 80051.2 81323.0 81647.6 11349.7 11364.7 11583.5 11600.5 12006.2 11431.0 11511.9 12011.4 12393.1 12842.5 10872.1 11275.3 11299.7 11462.4 11890.9 11647.2 11745.3 11783.4 11784.1 11791.5 11739.1 11755.3 11916.9 12063.8 12170.5 9426.2 9560.9 9620.9 9636.6 9874.9 9358.3 10075.3 10180.5 10208.5 10214.6 13:19:47 INFO - PROCESS | 9557 | -------- Summary: end -------- 13:19:47 INFO - PROCESS | 9557 | 13:19:48 INFO - TEST-INFO | 9557: exit 0 13:19:48 INFO - TEST-OK | dromaeo_css | took 1116098ms 13:19:48 INFO - TEST-START | kraken 13:19:48 INFO - operating with platform_type : linux_ 13:19:48 INFO - Initialising browser for kraken test... 13:19:48 INFO - TEST-INFO | started process 9867 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq04suc/profile http://localhost:48059/getInfo.html) 13:19:52 INFO - PROCESS | 9867 | __metrics Screen width/height:1600/1200 13:19:52 INFO - PROCESS | 9867 | colorDepth:24 13:19:52 INFO - PROCESS | 9867 | Browser inner width/height: 1024/697 13:19:52 INFO - PROCESS | 9867 | __metrics 13:19:53 INFO - PROCESS | 9867 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:19:53 INFO - PROCESS | 9867 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:19:54 INFO - PROCESS | 9867 | console.error: PushService: 13:19:54 INFO - PROCESS | 9867 | stateChangeProcessEnqueue: Error transitioning state 13:19:54 INFO - PROCESS | 9867 | UnknownError 13:19:54 INFO - TEST-INFO | 9867: exit 0 13:19:54 INFO - Browser initialized. 13:19:54 INFO - Running cycle 1/1 for kraken test... 13:19:54 INFO - TEST-INFO | started process 9951 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq04suc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:20:06 INFO - PROCESS | 9951 | RSS: Main: 173735936 13:20:06 INFO - PROCESS | 9951 | 13:20:09 INFO - PROCESS | 9951 | Cycle 1(1): loaded http://localhost:48059/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48059/tests/kraken/driver.html?testName=audio-beat-detection) 13:20:10 INFO - PROCESS | 9951 | RSS: Main: 232247296 13:20:10 INFO - PROCESS | 9951 | 13:20:12 INFO - PROCESS | 9951 | Cycle 1(1): loaded http://localhost:48059/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48059/tests/kraken/driver.html?testName=audio-dft) 13:20:13 INFO - PROCESS | 9951 | RSS: Main: 217317376 13:20:13 INFO - PROCESS | 9951 | 13:20:16 INFO - PROCESS | 9951 | Cycle 1(1): loaded http://localhost:48059/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48059/tests/kraken/driver.html?testName=audio-fft) 13:20:17 INFO - PROCESS | 9951 | RSS: Main: 298098688 13:20:17 INFO - PROCESS | 9951 | 13:20:19 INFO - PROCESS | 9951 | Cycle 1(1): loaded http://localhost:48059/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48059/tests/kraken/driver.html?testName=audio-oscillator) 13:20:19 INFO - PROCESS | 9951 | RSS: Main: 207798272 13:20:19 INFO - PROCESS | 9951 | 13:20:21 INFO - PROCESS | 9951 | Cycle 1(1): loaded http://localhost:48059/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48059/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:20:22 INFO - PROCESS | 9951 | RSS: Main: 212017152 13:20:22 INFO - PROCESS | 9951 | 13:20:25 INFO - PROCESS | 9951 | Cycle 1(1): loaded http://localhost:48059/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48059/tests/kraken/driver.html?testName=imaging-darkroom) 13:20:26 INFO - PROCESS | 9951 | RSS: Main: 248795136 13:20:26 INFO - PROCESS | 9951 | 13:20:29 INFO - PROCESS | 9951 | Cycle 1(1): loaded http://localhost:48059/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48059/tests/kraken/driver.html?testName=imaging-desaturate) 13:20:30 INFO - PROCESS | 9951 | RSS: Main: 248119296 13:20:30 INFO - PROCESS | 9951 | 13:20:32 INFO - PROCESS | 9951 | Cycle 1(1): loaded http://localhost:48059/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48059/tests/kraken/driver.html?testName=json-parse-financial) 13:20:33 INFO - PROCESS | 9951 | RSS: Main: 247087104 13:20:33 INFO - PROCESS | 9951 | 13:20:34 INFO - PROCESS | 9951 | Cycle 1(1): loaded http://localhost:48059/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48059/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:20:35 INFO - PROCESS | 9951 | RSS: Main: 209809408 13:20:35 INFO - PROCESS | 9951 | 13:20:37 INFO - PROCESS | 9951 | Cycle 1(1): loaded http://localhost:48059/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48059/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:20:37 INFO - PROCESS | 9951 | RSS: Main: 217518080 13:20:37 INFO - PROCESS | 9951 | 13:20:39 INFO - PROCESS | 9951 | Cycle 1(1): loaded http://localhost:48059/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48059/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:20:40 INFO - PROCESS | 9951 | RSS: Main: 222654464 13:20:40 INFO - PROCESS | 9951 | 13:20:43 INFO - PROCESS | 9951 | Cycle 1(1): loaded http://localhost:48059/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48059/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:20:43 INFO - PROCESS | 9951 | RSS: Main: 222683136 13:20:43 INFO - PROCESS | 9951 | 13:20:46 INFO - PROCESS | 9951 | Cycle 1(1): loaded http://localhost:48059/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48059/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:20:46 INFO - PROCESS | 9951 | RSS: Main: 221491200 13:20:46 INFO - PROCESS | 9951 | 13:20:48 INFO - PROCESS | 9951 | Cycle 1(1): loaded http://localhost:48059/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48059/tests/kraken/driver.html?testName=ai-astar) 13:20:48 INFO - PROCESS | 9951 | RSS: Main: 273186816 13:20:48 INFO - PROCESS | 9951 | 13:20:48 INFO - PROCESS | 9951 | __start_tp_report 13:20:48 INFO - PROCESS | 9951 | _x_x_mozilla_page_load 13:20:48 INFO - PROCESS | 9951 | _x_x_mozilla_page_load_details 13:20:48 INFO - PROCESS | 9951 | |i|pagename|runs| 13:20:48 INFO - PROCESS | 9951 | |0;ai-astar;109;112;110;110;110;111;111;110;109;110 13:20:48 INFO - PROCESS | 9951 | |1;audio-beat-detection;147;116;115;160;117;123;116;115;144;119 13:20:48 INFO - PROCESS | 9951 | |2;audio-dft;161;160;162;161;162;162;161;163;164;161 13:20:48 INFO - PROCESS | 9951 | |3;audio-fft;75;75;75;111;76;77;76;76;105;75 13:20:48 INFO - PROCESS | 9951 | |4;audio-oscillator;83;83;109;83;84;83;110;83;81;108 13:20:48 INFO - PROCESS | 9951 | |5;imaging-gaussian-blur;117;117;117;116;117;116;117;116;117;116 13:20:48 INFO - PROCESS | 9951 | |6;imaging-darkroom;147;147;146;146;147;147;147;147;147;146 13:20:48 INFO - PROCESS | 9951 | |7;imaging-desaturate;95;95;95;95;95;95;96;95;95;95 13:20:48 INFO - PROCESS | 9951 | |8;json-parse-financial;55;51;49;51;51;52;51;50;54;51 13:20:48 INFO - PROCESS | 9951 | |9;json-stringify-tinderbox;59;60;60;60;60;60;59;60;60;59 13:20:48 INFO - PROCESS | 9951 | |10;stanford-crypto-aes;77;77;78;76;77;85;86;77;77;78 13:20:48 INFO - PROCESS | 9951 | |11;stanford-crypto-ccm;125;132;126;119;120;118;123;121;159;130 13:20:48 INFO - PROCESS | 9951 | |12;stanford-crypto-pbkdf2;160;163;166;163;162;159;161;160;161;161 13:20:48 INFO - PROCESS | 9951 | |13;stanford-crypto-sha256-iterative;75;64;63;63;63;67;63;63;67;63 13:20:48 INFO - PROCESS | 9951 | __end_tp_report 13:20:48 INFO - PROCESS | 9951 | __start_cc_report 13:20:48 INFO - PROCESS | 9951 | _x_x_mozilla_cycle_collect,1576 13:20:48 INFO - PROCESS | 9951 | __end_cc_report 13:20:48 INFO - PROCESS | 9951 | __startTimestamp1474921248928__endTimestamp 13:20:48 INFO - PROCESS | 9951 | 13:20:48 INFO - PROCESS | 9951 | ------- Summary: start ------- 13:20:48 INFO - PROCESS | 9951 | Number of tests: 14 13:20:48 INFO - PROCESS | 9951 | 13:20:48 INFO - PROCESS | 9951 | [#0] ai-astar Cycles:10 Average:110.20 Median:110.00 stddev:0.92 (0.8%) stddev-sans-first:0.87 13:20:48 INFO - PROCESS | 9951 | Values: 109.0 112.0 110.0 110.0 110.0 111.0 111.0 110.0 109.0 110.0 13:20:48 INFO - PROCESS | 9951 | 13:20:48 INFO - PROCESS | 9951 | [#1] audio-beat-detection Cycles:10 Average:127.20 Median:121.00 stddev:16.63 (13.7%) stddev-sans-first:16.02 13:20:48 INFO - PROCESS | 9951 | Values: 147.0 116.0 115.0 160.0 117.0 123.0 116.0 115.0 144.0 119.0 13:20:48 INFO - PROCESS | 9951 | 13:20:48 INFO - PROCESS | 9951 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.16 (0.7%) stddev-sans-first:1.20 13:20:48 INFO - PROCESS | 9951 | Values: 161.0 160.0 162.0 161.0 162.0 162.0 161.0 163.0 164.0 161.0 13:20:48 INFO - PROCESS | 9951 | 13:20:48 INFO - PROCESS | 9951 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.50 stddev:13.74 (18.2%) stddev-sans-first:14.33 13:20:48 INFO - PROCESS | 9951 | Values: 75.0 75.0 75.0 111.0 76.0 77.0 76.0 76.0 105.0 75.0 13:20:48 INFO - PROCESS | 9951 | 13:20:48 INFO - PROCESS | 9951 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:83.00 stddev:12.66 (15.3%) stddev-sans-first:13.12 13:20:48 INFO - PROCESS | 9951 | Values: 83.0 83.0 109.0 83.0 84.0 83.0 110.0 83.0 81.0 108.0 13:20:48 INFO - PROCESS | 9951 | 13:20:48 INFO - PROCESS | 9951 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 13:20:48 INFO - PROCESS | 9951 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 117.0 116.0 117.0 116.0 13:20:48 INFO - PROCESS | 9951 | 13:20:48 INFO - PROCESS | 9951 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 13:20:48 INFO - PROCESS | 9951 | Values: 147.0 147.0 146.0 146.0 147.0 147.0 147.0 147.0 147.0 146.0 13:20:48 INFO - PROCESS | 9951 | 13:20:48 INFO - PROCESS | 9951 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 13:20:48 INFO - PROCESS | 9951 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 13:20:48 INFO - PROCESS | 9951 | 13:20:48 INFO - PROCESS | 9951 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:51.00 stddev:1.78 (3.5%) stddev-sans-first:1.36 13:20:48 INFO - PROCESS | 9951 | Values: 55.0 51.0 49.0 51.0 51.0 52.0 51.0 50.0 54.0 51.0 13:20:48 INFO - PROCESS | 9951 | 13:20:48 INFO - PROCESS | 9951 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 13:20:48 INFO - PROCESS | 9951 | Values: 59.0 60.0 60.0 60.0 60.0 60.0 59.0 60.0 60.0 59.0 13:20:48 INFO - PROCESS | 9951 | 13:20:48 INFO - PROCESS | 9951 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:77.50 stddev:3.58 (4.6%) stddev-sans-first:3.74 13:20:48 INFO - PROCESS | 9951 | Values: 77.0 77.0 78.0 76.0 77.0 85.0 86.0 77.0 77.0 78.0 13:20:48 INFO - PROCESS | 9951 | 13:20:48 INFO - PROCESS | 9951 | [#11] stanford-crypto-ccm Cycles:10 Average:127.30 Median:125.50 stddev:12.06 (9.6%) stddev-sans-first:12.76 13:20:48 INFO - PROCESS | 9951 | Values: 125.0 132.0 126.0 119.0 120.0 118.0 123.0 121.0 159.0 130.0 13:20:48 INFO - PROCESS | 9951 | 13:20:48 INFO - PROCESS | 9951 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.60 Median:161.50 stddev:2.01 (1.2%) stddev-sans-first:2.05 13:20:48 INFO - PROCESS | 9951 | Values: 160.0 163.0 166.0 163.0 162.0 159.0 161.0 160.0 161.0 161.0 13:20:48 INFO - PROCESS | 9951 | 13:20:48 INFO - PROCESS | 9951 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:63.50 stddev:3.84 (6.1%) stddev-sans-first:1.73 13:20:48 INFO - PROCESS | 9951 | Values: 75.0 64.0 63.0 63.0 63.0 67.0 63.0 63.0 67.0 63.0 13:20:48 INFO - PROCESS | 9951 | -------- Summary: end -------- 13:20:48 INFO - PROCESS | 9951 | 13:20:50 INFO - TEST-INFO | 9951: exit 0 13:20:50 INFO - TEST-OK | kraken | took 61764ms 13:20:50 INFO - SUITE-END | took 1177s 13:20:50 INFO - Completed test suite (00:19:38) 13:20:50 INFO - javascript benchmark 13:20:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2891.624088868447, 2905.6658484274317, 2922.9415411691766, 2950.6459224893015, 2954.8079374840636, 5574.721263936807, 5655.208270842086, 5666.631668941521, 5677.574181936356, 5744.712764361776, 5619.971900140504, 5665.093585026386, 5710.14347847822, 5742.39704830993, 5759.856003599912, 4805.831795887145, 5004.424491183506, 5037.319961805155, 5139.280500729901, 5152.355955505562, 5126.92309615356, 5173.586113110942, 5174.586033117342, 5183.455737147602, 5248.134057880445, 5025.0, 5208.973955130238, 5216.087184742655, 5241.554467870235, 5330.38700549436, 5022.397312322508, 5054.721990290533, 5090.032893750175, 5090.261912022773, 5093.745312734385, 5031.195008798574, 5044.117279476113, 5049.166887463564, 5139.126348520723, 5192.92210616841, 5707.600467967244, 5729.512991395736, 5737.627054241461, 5742.856428589277, 5755.194272801811, 5915.645061296336, 5976.701164941735, 5992.2809262888295, 6035.879282414371, 6074.696265186767, 6117.0, 6123.969380153116, 6142.232220972379, 6148.292946311187, 6155.907661385083, 5683.0, 5688.345840228385, 5690.9146362804595, 5692.0, 5700.37295897451, 5996.370381110008, 6042.667653279112, 6052.425019623129, 6083.726232319556, 6093.671727366957, 5856.033754430471, 5861.325947516005, 5882.735276912549, 5888.411158884163, 5963.016102343065, 6145.586515101551, 6155.938440615626, 6160.753569857246, 6163.722632481549, 6165.722542485599, 6099.756009759649, 6133.26400831903, 6152.969235153795, 6160.507159427235, 6162.907556386658, 5903.144044113579, 5968.791092311748, 6155.599886007395, 6175.876482470326, 6192.380761923861, 4620.19146649335, 4652.302154676758, 4654.2785868190485, 4678.60231880294, 4735.076660051257, 4056.1887622475033, 4083.0200751819943, 4085.428040074392, 4115.814788334532, 4128.814203360856, 5622.550195984311, 5770.567207459458, 5844.327902291291, 5846.123081537803, 5849.61977471463, 5932.495737862244, 6055.515558755289, 6070.696465176724, 6072.392760723892, 6076.118962750376, 5701.629394089371, 5723.227364305765, 5751.769929202868, 5758.510526605285, 5769.624974376652, 5196.168613021899, 5249.42256351801, 5260.658057226268, 5323.920141197885, 5336.17289320156, 6393.488520918316, 6416.7433302668305, 6428.5178611604315, 6447.323031081763, 6449.097126402307, 6143.6006659568775, 6157.846053848511, 6163.691815409122, 6163.876722465436, 6165.229346331708, 6106.551676171979, 6118.5411094169, 6228.626282423069, 6271.843203919756, 6328.177336946167, 5999.700014999145, 6001.879962400815, 6065.878682426415, 6075.058365953284, 6077.24034495688, 6097.512199023979, 6107.206063211754, 6110.419510146529, 6125.234345706786, 6136.754529818757, 5807.070868660994, 5861.912071318849, 5977.551683623833, 5978.970105149447, 5986.88026239464, 5899.764009439575, 5927.347991720821, 5937.317208520903, 5994.3705910878725, 6073.392660734068, 5903.085021821625, 5944.108383742473, 5947.078202878561, 5955.0, 5955.315138759098, 5819.621724587888, 5917.822465326047, 5969.940300596939, 5981.491573216152, 5983.252093488314, 5741.368449470639, 5803.506701930383, 5854.619449735754, 5879.764809407576, 5935.139404786196], "value": 5580.059372765765, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.8654809393839, 604.5828378418892, 619.1332135010987, 628.8365025093477, 644.2687549631167, 35976.64023359769, 36838.0, 36853.99999999996, 43337.0, 44547.55452445475, 46514.30228546566, 46823.76588117055, 46900.76549617247, 46944.530554694444, 47002.76498617502, 8862.202401783838, 9003.414778039407, 9011.729648110535, 9013.05362936892, 9019.639214431447, 8042.276195142436, 8240.752777416657, 10333.58665653373, 10512.894871051269, 10558.260921735482, 10679.572817087308, 10768.623098191565, 10784.0, 10790.136789056856, 10799.676009719682, 10582.894171058306, 10595.311304765166, 10650.094741946943, 10660.253782235208, 10665.733356666067, 10394.376337419779, 10523.78952420955, 10535.525901334458, 10535.947320263427, 10539.209559283085, 42714.78642606798, 43126.78436607828, 43130.76519261068, 43148.568514315084, 43175.56824431747, 3660.2496488220117, 3668.853245870162, 3732.5520937487404, 3734.804862444019, 3802.5817160112365, 32224.838875805704, 32355.6764432355, 32584.674153258402, 34314.0, 34733.0, 4473.194824931511, 4536.160810250114, 4589.862304130881, 4611.193041217807, 4798.5201479852085, 317957.0, 319283.0, 320234.0, 320477.39761301276, 320700.9999999977, 53524.732376338645, 53683.463165367844, 53696.463035369925, 53730.0, 53797.0, 38917.22165556673, 39936.400953985714, 40354.394684079765, 42668.359974600404, 66930.9960350595, 17353.479395618153, 17611.207495662726, 17634.735478967825, 17641.7353739694, 17665.7350139748, 12203.389830508439, 13463.932680336535, 13729.244891531062, 13736.793948090786, 13751.793723094162, 17446.0, 19612.11745471457, 20602.27892023772, 20647.077055359434, 20686.17255309771, 7348.63256837156, 7371.557706537517, 7490.962545187348, 7550.0, 7610.1628820829665, 871.9476831390136, 941.4727752458645, 990.4750482244422, 1094.3871431998107, 1130.5421304371744, 33095.834520827724, 33396.18522120545, 33521.497177542355, 33537.16157096043, 33993.0, 1034.1984961654628, 1072.3512275073467, 1090.7164137324353, 1136.5624234669713, 1153.6250718516517, 16978.23597938071, 17594.0, 17621.471355859343, 17688.646227075387, 17699.82300176982, 577313.0, 579885.0, 583239.0, 583889.0, 589811.0, 59456.405435945955, 59786.0, 59862.10206846901, 59957.0, 60046.39953600495, 1272.5864094169247, 1286.6075846866609, 1306.7582497238232, 1361.0, 1364.092878235962, 28945.42109157847, 33404.33191336208, 33740.084203401275, 33951.66048339485, 34206.65793342035, 51790.0, 52406.47593524016, 52418.213726793365, 52449.21326180034, 52476.73761631167, 300259.0, 300807.0, 301251.0, 301432.0, 302158.0, 29558.408831822813, 30403.847980759954, 30614.234644134074, 30986.211240988418, 32673.18317041998, 46099.76950115228, 48580.75709621429, 48976.51023489719, 49748.0, 50978.0, 39835.87841442163, 42447.78776106223, 42743.572564273956, 43230.13539729125, 43377.56622433735, 40901.38647920343, 43465.13069738651, 44292.33561496645, 46765.53234467748, 47013.76493117512, 42307.7884610575, 42678.35982460328, 42817.78591107149, 42931.35602966021, 44138.11723765571, 35225.82387088048, 38141.427878581286, 38438.423423648106, 39065.0, 39202.6079739199, 28357.291067723472, 28762.280942976595, 28962.710372896003, 29109.70890291155, 29170.270743231587], "value": 20485.920610937985, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.8549108593191, 422.7642276422764, 433.32185130271125, 433.4776594203984, 438.12812503118784, 14745.48390806322, 19438.319658811943, 19440.708389374136, 20120.396388108344, 20147.496312592157, 19028.429147125607, 19069.80930190698, 19075.61848763024, 19232.71150932737, 19387.806121938775, 5479.3972663007235, 5537.446255374471, 5749.568782341341, 5777.277840269966, 5781.884362312751, 5769.567282453832, 5791.420857914196, 5796.304443466769, 5800.245968024151, 5804.59367844251, 5783.913241301384, 5795.739191736361, 6068.544859135561, 6234.563580549363, 6314.557980941313, 6167.105769663419, 6342.556021078526, 6375.362463753588, 6377.234731832186, 6388.680565971683, 5631.71841407928, 5695.515881150066, 5702.401247868997, 5703.17303990919, 5708.457696518824, 14190.290485475685, 14466.566003019927, 22441.55116897653, 23585.0, 23766.64350034751, 2288.439332363582, 2338.5790557699606, 2339.894704738291, 2456.803455723538, 2936.0017594017922, 9787.608495660237, 10163.695089147264, 10296.124829389511, 10638.521266542946, 10876.836847447295, 1931.4302280827048, 1969.7931717169777, 2005.8796472211568, 2011.9497012574657, 2060.8454365922616, 79926.60036699838, 86673.99999999937, 87217.56391218003, 87227.56386218028, 90235.54882225547, 11244.49399777012, 11455.942720286512, 11533.250338728123, 11580.305181689126, 11851.348175850238, 16540.105481540922, 16547.83452165463, 16554.42059527935, 16571.337146514245, 16578.0, 8289.917100829036, 8397.790055248668, 8555.657773689107, 8646.697365592174, 8767.824643507094, 7802.414818888493, 7809.180036096242, 8044.678212871537, 8086.7169649062, 8269.503829770232, 4730.455997560256, 4790.520947905182, 4860.416749990024, 4899.706017638953, 5065.240213967934, 1976.723258743777, 1986.8409229325441, 2061.1655626492434, 2103.347962131744, 2110.2614085070104, 863.6977058029639, 1003.2575893838507, 1027.429776474064, 1030.6547306652205, 1035.5443604813859, 19736.0, 19776.901115494617, 19869.205231790856, 19909.0, 19986.400407987785, 958.1281034258791, 973.8636590877283, 977.2670497127154, 987.5852142100335, 1012.5190534496055, 10360.533775980099, 10927.289726167774, 10947.56209751617, 10989.670309890716, 10999.34003959765, 446785.0, 448678.0, 450263.0, 454132.0, 455527.0, 94286.5285673581, 94435.52782236045, 95327.0, 96588.0, 102134.0, 997.3915911294105, 1019.5666841592442, 1046.2885238038054, 1051.9000694933968, 1058.2010582010532, 16544.50366489007, 17098.658026839144, 17447.214875330388, 17811.287548498432, 18299.634007320044, 43124.35313470363, 43483.56516434922, 43798.56201437945, 43876.34185487156, 45567.31649025201, 57401.42598573961, 58188.4181158183, 58616.0, 60334.39665603288, 62063.37936620576, 7960.721374751856, 8265.917340826756, 8279.172082791672, 8284.627191776504, 8524.531150786766, 9079.046700096394, 11617.825732613848, 12219.69450763738, 12385.752284954431, 12429.378531073591, 10584.259101862795, 10795.0, 11006.174536909924, 11186.496607652512, 11385.544578216779, 10492.895071049497, 10769.246152769545, 10790.514426850968, 10913.727156821144, 11015.173861960226, 10836.078933290759, 10999.835002474809, 11198.21612487118, 11209.495572699085, 11534.480948357512, 8079.83840323202, 8181.140980196994, 8246.711365102192, 8292.419530633038, 8717.607707653298, 10702.571897124028, 11027.0, 11083.501242443948, 11127.499262533043, 11224.94387528057], "value": 9252.38300333834, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1338.4092562510584, 1502.6919481506288, 1541.57606658169, 1678.622309980254, 1826.9086545672722, 7998.320142787863, 8839.823203535925, 9249.260059195265, 9254.167124958753, 9634.0, 9389.295802814799, 9422.293328000393, 9446.149846513812, 9468.479233642147, 9490.383125096863, 2483.354327874752, 2500.4874000829877, 2500.862452565108, 2506.736792636774, 2514.5976643737004, 2398.136670798511, 2485.689288838895, 2487.6641653376832, 2489.2781093482868, 2495.089292408276, 2483.205374280222, 2494.1270555305678, 2507.72415034347, 2510.686164229471, 2512.932003898336, 2411.1078900806638, 2436.0864675746593, 2439.743826898177, 2471.270975062361, 2474.134053081425, 2401.087586717054, 2409.3374322061572, 2418.3349578865777, 2424.175780234729, 2471.369800700828, 9272.490013049279, 9279.072092790735, 9287.164155225995, 9306.581203845775, 9394.34239603228, 5440.646357986758, 5629.3526244482, 5641.097424412074, 5642.689652069134, 5756.366799652035, 3551.7691350062164, 3571.089372210096, 3631.7457777955556, 3661.9450708239397, 3736.0846592584717, 1154.2958795135046, 1157.1090260499368, 1172.0, 1174.448009435564, 1184.2953442701578, 12839.807402888964, 13099.279539625317, 13117.409716562683, 13138.605841824761, 13140.6714832129, 4757.35775670287, 4862.927056094161, 4877.219644856806, 4931.852044438672, 4966.180580204298, 10920.50857711405, 10956.616518421817, 10958.452077396098, 10964.451777411097, 10987.39569323695, 5623.044082505902, 5625.943740562542, 5634.60557760961, 5638.097904335286, 5638.223959452759, 4370.082282720664, 4471.463424389029, 4514.6614003949835, 4627.120847039052, 5138.511841375063, 4126.133511962462, 4146.1914926589025, 4331.047169622678, 4348.456442944632, 4353.73877567347, 1382.6336020954454, 1439.9568012959628, 1448.739226939161, 1450.7461194290956, 1460.773580095087, 846.204567706354, 868.1969178509853, 891.4294851295176, 943.254828685331, 956.8277710012126, 5771.624844385102, 5792.739326730307, 5835.416458354131, 5979.760809567569, 6036.758529658852, 438.19591050422196, 466.2912373192728, 468.0148287854086, 472.5380766208026, 478.4760687047677, 4030.8790736277374, 4145.564715704808, 4149.149424367997, 4157.812898419578, 4161.83352665896, 11449.828252576219, 11493.71265718347, 11531.769364612828, 11555.653330400102, 11598.536058557733, 10809.83785243222, 11341.659750207507, 11354.886451135548, 11372.601958931398, 11382.146339024606, 8305.792355191168, 8734.388592798443, 8734.606942687595, 8742.475451472932, 8744.606492707844, 5666.603337766317, 5676.631018983753, 5708.0, 5779.739911703899, 5903.675297858659, 10668.83996740034, 10760.784784304427, 10771.89228107709, 10787.137029037502, 10798.460076995962, 9555.0, 10043.397396156253, 10407.323523970917, 10584.259101862795, 10714.839277410689, 7835.647395867086, 8199.754007379788, 8256.463329883538, 8275.50346979183, 8279.509688256172, 8781.91218087811, 8795.340349473687, 8847.247983921181, 8867.73396798097, 8873.955630222066, 8012.559309238048, 8190.672373105009, 8213.876791848246, 8217.383696222687, 8425.662973480992, 7792.61036948139, 7842.490238134503, 7855.33229675484, 7949.682012719427, 7983.1617680142745, 7327.560346379234, 7469.887951680837, 7500.1374841893885, 7503.624818759149, 7507.324340809353, 5141.691498509952, 5153.175491921274, 5187.662801917863, 5217.634765566526, 5567.4432556744005, 5200.869978250574, 5252.1596544552685, 5265.315508983961, 5269.288646032736, 5453.454654534515], "value": 4740.711698848076, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.3955317747119, 351.09242607858687, 361.759429979064, 368.7345111519705, 369.89827797355724, 5387.380451248107, 5588.273524441817, 5591.440855914407, 5645.5483561315095, 5685.687287199203, 5369.275147855038, 5457.836264912049, 5482.876010417865, 5495.203195536645, 5518.33779946406, 4353.172897149548, 4362.607365337127, 4365.432493775805, 4374.4313239278845, 4414.955850441486, 4118.455579157816, 4308.246056940038, 4387.583179597933, 4388.407564978735, 4406.1187762447635, 4288.9571104289025, 4297.59172878576, 4299.914541447395, 4308.159908817782, 4309.590588894066, 4320.330348795942, 4332.328489084197, 4332.591907630032, 4333.891652708692, 4364.192624364471, 3746.6253374662588, 3781.773093614392, 3866.6326698963553, 3867.3425517662067, 3875.670568001723, 5355.571554275649, 5360.624756267063, 5376.569874410038, 5379.354477462691, 5423.864403389907, 4924.729139897304, 4930.975345123287, 4942.802287908479, 4943.530364615356, 4984.576311013569, 5487.780488780444, 5756.971215143939, 5779.9422005779825, 5784.421557844224, 5787.768489260467, 4179.623833854967, 4190.601892820177, 4198.685098617585, 4210.894727631803, 4220.662347012231, 6017.458428741391, 6028.216331876828, 6045.72794224261, 6050.8184754457, 6083.2395950506625, 4232.386303985905, 4288.120935208337, 4318.30907054876, 4339.848105316299, 4342.934855977162, 4343.609075183249, 4348.586884245991, 4356.760378179167, 4359.17175736609, 4362.6946113772365, 4935.457099719028, 4963.6525443218625, 4964.280179373971, 4996.850094497171, 4999.400071991312, 5673.723412232297, 5814.186013958049, 5826.329972053183, 5826.504747096459, 5834.27071616048, 1483.1397789282191, 1496.2817847433294, 1499.130504307499, 1499.567912643423, 1500.7543738696857, 927.657230653282, 961.423146112327, 975.2588033094898, 976.9316147869723, 977.4379731654327, 4992.929348450749, 5019.222020586742, 5041.773120209599, 5043.36957880265, 5078.415982162025, 5277.472252774692, 5281.642644817964, 5295.258663787073, 5306.814261500829, 5325.9733701332025, 4760.048380164185, 4856.587190088811, 4956.801727930914, 5061.114304996685, 5096.821611243588, 2760.2748282323546, 2785.2340606333014, 2787.7351651593067, 2795.5527115661803, 2818.788590855694, 5463.0, 5468.91796623051, 5525.364583072998, 5533.723313834373, 5561.221428999943, 4947.332110165154, 5285.418603953562, 5290.338707661543, 5292.470752924677, 5322.456487618547, 5421.566274697936, 5432.348118225759, 5440.510354068153, 5456.809011684572, 5457.590680698963, 5212.166053431584, 5212.348456442945, 5226.71253081069, 5242.292290540729, 5293.153095504701, 5615.950178185015, 5920.940790592039, 5947.899638566879, 5949.226600542075, 5994.580379373402, 6294.685265736786, 6317.652529110943, 6319.24169099711, 6329.778457753957, 6362.300146983735, 4034.9798251009734, 4157.230912281238, 4173.937390939078, 4282.657387409062, 4299.269124248823, 5893.381194974466, 5904.439078287556, 5921.134842524591, 5927.436893495111, 5935.2877654681715, 5678.6876721779045, 5709.143628455765, 5777.826665200051, 5819.447152520504, 5847.707614619167, 5742.36833948257, 5750.971245143747, 5756.079027355603, 5769.2403816834585, 5790.2206940667875, 5743.712814359349, 5743.913841292468, 5761.711914404179, 5771.769129234784, 5800.767969281182, 5685.260916080883, 5808.651480911159, 5817.621854579439, 5836.795712150054, 5866.882662346815, 5584.888302233851, 5589.636673616202, 5631.239782629293, 5682.0, 5693.345265294544], "value": 4324.008074424558, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [778.4161878591058, 820.9876851847223, 876.3514998900812, 878.9736307910765, 887.8801361816157, 14609.0, 16008.599785005366, 16014.83985160148, 16064.598385040365, 17255.568610784736, 16062.919685401586, 16132.112733799637, 16145.354185832553, 16178.433754818583, 16290.83709162908, 821.2485575698229, 844.5186243841013, 845.9577021148918, 848.1518481518482, 848.6944699908029, 723.4321057969495, 741.5068979128899, 834.7913021744564, 855.0978717453085, 856.2892798976834, 895.5432729308067, 899.0964081098487, 899.9100089990982, 899.9325050621197, 902.0933961368816, 893.7586851550078, 894.5124906925709, 900.0549423105779, 900.9639614415415, 901.6078006067381, 390.7635880292411, 394.9585293544165, 644.8387903024244, 660.4122331125302, 669.364104101101, 15680.529584112495, 15744.291506882104, 15749.685006299924, 15758.76361854573, 15804.683906321925, 13935.233562154179, 14221.502247421395, 14519.346629401702, 14586.708265834624, 14655.560333189915, 12754.744905101847, 12757.234565926074, 13051.412686429134, 13091.607251782461, 13284.335783210898, 4395.296752519582, 4427.313766366218, 4429.335599660077, 4477.417935668343, 4485.237509623372, 77998.0, 78026.0, 78037.0, 78269.60865195695, 78546.0, 12279.447424865903, 12301.56944506956, 12339.197952133083, 12490.25058496475, 12502.249865008129, 23946.52106957851, 23987.520249595258, 24018.639720404208, 24080.0, 24112.87943560306, 9317.534123293808, 9408.764780880532, 9584.808303834025, 9618.663346782969, 9649.758756031155, 4982.078315511642, 4989.351384320015, 5036.823711170092, 5050.671706339076, 5200.843974680765, 3805.9429108563395, 3897.8051097445014, 3934.567197608261, 3935.2916475034194, 3935.5277366716177, 646.9842347514451, 652.1326635574675, 660.920689517261, 668.6589839182052, 691.7578847403469, 663.5952069237761, 674.1707699529607, 675.5237557521936, 707.2573797512591, 713.12642013533, 9220.950813950616, 9326.160645541933, 9405.623775049058, 9443.338966272433, 9505.287103467268, 563.9097744360964, 611.9357467465852, 628.7422156915734, 657.8585604095142, 681.2370145437142, 4235.1317979814685, 4526.23054080807, 4532.478764942008, 4537.478190008125, 4613.907721845544, 101185.49407252917, 118422.40788796001, 119784.0, 123032.38483807523, 123049.0, 101822.0, 105496.0, 106844.0, 108459.45770271098, 112031.43984280189, 89420.0, 91868.54065729628, 92045.0, 92783.0, 93811.0, 8647.178518040777, 8752.78118047054, 8943.955280223558, 9054.139856713602, 9106.575421610074, 55301.170482441994, 55762.442375577346, 55829.44170558242, 56104.43895561156, 56570.717146414005, 74345.6282718583, 78950.0, 80051.19180931023, 81323.0, 81647.59176204081, 11349.659510214376, 11364.659060228207, 11583.478743456733, 11600.477978490819, 12006.159568830099, 11431.0, 11511.942440287745, 12011.399430028288, 12393.132480726263, 12842.460652400354, 10872.07587355052, 11275.32348059119, 11299.71750706206, 11462.369569673414, 11890.940545297219, 11647.242929209575, 11745.29528228309, 11783.351915644722, 11784.057275418118, 11791.469383877575, 11739.11956603241, 11755.294682319089, 11916.880831191924, 12063.75872482563, 12170.513179472722, 9426.151646351862, 9560.904390956, 9620.903790962, 9636.614535418505, 9874.851877221703, 9358.29812764059, 10075.294729369167, 10180.541875615763, 10208.540615672164, 10214.591416343263], "value": 7570.916653247854, "unit": "score"}], "name": "dromaeo_css", "value": 7399.657283544334, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 110.0, 110.0, 110.0, 111.0, 111.0, 110.0, 109.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 116.0, 115.0, 160.0, 117.0, 123.0, 116.0, 115.0, 144.0, 119.0], "value": 127.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 161.0, 162.0, 162.0, 161.0, 163.0, 164.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 111.0, 76.0, 77.0, 76.0, 76.0, 105.0, 75.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 109.0, 83.0, 84.0, 83.0, 110.0, 83.0, 81.0, 108.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 51.0, 49.0, 51.0, 51.0, 52.0, 51.0, 50.0, 54.0, 51.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 60.0, 60.0, 60.0, 59.0, 60.0, 60.0, 59.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 78.0, 76.0, 77.0, 85.0, 86.0, 77.0, 77.0, 78.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 132.0, 126.0, 119.0, 120.0, 118.0, 123.0, 121.0, 159.0, 130.0], "value": 127.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 166.0, 163.0, 162.0, 159.0, 161.0, 160.0, 161.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 64.0, 63.0, 63.0, 63.0, 67.0, 63.0, 63.0, 67.0, 63.0], "value": 65.1, "unit": "score"}], "name": "kraken", "value": 1474.2999999999997, "alertThreshold": 2.0}]} 13:20:50 INFO - Return code: 0 13:20:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:20:50 INFO - # TBPL SUCCESS # 13:20:50 INFO - Running post-action listener: _resource_record_post_action 13:20:50 INFO - [mozharness: 2016-09-26 20:20:50.715506Z] Finished run-tests step (success) 13:20:50 INFO - Running post-run listener: _resource_record_post_run 13:20:50 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 353845248; Read time: 12; Write time: 248448 13:20:50 INFO - TinderboxPrint: CPU usage
13.1% 13:20:50 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 13:20:50 INFO - TinderboxPrint: I/O write bytes / time
353,845,248 / 248,448 13:20:50 INFO - TinderboxPrint: CPU idle
8,271.4 (86.9%) 13:20:50 INFO - TinderboxPrint: CPU user
1,197.1 (12.6%) 13:20:50 INFO - TinderboxPrint: Swap in / out
0 / 0 13:20:50 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 96022528; Read time: 0; Write time: 75364 13:20:50 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 257822720; Read time: 0; Write time: 173084 13:20:51 INFO - Running post-run listener: _upload_blobber_files 13:20:51 INFO - Blob upload gear active. 13:20:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:20:51 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:20:51 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', 'Date', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:20:51 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 Date -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:20:51 INFO - (blobuploader) - INFO - Open directory for files ... 13:20:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:20:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:20:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:20:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:20:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:20:52 INFO - (blobuploader) - INFO - Done attempting. 13:20:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:20:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:20:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:20:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:20:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:20:56 INFO - (blobuploader) - INFO - Done attempting. 13:20:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:20:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:20:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:20:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:20:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:20:57 INFO - (blobuploader) - INFO - Done attempting. 13:20:57 INFO - (blobuploader) - INFO - Iteration through files over. 13:20:57 INFO - Return code: 0 13:20:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:20:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:20:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/9bd6b20c6e0e0e13b92c73a3dfe3b91f7e80d4bbda3dade38d5221a0ec166bdc039fd9b78a0a092ba78e88420b409a30410fb6445639e556714edd5bb2e073cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/a5c006159033c9318f2a31caea0f09406ad731b4409a9505c3d6d53d37aba67abe0fb38bfb69fe6c0fee6bfeb192f124669916630d6577cf84e3934155707463", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/9212c239274625a114f9a24b1bea1f3fa05e8d8c3e5c3115c4f0e8f26c595b0a0d3a2de9c8482d347ee8f093a33d18bd1555905705459e6b44d4a538d9e07019"} 13:20:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:20:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:20:57 INFO - Contents: 13:20:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/9bd6b20c6e0e0e13b92c73a3dfe3b91f7e80d4bbda3dade38d5221a0ec166bdc039fd9b78a0a092ba78e88420b409a30410fb6445639e556714edd5bb2e073cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/a5c006159033c9318f2a31caea0f09406ad731b4409a9505c3d6d53d37aba67abe0fb38bfb69fe6c0fee6bfeb192f124669916630d6577cf84e3934155707463", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/9212c239274625a114f9a24b1bea1f3fa05e8d8c3e5c3115c4f0e8f26c595b0a0d3a2de9c8482d347ee8f093a33d18bd1555905705459e6b44d4a538d9e07019"} 13:20:57 INFO - Running post-run listener: copy_logs_to_upload_dir 13:20:57 INFO - Copying logs to upload dir... 13:20:57 INFO - mkdir: /builds/slave/test/build/upload/logs 13:20:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.510805 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-09-26 13:20:57.072645) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 13:20:57.076262) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1474919847.180215-1454381279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/9bd6b20c6e0e0e13b92c73a3dfe3b91f7e80d4bbda3dade38d5221a0ec166bdc039fd9b78a0a092ba78e88420b409a30410fb6445639e556714edd5bb2e073cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/a5c006159033c9318f2a31caea0f09406ad731b4409a9505c3d6d53d37aba67abe0fb38bfb69fe6c0fee6bfeb192f124669916630d6577cf84e3934155707463", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/9212c239274625a114f9a24b1bea1f3fa05e8d8c3e5c3115c4f0e8f26c595b0a0d3a2de9c8482d347ee8f093a33d18bd1555905705459e6b44d4a538d9e07019"} build_url:https://queue.taskcluster.net/v1/task/BqSTVOBRRryDw_b8Ip7pDg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011215 build_url: 'https://queue.taskcluster.net/v1/task/BqSTVOBRRryDw_b8Ip7pDg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/9bd6b20c6e0e0e13b92c73a3dfe3b91f7e80d4bbda3dade38d5221a0ec166bdc039fd9b78a0a092ba78e88420b409a30410fb6445639e556714edd5bb2e073cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/a5c006159033c9318f2a31caea0f09406ad731b4409a9505c3d6d53d37aba67abe0fb38bfb69fe6c0fee6bfeb192f124669916630d6577cf84e3934155707463", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/9212c239274625a114f9a24b1bea1f3fa05e8d8c3e5c3115c4f0e8f26c595b0a0d3a2de9c8482d347ee8f093a33d18bd1555905705459e6b44d4a538d9e07019"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 13:20:57.101850) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 13:20:57.102196) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1474919847.180215-1454381279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 13:20:57.185518) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 13:20:57.185879) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 13:20:57.186208) ========= ========= Total master_lag: 0.17 =========