builder: date_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-052 starttime: 1474920007.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:07.975878) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 13:00:07.976921) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 13:00:07.977201) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 13:00:08.006237) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 13:00:08.006504) ========= 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=826874ccc97bd7bf541b4875000001d5-1474915074.520715-556995881 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-26 13:00:09-- 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% 45.8M=0s 2016-09-26 13:00:09 (45.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105381 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 13:00:08.126000) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 13:00:08.126313) ========= 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=826874ccc97bd7bf541b4875000001d5-1474915074.520715-556995881 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023371 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 13:00:08.178902) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-26 13:00:08.179233) ========= 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=826874ccc97bd7bf541b4875000001d5-1474915074.520715-556995881 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-26 13:00:09,892 truncating revision to first 12 chars 2016-09-26 13:00:09,893 Setting DEBUG logging. 2016-09-26 13:00:09,893 attempt 1/10 2016-09-26 13:00:09,893 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:10,714 unpacking tar archive at: date-40ee5ff8fad8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.162895 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-26 13:00:09.355471) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 13:00:09.355855) ========= script_repo_revision: 40ee5ff8fad82e4581e49361beb1d00179521420 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 13:00:09.356235) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 13:00:09.356504) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 13:00:09.364345) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-09-26 13:00:09.364613) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=826874ccc97bd7bf541b4875000001d5-1474915074.520715-556995881 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:00:11 INFO - MultiFileLogger online at 20160926 13:00:11 in /builds/slave/test 13:00:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Date --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Date 13:00:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:00:11 INFO - {'append_to_log': False, 13:00:11 INFO - 'base_work_dir': '/builds/slave/test', 13:00:11 INFO - 'blob_upload_branch': 'Date', 13:00:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:00:11 INFO - 'branch': 'Date', 13:00:11 INFO - 'buildbot_json_path': 'buildprops.json', 13:00:11 INFO - 'config_files': ('talos/linux_config.py',), 13:00:11 INFO - 'default_actions': ('clobber', 13:00:11 INFO - 'read-buildbot-config', 13:00:11 INFO - 'download-and-extract', 13:00:11 INFO - 'populate-webroot', 13:00:11 INFO - 'create-virtualenv', 13:00:11 INFO - 'install', 13:00:11 INFO - 'run-tests'), 13:00:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:00:11 INFO - 'download_minidump_stackwalk': True, 13:00:11 INFO - 'download_symbols': 'ondemand', 13:00:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:00:11 INFO - 'tooltool.py': '/tools/tooltool.py', 13:00:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:00:11 INFO - '/tools/misc-python/virtualenv.py')}, 13:00:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:00:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:00:11 INFO - 'installer_path': 'installer.exe', 13:00:11 INFO - 'log_level': 'info', 13:00:11 INFO - 'log_name': 'talos', 13:00:11 INFO - 'log_to_console': True, 13:00:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:00:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:00:11 INFO - 'opt_config_files': (), 13:00:11 INFO - 'pip_index': False, 13:00:11 INFO - 'sps_profile': False, 13:00:11 INFO - 'sps_profile_interval': 0, 13:00:11 INFO - 'suite': 'dromaeojs-e10s', 13:00:11 INFO - 'system_bits': '32', 13:00:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:00:11 INFO - 'title': 'talos-linux64-ix-052', 13:00:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:00:11 INFO - 'use_talos_json': True, 13:00:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:00:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:00:11 INFO - 'work_dir': 'build'} 13:00:11 INFO - [mozharness: 2016-09-26 20:00:11.171024Z] Running clobber step. 13:00:11 INFO - Running pre-action listener: _resource_record_pre_action 13:00:11 INFO - Running main action method: clobber 13:00:11 INFO - rmtree: /builds/slave/test/build 13:00:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:00:11 INFO - Running post-action listener: _resource_record_post_action 13:00:11 INFO - [mozharness: 2016-09-26 20:00:11.628056Z] Finished clobber step (success) 13:00:11 INFO - [mozharness: 2016-09-26 20:00:11.628158Z] Running read-buildbot-config step. 13:00:11 INFO - Running pre-action listener: _resource_record_pre_action 13:00:11 INFO - Running main action method: read_buildbot_config 13:00:11 INFO - Using buildbot properties: 13:00:11 INFO - { 13:00:11 INFO - "project": "", 13:00:11 INFO - "product": "firefox", 13:00:11 INFO - "script_repo_revision": "production", 13:00:11 INFO - "builddir": "date_ubuntu64_hw_test-dromaeojs-e10s", 13:00:11 INFO - "repository": "", 13:00:11 INFO - "buildername": "Ubuntu HW 12.04 x64 date talos dromaeojs-e10s", 13:00:11 INFO - "buildid": "20160926094650", 13:00:11 INFO - "pgo_build": "False", 13:00:11 INFO - "basedir": "/builds/slave/test", 13:00:11 INFO - "buildnumber": 1, 13:00:11 INFO - "slavename": "talos-linux64-ix-052", 13:00:11 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:00:11 INFO - "platform": "ubuntu64_hw", 13:00:11 INFO - "scheduler": "tests-date-linux64-talos", 13:00:11 INFO - "branch": "date", 13:00:11 INFO - "repo_path": "projects/date", 13:00:11 INFO - "revision": "40ee5ff8fad82e4581e49361beb1d00179521420", 13:00:11 INFO - "stage_platform": "linux64", 13:00:11 INFO - "builduid": "301d4a31454d4e878d33469099f07efe", 13:00:11 INFO - "slavebuilddir": "test" 13:00:11 INFO - } 13:00:11 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:11 INFO - Running post-action listener: _resource_record_post_action 13:00:11 INFO - [mozharness: 2016-09-26 20:00:11.630582Z] Finished read-buildbot-config step (success) 13:00:11 INFO - [mozharness: 2016-09-26 20:00:11.630670Z] Running download-and-extract step. 13:00:11 INFO - Running pre-action listener: _resource_record_pre_action 13:00:11 INFO - Running main action method: download_and_extract 13:00:11 INFO - mkdir: /builds/slave/test/build/tests 13:00:11 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:11 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:11 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:11 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:12 INFO - Downloaded 1361 bytes. 13:00:12 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:00:12 INFO - Using the following test package requirements: 13:00:12 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:00:12 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:00:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:00:12 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:00:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:00:12 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:00:12 INFO - u'jsshell-linux-x86_64.zip'], 13:00:12 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:00:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:00:12 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:00:12 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:00:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:00:12 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:00:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:00:12 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:00:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:00:12 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:00:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:00:12 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:00:12 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:12 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:12 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:12 INFO - Expected file size: 21940934 13:00:17 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:17 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:17 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:17 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:17 INFO - Expected file size: 21940934 13:00:22 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:22 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:22 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:23 INFO - Expected file size: 14414057 13:00:24 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:24 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:24 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:24 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:25 INFO - Downloaded 52681263 bytes. 13:00:25 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:25 INFO - mkdir: /builds/slave/test/properties 13:00:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:00:25 INFO - Writing to file /builds/slave/test/properties/build_url 13:00:25 INFO - Contents: 13:00:25 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:25 INFO - Running post-action listener: _resource_record_post_action 13:00:25 INFO - Running post-action listener: set_extra_try_arguments 13:00:25 INFO - [mozharness: 2016-09-26 20:00:25.926602Z] Finished download-and-extract step (success) 13:00:25 INFO - [mozharness: 2016-09-26 20:00:25.926828Z] Running populate-webroot step. 13:00:25 INFO - Running pre-action listener: _resource_record_pre_action 13:00:25 INFO - Running main action method: populate_webroot 13:00:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:00:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:00:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:00:25 INFO - '--tppagecycles', 13:00:25 INFO - '7'], 13:00:25 INFO - 'tests': ['tsvgm']}}, 13:00:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:00:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:00:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:00:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:00:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:00:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:00:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:25 INFO - 'talos_options': ['--disable-e10s'], 13:00:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:00:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:00:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:25 INFO - 'talos_options': ['--disable-e10s'], 13:00:25 INFO - 'tests': ['damp', 'tps']}, 13:00:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:25 INFO - 'tests': ['damp', 'tps']}, 13:00:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:00:25 INFO - 'tests': ['dromaeo_dom']}, 13:00:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:00:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:00:25 INFO - 'tests': ['basic_compositor_video']}, 13:00:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:00:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:00:25 INFO - 'tests': ['a11yr', 13:00:25 INFO - 'ts_paint', 13:00:25 INFO - 'tpaint', 13:00:25 INFO - 'sessionrestore', 13:00:25 INFO - 'sessionrestore_no_auto_restore', 13:00:25 INFO - 'tabpaint']}, 13:00:25 INFO - 'other-e10s': {'tests': ['a11yr', 13:00:25 INFO - 'ts_paint', 13:00:25 INFO - 'tpaint', 13:00:25 INFO - 'sessionrestore', 13:00:25 INFO - 'sessionrestore_no_auto_restore', 13:00:25 INFO - 'tabpaint']}, 13:00:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:00:25 INFO - 'ts_paint', 13:00:25 INFO - 'tpaint', 13:00:25 INFO - 'sessionrestore', 13:00:25 INFO - 'sessionrestore_no_auto_restore', 13:00:25 INFO - 'tabpaint']}, 13:00:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:00:25 INFO - 'ts_paint', 13:00:25 INFO - 'tpaint', 13:00:25 INFO - 'sessionrestore', 13:00:25 INFO - 'sessionrestore_no_auto_restore', 13:00:25 INFO - 'tabpaint']}, 13:00:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:00:25 INFO - 'tests': ['a11yr', 13:00:25 INFO - 'ts_paint', 13:00:25 INFO - 'tpaint', 13:00:25 INFO - 'sessionrestore', 13:00:25 INFO - 'sessionrestore_no_auto_restore', 13:00:25 INFO - 'tabpaint']}, 13:00:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:00:25 INFO - 'tests': ['a11yr', 13:00:25 INFO - 'ts_paint', 13:00:25 INFO - 'tpaint', 13:00:25 INFO - 'sessionrestore', 13:00:25 INFO - 'sessionrestore_no_auto_restore', 13:00:25 INFO - 'tabpaint']}, 13:00:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:00:25 INFO - 'tests': ['tsvgx', 13:00:25 INFO - 'tsvgr_opacity', 13:00:25 INFO - 'tart', 13:00:25 INFO - 'tscrollx', 13:00:25 INFO - 'cart']}, 13:00:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:00:25 INFO - 'tsvgr_opacity', 13:00:25 INFO - 'tart', 13:00:25 INFO - 'tscrollx', 13:00:25 INFO - 'cart']}, 13:00:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:25 INFO - 'talos_options': ['--disable-e10s'], 13:00:25 INFO - 'tests': ['tp5o']}, 13:00:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:25 INFO - 'tests': ['tp5o']}, 13:00:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:25 INFO - 'talos_options': ['--disable-e10s', 13:00:25 INFO - '--xperf_path', 13:00:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:00:25 INFO - 'tests': ['tp5n']}, 13:00:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:25 INFO - 'talos_options': ['--xperf_path', 13:00:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:00:25 INFO - 'tests': ['tp5n']}}, 13:00:25 INFO - 'talos.zip': {'path': '', 13:00:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:00:25 INFO - Running post-action listener: _resource_record_post_action 13:00:25 INFO - [mozharness: 2016-09-26 20:00:25.947986Z] Finished populate-webroot step (success) 13:00:25 INFO - [mozharness: 2016-09-26 20:00:25.948081Z] Running create-virtualenv step. 13:00:25 INFO - Running pre-action listener: _resource_record_pre_action 13:00:25 INFO - Running main action method: create_virtualenv 13:00:25 INFO - Creating virtualenv /builds/slave/test/build/venv 13:00:25 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:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:00:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:00:26 INFO - Using real prefix '/usr' 13:00:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:00:26 INFO - Installing distribute.............................................................................................................................................................................................done. 13:00:28 INFO - Installing pip.................done. 13:00:28 INFO - Return code: 0 13:00:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:00:28 INFO - Reading from file tmpfile_stdout 13:00:28 INFO - Output received: 13:00:28 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:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:00:28 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:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:28 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:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:28 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 0x7faa180e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af0930>, '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 0x2af1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af1cc0>, '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': '826874ccc97bd7bf541b4875000001d5-1474915074.520715-556995881', '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:28 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:28 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:28 INFO - Using env: {'DISPLAY': ':0', 13:00:28 INFO - 'HOME': '/home/cltbld', 13:00:28 INFO - 'LANG': 'en_US.UTF-8', 13:00:28 INFO - 'LANGUAGE': 'en_US:en', 13:00:28 INFO - 'LOGNAME': 'cltbld', 13:00:28 INFO - 'MAIL': '/var/mail/cltbld', 13:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:28 INFO - 'MOZ_NO_REMOTE': '1', 13:00:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:28 INFO - 'NO_EM_RESTART': '1', 13:00:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:28 INFO - 'PWD': '/builds/slave/test', 13:00:28 INFO - 'SHELL': '/bin/bash', 13:00:28 INFO - 'SHLVL': '1', 13:00:28 INFO - 'TERM': 'linux', 13:00:28 INFO - 'TMOUT': '86400', 13:00:28 INFO - 'USER': 'cltbld', 13:00:28 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1474915074.520715-556995881', 13:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:28 INFO - '_': '/tools/buildbot/bin/python'} 13:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:28 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:28 INFO - Cleaning up... 13:00:28 INFO - Return code: 0 13:00:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:00:28 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:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:28 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:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:28 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 0x7faa180e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af0930>, '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 0x2af1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af1cc0>, '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': '826874ccc97bd7bf541b4875000001d5-1474915074.520715-556995881', '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:28 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:28 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:28 INFO - Using env: {'DISPLAY': ':0', 13:00:28 INFO - 'HOME': '/home/cltbld', 13:00:28 INFO - 'LANG': 'en_US.UTF-8', 13:00:28 INFO - 'LANGUAGE': 'en_US:en', 13:00:28 INFO - 'LOGNAME': 'cltbld', 13:00:28 INFO - 'MAIL': '/var/mail/cltbld', 13:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:28 INFO - 'MOZ_NO_REMOTE': '1', 13:00:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:28 INFO - 'NO_EM_RESTART': '1', 13:00:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:28 INFO - 'PWD': '/builds/slave/test', 13:00:28 INFO - 'SHELL': '/bin/bash', 13:00:28 INFO - 'SHLVL': '1', 13:00:28 INFO - 'TERM': 'linux', 13:00:28 INFO - 'TMOUT': '86400', 13:00:28 INFO - 'USER': 'cltbld', 13:00:28 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1474915074.520715-556995881', 13:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:28 INFO - '_': '/tools/buildbot/bin/python'} 13:00:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:29 INFO - Downloading/unpacking psutil>=3.1.1 13:00:29 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:29 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:29 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:29 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:29 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:29 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:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:00:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:00:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:00:31 INFO - Installing collected packages: psutil 13:00:31 INFO - Running setup.py install for psutil 13:00:31 INFO - building 'psutil._psutil_linux' extension 13:00:31 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:31 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:31 INFO - building 'psutil._psutil_posix' extension 13:00:31 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:31 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:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:00:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:00:31 INFO - Successfully installed psutil 13:00:31 INFO - Cleaning up... 13:00:31 INFO - Return code: 0 13:00:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:00:31 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:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:31 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:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:31 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 0x7faa180e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af0930>, '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 0x2af1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af1cc0>, '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': '826874ccc97bd7bf541b4875000001d5-1474915074.520715-556995881', '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:31 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:31 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:31 INFO - Using env: {'DISPLAY': ':0', 13:00:31 INFO - 'HOME': '/home/cltbld', 13:00:31 INFO - 'LANG': 'en_US.UTF-8', 13:00:31 INFO - 'LANGUAGE': 'en_US:en', 13:00:31 INFO - 'LOGNAME': 'cltbld', 13:00:31 INFO - 'MAIL': '/var/mail/cltbld', 13:00:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:31 INFO - 'MOZ_NO_REMOTE': '1', 13:00:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:31 INFO - 'NO_EM_RESTART': '1', 13:00:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:31 INFO - 'PWD': '/builds/slave/test', 13:00:31 INFO - 'SHELL': '/bin/bash', 13:00:31 INFO - 'SHLVL': '1', 13:00:31 INFO - 'TERM': 'linux', 13:00:31 INFO - 'TMOUT': '86400', 13:00:31 INFO - 'USER': 'cltbld', 13:00:31 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1474915074.520715-556995881', 13:00:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:31 INFO - '_': '/tools/buildbot/bin/python'} 13:00:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:00:31 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:31 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:31 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:31 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:31 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:31 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:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:00:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:00:33 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:33 INFO - Installing collected packages: mozsystemmonitor 13:00:33 INFO - Running setup.py install for mozsystemmonitor 13:00:33 INFO - Successfully installed mozsystemmonitor 13:00:33 INFO - Cleaning up... 13:00:34 INFO - Return code: 0 13:00:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:00:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:34 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 0x7faa180e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af0930>, '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 0x2af1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af1cc0>, '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': '826874ccc97bd7bf541b4875000001d5-1474915074.520715-556995881', '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:34 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:34 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:34 INFO - Using env: {'DISPLAY': ':0', 13:00:34 INFO - 'HOME': '/home/cltbld', 13:00:34 INFO - 'LANG': 'en_US.UTF-8', 13:00:34 INFO - 'LANGUAGE': 'en_US:en', 13:00:34 INFO - 'LOGNAME': 'cltbld', 13:00:34 INFO - 'MAIL': '/var/mail/cltbld', 13:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:34 INFO - 'MOZ_NO_REMOTE': '1', 13:00:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:34 INFO - 'NO_EM_RESTART': '1', 13:00:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:34 INFO - 'PWD': '/builds/slave/test', 13:00:34 INFO - 'SHELL': '/bin/bash', 13:00:34 INFO - 'SHLVL': '1', 13:00:34 INFO - 'TERM': 'linux', 13:00:34 INFO - 'TMOUT': '86400', 13:00:34 INFO - 'USER': 'cltbld', 13:00:34 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1474915074.520715-556995881', 13:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:34 INFO - '_': '/tools/buildbot/bin/python'} 13:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:34 INFO - Downloading/unpacking jsonschema==2.5.1 13:00:34 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:34 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:34 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:34 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:34 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:34 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:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:00:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:00:36 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:36 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:36 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:36 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:36 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:36 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:36 INFO - Downloading functools32-3.2.3-2.tar.gz 13:00:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:00:36 INFO - warning: no files found matching '*.txt' 13:00:36 INFO - no previously-included directories found matching 'build' 13:00:36 INFO - no previously-included directories found matching 'dist' 13:00:36 INFO - no previously-included directories found matching '.git*' 13:00:36 INFO - Installing collected packages: jsonschema, functools32 13:00:36 INFO - Running setup.py install for functools32 13:00:36 INFO - warning: no files found matching '*.txt' 13:00:36 INFO - no previously-included directories found matching 'build' 13:00:36 INFO - no previously-included directories found matching 'dist' 13:00:36 INFO - no previously-included directories found matching '.git*' 13:00:36 INFO - Successfully installed jsonschema functools32 13:00:36 INFO - Cleaning up... 13:00:36 INFO - Return code: 0 13:00:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:00:36 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:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:36 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:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:36 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 0x7faa180e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af0930>, '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 0x2af1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af1cc0>, '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': '826874ccc97bd7bf541b4875000001d5-1474915074.520715-556995881', '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:36 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:36 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:36 INFO - Using env: {'DISPLAY': ':0', 13:00:36 INFO - 'HOME': '/home/cltbld', 13:00:36 INFO - 'LANG': 'en_US.UTF-8', 13:00:36 INFO - 'LANGUAGE': 'en_US:en', 13:00:36 INFO - 'LOGNAME': 'cltbld', 13:00:36 INFO - 'MAIL': '/var/mail/cltbld', 13:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:36 INFO - 'MOZ_NO_REMOTE': '1', 13:00:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:36 INFO - 'NO_EM_RESTART': '1', 13:00:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:36 INFO - 'PWD': '/builds/slave/test', 13:00:36 INFO - 'SHELL': '/bin/bash', 13:00:36 INFO - 'SHLVL': '1', 13:00:36 INFO - 'TERM': 'linux', 13:00:36 INFO - 'TMOUT': '86400', 13:00:36 INFO - 'USER': 'cltbld', 13:00:36 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1474915074.520715-556995881', 13:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:36 INFO - '_': '/tools/buildbot/bin/python'} 13:00:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:00:36 INFO - Cleaning up... 13:00:37 INFO - Return code: 0 13:00:37 INFO - Installing blobuploader==1.2.4 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', '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 0x7faa180e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af0930>, '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 0x2af1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af1cc0>, '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': '826874ccc97bd7bf541b4875000001d5-1474915074.520715-556995881', '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', 'blobuploader==1.2.4'] 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 blobuploader==1.2.4 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': '826874ccc97bd7bf541b4875000001d5-1474915074.520715-556995881', 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 blobuploader==1.2.4 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 - Downloading blobuploader-1.2.4.tar.gz 13:00:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:00:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:00:39 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:39 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 - 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:39 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:39 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:39 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/requests/setup.py) egg_info for package requests 13:00:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:00:39 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:39 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 - 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:39 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:39 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:39 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 - Downloading docopt-0.6.1.tar.gz 13:00:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:00:39 INFO - Installing collected packages: blobuploader, requests, docopt 13:00:39 INFO - Running setup.py install for blobuploader 13:00:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:00:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:00:39 INFO - Running setup.py install for requests 13:00:40 INFO - Running setup.py install for docopt 13:00:40 INFO - Successfully installed blobuploader requests docopt 13:00:40 INFO - Cleaning up... 13:00:40 INFO - Return code: 0 13:00:40 INFO - Installing None 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', '--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 0x7faa180e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af0930>, '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 0x2af1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af1cc0>, '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': '826874ccc97bd7bf541b4875000001d5-1474915074.520715-556995881', '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', '--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:40 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: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': '826874ccc97bd7bf541b4875000001d5-1474915074.520715-556995881', 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 - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:00:40 INFO - Running setup.py (path:/tmp/pip-zMgemL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:00:40 INFO - Running setup.py (path:/tmp/pip-Tllp_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:00:40 INFO - Running setup.py (path:/tmp/pip-4x3bot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:00:40 INFO - Running setup.py (path:/tmp/pip-_0OmU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:00:40 INFO - Running setup.py (path:/tmp/pip-uathZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:00:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:00:41 INFO - Running setup.py (path:/tmp/pip-iJmos_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:00:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:00:41 INFO - Running setup.py (path:/tmp/pip-Ui5z58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:00:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:00:41 INFO - Running setup.py (path:/tmp/pip-rUt6jW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:00:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:00:41 INFO - Running setup.py (path:/tmp/pip-32eLh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:00:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:00:41 INFO - Running setup.py (path:/tmp/pip-lzNezj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:00:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:00:41 INFO - Running setup.py (path:/tmp/pip-8TK_0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:00:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:00:41 INFO - Running setup.py (path:/tmp/pip-rFuPBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:00:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:00:41 INFO - Running setup.py (path:/tmp/pip-sUJt_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:00:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:00:41 INFO - Running setup.py (path:/tmp/pip-ziFWTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:00:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:00:41 INFO - Running setup.py (path:/tmp/pip-MM5wKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:00:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:00:41 INFO - Running setup.py (path:/tmp/pip-0lRCTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:00:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:00:41 INFO - Running setup.py (path:/tmp/pip-2HqzOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:00:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:00:41 INFO - Running setup.py install for manifestparser 13:00:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:00:42 INFO - Running setup.py install for mozcrash 13:00:42 INFO - Running setup.py install for mozdebug 13:00:42 INFO - Running setup.py install for mozdevice 13:00:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:00:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:00:42 INFO - Running setup.py install for mozfile 13:00:42 INFO - Running setup.py install for mozhttpd 13:00:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:00:42 INFO - Running setup.py install for mozinfo 13:00:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:00:42 INFO - Running setup.py install for mozInstall 13:00:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:00:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:00:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:00:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:00:42 INFO - Running setup.py install for mozleak 13:00:42 INFO - Running setup.py install for mozlog 13:00:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:00:42 INFO - Running setup.py install for moznetwork 13:00:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:00:43 INFO - Running setup.py install for mozprocess 13:00:43 INFO - Running setup.py install for mozprofile 13:00:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:00:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:00:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:00:43 INFO - Running setup.py install for mozrunner 13:00:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:00:43 INFO - Running setup.py install for mozscreenshot 13:00:43 INFO - Running setup.py install for moztest 13:00:43 INFO - Running setup.py install for mozversion 13:00:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:00:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:00:43 INFO - Cleaning up... 13:00:43 INFO - Return code: 0 13:00:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:00:43 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:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:43 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:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:43 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 0x7faa180e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af0930>, '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 0x2af1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af1cc0>, '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': '826874ccc97bd7bf541b4875000001d5-1474915074.520715-556995881', '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:43 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:43 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:43 INFO - Using env: {'DISPLAY': ':0', 13:00:43 INFO - 'HOME': '/home/cltbld', 13:00:43 INFO - 'LANG': 'en_US.UTF-8', 13:00:43 INFO - 'LANGUAGE': 'en_US:en', 13:00:43 INFO - 'LOGNAME': 'cltbld', 13:00:43 INFO - 'MAIL': '/var/mail/cltbld', 13:00:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:43 INFO - 'MOZ_NO_REMOTE': '1', 13:00:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:43 INFO - 'NO_EM_RESTART': '1', 13:00:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:43 INFO - 'PWD': '/builds/slave/test', 13:00:43 INFO - 'SHELL': '/bin/bash', 13:00:43 INFO - 'SHLVL': '1', 13:00:43 INFO - 'TERM': 'linux', 13:00:43 INFO - 'TMOUT': '86400', 13:00:43 INFO - 'USER': 'cltbld', 13:00:43 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1474915074.520715-556995881', 13:00:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:43 INFO - '_': '/tools/buildbot/bin/python'} 13:00:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:00:43 INFO - Running setup.py (path:/tmp/pip-EIMxTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:00:44 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:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:00:44 INFO - Running setup.py (path:/tmp/pip-29dfTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:00:44 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:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:00:44 INFO - Running setup.py (path:/tmp/pip-COcwCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:00:44 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:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:00:44 INFO - Running setup.py (path:/tmp/pip-uj7UmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:00:44 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:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:00:44 INFO - Running setup.py (path:/tmp/pip-wh3WQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:00:44 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:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:00:44 INFO - Running setup.py (path:/tmp/pip-WlWNMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:00:44 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:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:00:44 INFO - Running setup.py (path:/tmp/pip-m_kiBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:00:44 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:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:00:44 INFO - Running setup.py (path:/tmp/pip-mc7tm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:00:44 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:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:00:44 INFO - Running setup.py (path:/tmp/pip-WpdkPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:00:44 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:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:00:44 INFO - Running setup.py (path:/tmp/pip-JX2dCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:00:44 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:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:00:44 INFO - Running setup.py (path:/tmp/pip-CAuBbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:00:44 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:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:00:44 INFO - Running setup.py (path:/tmp/pip-7M3SOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:00:44 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:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:00:44 INFO - Running setup.py (path:/tmp/pip-e3Sx7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:00:44 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:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:00:44 INFO - Running setup.py (path:/tmp/pip-JRzo2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:00:44 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:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:00:44 INFO - Running setup.py (path:/tmp/pip-YhTI3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:00:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:00:45 INFO - Running setup.py (path:/tmp/pip-Kdbcu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:00:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:00:45 INFO - Running setup.py (path:/tmp/pip-Icqiba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:00:45 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:45 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:45 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:45 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:45 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:45 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:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 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 blessings-1.6.tar.gz 13:00:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:00:47 INFO - Installing collected packages: blessings 13:00:47 INFO - Running setup.py install for blessings 13:00:47 INFO - Successfully installed blessings 13:00:47 INFO - Cleaning up... 13:00:47 INFO - Return code: 0 13:00:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:00:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:00:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:00:47 INFO - Reading from file tmpfile_stdout 13:00:47 INFO - Current package versions: 13:00:47 INFO - argparse == 1.2.1 13:00:47 INFO - blessings == 1.6 13:00:47 INFO - blobuploader == 1.2.4 13:00:47 INFO - docopt == 0.6.1 13:00:47 INFO - functools32 == 3.2.3-2 13:00:47 INFO - jsonschema == 2.5.1 13:00:47 INFO - manifestparser == 1.1 13:00:47 INFO - mozInstall == 1.12 13:00:47 INFO - mozcrash == 0.17 13:00:47 INFO - mozdebug == 0.1 13:00:47 INFO - mozdevice == 0.48 13:00:47 INFO - mozfile == 1.2 13:00:47 INFO - mozhttpd == 0.7 13:00:47 INFO - mozinfo == 0.9 13:00:47 INFO - mozleak == 0.1 13:00:47 INFO - mozlog == 3.4 13:00:47 INFO - moznetwork == 0.27 13:00:47 INFO - mozprocess == 0.23 13:00:47 INFO - mozprofile == 0.28 13:00:47 INFO - mozrunner == 6.12 13:00:47 INFO - mozscreenshot == 0.1 13:00:47 INFO - mozsystemmonitor == 0.3 13:00:47 INFO - moztest == 0.7 13:00:47 INFO - mozversion == 1.4 13:00:47 INFO - psutil == 3.1.1 13:00:47 INFO - requests == 1.2.3 13:00:47 INFO - wsgiref == 0.1.2 13:00:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:00:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:47 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 0x7faa180e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af0930>, '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 0x2af1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af1cc0>, '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': '826874ccc97bd7bf541b4875000001d5-1474915074.520715-556995881', '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:47 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:47 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:47 INFO - Using env: {'DISPLAY': ':0', 13:00:47 INFO - 'HOME': '/home/cltbld', 13:00:47 INFO - 'LANG': 'en_US.UTF-8', 13:00:47 INFO - 'LANGUAGE': 'en_US:en', 13:00:47 INFO - 'LOGNAME': 'cltbld', 13:00:47 INFO - 'MAIL': '/var/mail/cltbld', 13:00:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:47 INFO - 'MOZ_NO_REMOTE': '1', 13:00:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:47 INFO - 'NO_EM_RESTART': '1', 13:00:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:47 INFO - 'PWD': '/builds/slave/test', 13:00:47 INFO - 'SHELL': '/bin/bash', 13:00:47 INFO - 'SHLVL': '1', 13:00:47 INFO - 'TERM': 'linux', 13:00:47 INFO - 'TMOUT': '86400', 13:00:47 INFO - 'USER': 'cltbld', 13:00:47 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1474915074.520715-556995881', 13:00:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:47 INFO - '_': '/tools/buildbot/bin/python'} 13:00:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:47 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:47 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:47 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:47 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:47 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:47 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:47 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:47 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:47 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:47 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:47 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:47 INFO - Cleaning up... 13:00:47 INFO - Return code: 0 13:00:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:00:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:47 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 0x7faa180e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af0930>, '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 0x2af1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af1cc0>, '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': '826874ccc97bd7bf541b4875000001d5-1474915074.520715-556995881', '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:47 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:47 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:47 INFO - Using env: {'DISPLAY': ':0', 13:00:47 INFO - 'HOME': '/home/cltbld', 13:00:47 INFO - 'LANG': 'en_US.UTF-8', 13:00:47 INFO - 'LANGUAGE': 'en_US:en', 13:00:47 INFO - 'LOGNAME': 'cltbld', 13:00:47 INFO - 'MAIL': '/var/mail/cltbld', 13:00:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:47 INFO - 'MOZ_NO_REMOTE': '1', 13:00:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:47 INFO - 'NO_EM_RESTART': '1', 13:00:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:47 INFO - 'PWD': '/builds/slave/test', 13:00:47 INFO - 'SHELL': '/bin/bash', 13:00:47 INFO - 'SHLVL': '1', 13:00:47 INFO - 'TERM': 'linux', 13:00:47 INFO - 'TMOUT': '86400', 13:00:47 INFO - 'USER': 'cltbld', 13:00:47 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1474915074.520715-556995881', 13:00:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:47 INFO - '_': '/tools/buildbot/bin/python'} 13:00:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:00:47 INFO - Cleaning up... 13:00:47 INFO - Return code: 0 13:00:47 INFO - Running post-action listener: _resource_record_post_action 13:00:47 INFO - Running post-action listener: _start_resource_monitoring 13:00:47 INFO - Starting resource monitoring. 13:00:47 INFO - [mozharness: 2016-09-26 20:00:47.987710Z] Finished create-virtualenv step (success) 13:00:47 INFO - [mozharness: 2016-09-26 20:00:47.988223Z] Running install step. 13:00:47 INFO - Running pre-action listener: _resource_record_pre_action 13:00:47 INFO - Running main action method: install 13:00:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:00:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:00:48 INFO - Reading from file tmpfile_stdout 13:00:48 INFO - Detecting whether we're running mozinstall >=1.0... 13:00:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:00:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:00:48 INFO - Reading from file tmpfile_stdout 13:00:48 INFO - Output received: 13:00:48 INFO - Usage: mozinstall [options] installer 13:00:48 INFO - Options: 13:00:48 INFO - -h, --help show this help message and exit 13:00:48 INFO - -d DEST, --destination=DEST 13:00:48 INFO - Directory to install application into. [default: 13:00:48 INFO - "/builds/slave/test"] 13:00:48 INFO - --app=APP Application being installed. [default: firefox] 13:00:48 INFO - mkdir: /builds/slave/test/build/application 13:00:48 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:48 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:03 INFO - Reading from file tmpfile_stdout 13:01:03 INFO - Output received: 13:01:03 INFO - /builds/slave/test/build/application/firefox/firefox 13:01:03 INFO - Running post-action listener: _resource_record_post_action 13:01:03 INFO - [mozharness: 2016-09-26 20:01:03.385551Z] Finished install step (success) 13:01:03 INFO - [mozharness: 2016-09-26 20:01:03.385800Z] Running run-tests step. 13:01:03 INFO - Running pre-action listener: _resource_record_pre_action 13:01:03 INFO - Running main action method: run_tests 13:01:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:01:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:01:03 INFO - Python 2.7.3 13:01:03 INFO - Return code: 0 13:01:03 INFO - grabbing minidump binary from tooltool 13:01:03 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:03 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 0x2af0930>, '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 0x2af1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af1cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:01:03 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:03 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:03 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:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:01:03 INFO - Return code: 0 13:01:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:01:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:01:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:01:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:01:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:01:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Date', '--suite', 'dromaeojs-e10s', '--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-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:01:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Date --suite dromaeojs-e10s --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-052 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:01:03 INFO - Using env: {'DISPLAY': ':0', 13:01:03 INFO - 'HOME': '/home/cltbld', 13:01:03 INFO - 'LANG': 'en_US.UTF-8', 13:01:03 INFO - 'LANGUAGE': 'en_US:en', 13:01:03 INFO - 'LOGNAME': 'cltbld', 13:01:03 INFO - 'MAIL': '/var/mail/cltbld', 13:01:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:01:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:03 INFO - 'MOZ_NO_REMOTE': '1', 13:01:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:01:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:01:03 INFO - 'NO_EM_RESTART': '1', 13:01:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:01:03 INFO - 'PWD': '/builds/slave/test', 13:01:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:01:03 INFO - 'SHELL': '/bin/bash', 13:01:03 INFO - 'SHLVL': '1', 13:01:03 INFO - 'TERM': 'linux', 13:01:03 INFO - 'TMOUT': '86400', 13:01:03 INFO - 'USER': 'cltbld', 13:01:03 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1474915074.520715-556995881', 13:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:03 INFO - '_': '/tools/buildbot/bin/python'} 13:01:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Date', '--suite', 'dromaeojs-e10s', '--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-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:01:03 INFO - mozversion application_buildid: 20160926094650 13:01:03 INFO - mozversion application_changeset: 40ee5ff8fad82e4581e49361beb1d00179521420 13:01:03 INFO - mozversion application_display_name: Firefox 13:01:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:01:03 INFO - mozversion application_name: Firefox 13:01:03 INFO - mozversion application_remotingname: firefox 13:01:03 INFO - mozversion application_repository: https://hg.mozilla.org/projects/date 13:01:03 INFO - mozversion application_vendor: Mozilla 13:01:03 INFO - mozversion application_version: 52.0a1 13:01:03 INFO - mozversion platform_buildid: 20160926094650 13:01:03 INFO - mozversion platform_changeset: 40ee5ff8fad82e4581e49361beb1d00179521420 13:01:03 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/date 13:01:03 INFO - mozversion platform_version: 52.0a1 13:01:03 INFO - using testdate: 1474920063 13:01:03 INFO - actual date: 1474920063 13:01:03 INFO - starting webserver on 'localhost:38793' 13:01:03 INFO - SUITE-START | Running 2 tests 13:01:03 INFO - TEST-START | dromaeo_css 13:01:03 INFO - operating with platform_type : linux_ 13:01:03 INFO - Initialising browser for dromaeo_css test... 13:01:03 INFO - TEST-INFO | started process 4592 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpciw7cQ/profile http://localhost:38793/getInfo.html) 13:01:08 INFO - PROCESS | 4592 | __metrics Screen width/height:1600/1200 13:01:08 INFO - PROCESS | 4592 | colorDepth:24 13:01:08 INFO - PROCESS | 4592 | Browser inner width/height: 1024/697 13:01:08 INFO - PROCESS | 4592 | __metrics 13:01:08 ERROR - PROCESS | 4592 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 13:01:09 INFO - TEST-INFO | 4592: exit 0 13:01:09 INFO - Browser initialized. 13:01:09 INFO - Running cycle 1/1 for dromaeo_css test... 13:01:09 INFO - TEST-INFO | started process 4714 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpciw7cQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:01:21 INFO - PROCESS | 4714 | RSS: Main: 185389056 13:01:21 INFO - PROCESS | 4714 | 13:02:11 INFO - PROCESS | 4714 | 1474920131287 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:21 INFO - PROCESS | 4714 | Cycle 1(1): loaded http://localhost:38793/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38793/tests/dromaeo/cssquery-ext.html) 13:04:22 INFO - PROCESS | 4714 | RSS: Main: 202338304 13:04:22 INFO - PROCESS | 4714 | 13:07:25 INFO - PROCESS | 4714 | Cycle 1(1): loaded http://localhost:38793/tests/dromaeo/cssquery-ext.html (next: http://localhost:38793/tests/dromaeo/cssquery-jquery.html) 13:07:25 INFO - PROCESS | 4714 | RSS: Main: 197095424 13:07:25 INFO - PROCESS | 4714 | 13:10:27 INFO - PROCESS | 4714 | Cycle 1(1): loaded http://localhost:38793/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38793/tests/dromaeo/cssquery-mootools.html) 13:10:28 INFO - PROCESS | 4714 | RSS: Main: 198402048 13:10:28 INFO - PROCESS | 4714 | 13:13:29 INFO - PROCESS | 4714 | Cycle 1(1): loaded http://localhost:38793/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38793/tests/dromaeo/cssquery-prototype.html) 13:13:30 INFO - PROCESS | 4714 | RSS: Main: 195293184 13:13:30 INFO - PROCESS | 4714 | 13:16:33 INFO - PROCESS | 4714 | Cycle 1(1): loaded http://localhost:38793/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38793/tests/dromaeo/cssquery-yui.html) 13:16:34 INFO - PROCESS | 4714 | RSS: Main: 197967872 13:16:34 INFO - PROCESS | 4714 | 13:19:36 INFO - PROCESS | 4714 | Cycle 1(1): loaded http://localhost:38793/tests/dromaeo/cssquery-yui.html (next: http://localhost:38793/tests/dromaeo/cssquery-dojo.html) 13:19:37 INFO - PROCESS | 4714 | RSS: Main: 199122944 13:19:37 INFO - PROCESS | 4714 | 13:19:37 INFO - PROCESS | 4714 | __start_tp_report 13:19:37 INFO - PROCESS | 4714 | _x_x_mozilla_page_load 13:19:37 INFO - PROCESS | 4714 | _x_x_mozilla_page_load_details 13:19:37 INFO - PROCESS | 4714 | |i|pagename|runs| 13:19:37 INFO - PROCESS | 4714 | |0;dojo.html;2933.765298776098;2940.4560156371085;2942.2497263197884;2957.7190166934133;2971.2126286534067;5561.082421400464;5675.2338434311405;5692.743826527806;5694.743736531861;5728.570357223214;5625.043742563764;5713.628614140078;5732.254806875111;5744.741486633101;5748.2527271454655;5150.639455238125;5220.869478263055;5225.947740522603;5255.316808814849;5279.5512381447625;5174.611904107188;5178.896422071556;5225.163973764198;5333.70664613448;5388.515033646971;5182.093133701587;5231.032259032072;5232.529072383485;5239.292695486118;5242.16125419931;5278.736063196844;5323.760430780624;5326.7070311132675;5366.490183432567;5401.972990135064;5033.974830125862;5034.345535080416;5094.5160209780015;5145.742712864342;5154.613403994716;5652.123920792284;5699.943000569982;5723.713814309268;5759.827205183851;5775.797847075374;5949.137375080632;5986.102084687288;6058.1518587397795;6119.99004232014;6130.264368275791;6080.452759251689;6081.939180608181;6085.3914608539235;6093.451589356979;6097.542684298695;5588.133839254922;5629.943700562942;5630.296212973379;5634.267545219136;5693.5445164387575;6236.75052997875;6335.36646335372;6368.617882927039;6369.8726025480155;6395.872082558416;6102.481289090477;6104.236970378703;6107.144999700045;6108.969455152695;6125.418085281891;5981.431763982415;6022.879542409215;6027.6684782336515;6175.3824617538785;6180.505559555225;6038.456538911519;6065.302490213682;6082;6091.208142941389;6120.782376608313;6111.956402836248;6113.354685976816;6114.327782088734;6126.059675755477;6129.419919118773;4536.6824322297125;4557.794899229542;4572.7942242599165;4602.05657840142;4688.742119183477;4045.110075783323;4050.1697152083752;4058.289799285113;4079.592040795956;4152.273352163359;5706.343770466367;5748.971255143698;5812.070068789058;5838.241028666246;5870.882582348329;6162.691865406712;6202.689865506707;6210.31686514483;6212.254529456494;6228.750849966042;5919.6744179070565;5922.052471604523;5933.910991335133;5937.940620593825;5989.850253743604;5186.896262074737;5221;5237.738113094406;5374.086405311028;5398.460153984649;6198.938010619926;6250.468710159596;6254.468370188585;6261.279952805395;6314.652694101868;6074.939250607437;6097.207363042776;6103.969480152571;6110.26676798787;6116.755329786759;6164.198654174928;6208.503319734501;6237.812865614039;6239.0953311768635;6311.810645680637;5936.28764548257;5976.163337132892;5984.371640977809;6020.157177995172;6098.75604975796;6135.969320153371;6148.600340977822;6153.569250152446;6164.198654174928;6165.537584681257;5753.913691294718;5997.760089596367;6007.279126504847;6009.338972712911;6012;5843;5947.464728174485;5963.135345374983;6014.578979471395;6096.512279017757;5920.437558431942;5951.880962380815;5973.1637570741;5990.910136347871;5993.61041532299;5915.91126133117;5960.3443621202505;6001.669908155093;6073.14975903365;6087.208662873798;5839;5908.291005079418;5917.37867523921;5922.2597175353085;5932.317783454958 13:19:37 INFO - PROCESS | 4714 | |1;ext.html;563.4450066684316;576.3919065386018;581.1747318807293;587.7913340764029;587.964722116673;37439.25121497569;39478.802605987;39521.80239098808;41991;42037.15925681492;40286.79856600713;40287.39568906469;40503.797481012625;40514.79742601283;40824;8185.5907204639825;8321.459105158145;8333.416660833744;8340.165983401672;8360.163983601651;8363.414560980735;8392.748217553482;8443.029051659076;8446.493210407396;8449.32405407566;8352.081271060179;8480.194381533744;8480.363972702042;8491.702790402338;8493.278071363942;8429.831403371929;8449.788755281106;8460.407771456;8469.32245420365;8485.66057357705;8254.339652827759;8264.793380165484;8301.630231011875;8309.750707478785;8317.209865062809;34689.826550867336;34841.6515834841;34877.12807179816;34915.825420872985;34988.65011349905;3285.178705323669;3319.0872510059685;3338.4157772389735;3376.5104059911423;3662.322470342995;28182.28244755494;28409;28555.57166642502;28979.56530652042;29017.419651607062;4340.717853339523;4492.663050271242;4574.725516469022;4625.953740462586;4644.512326205768;328721;329600;332159.33920330484;332391;332999;32381.838090809397;50152;50396.49603503991;50399.24401133986;50402.49597503978;33663.32673346519;35181.648183517835;35542.111447214025;35727.106822329646;35729.64270357263;13100.868991309964;13197.73604527904;13215.405306761219;13239.073264871558;13301.06892517534;10531.89468105309;10553.894461055444;10597.523111460003;10599.258051936446;10624.36253824773;8403.823464714946;8445.366597505088;8483.236508714246;8534.317254619615;8540.658373665108;3260.983695081557;3266.8856590019236;3272.9018129456153;3313.072339744875;3360.764746467724;902.2871931174299;946.7443790176613;963.7831487915163;982.7150126463246;1008.0071129937006;28198.85900570484;29661.25846853846;29821.701782982327;29999.850000749855;30064.398712025635;1007.7883644434604;1019.9439030853226;1042.3641578637025;1047.8654592496825;1084.2897901874285;14357.856421435861;15159.393624255126;15224.391024358902;15557.766633500507;15671.921640391725;542257;549803;551725;600741;898634;50556.24165637518;51200;51390;51418.74290628523;51564;1249.419020155632;1256.4597223194114;1271.319843883518;1289.2844471318322;1292.7349893272044;28558.857205713837;29384.559231611114;29633.555496667137;30519.84740076374;30749.692503074682;44408.555914441735;44507.777461112484;44523;44836.551634483236;44858.55141448544;475906;482222;482358;483440;484662;27281;27700.584491232243;27765.444691105662;27976.30059248535;28088.157355279374;39410.40884386794;40259;40814.9796255096;40826.591734083464;41364.586354137275;35565;35911.10222244465;35985.460218096225;35989.64010359863;36392.45411318779;36103.63896361003;36361.636383636884;36682.8165859169;36797;36982.815085925475;31335;31527.84236078805;34492.31015379728;35990.640093598726;37103;26552.601710974737;32981;33654.158646033065;33880.15299617431;34060.14849628779;25273.87363063173;25962;26095.869520652275;26117;26331.736682633695 13:19:37 INFO - PROCESS | 4714 | |2;jquery.html;402.62756949821426;405.6937012555521;408.18566958916966;410.80076163060914;428.86919489555675;16761;18398.540036499093;18416.907915460404;18456.723149152756;18806.81193188071;15146;15745.763813542806;15868.682626347467;15904.84095159048;16044.919775401107;5275.894482110365;5309.150535914255;5507.697076660782;5511.779528818843;5522.972385138089;5319.5478384337375;5428.212909128174;5458.099413596771;5471.534919531825;5475.315585551806;5268.525832675058;5414.07960646689;5422.6475279106735;5431.809886653968;5438.157085651711;5467.20725494803;5504.559635229172;5512.6968016759065;5526.281583394153;5548.9722551387185;4798.088363210979;4969.975150124226;4970.87572810679;4995.400551933755;5011.774470148852;20617.5876482471;21115;21148.365549033555;21164.259250926145;21376;2439.134107391868;2587.8188526803133;2626.3696712788983;2841.957370639442;3065.7700672449655;13164;13296;13795.931020344935;13901.58295251134;14235.928820355935;1883.8869667819974;1902.5909429472729;1954.6579348613936;1964.6168997045581;1984.563396052866;77928.61035694786;80256.59871700604;81152;81771;81906.18093819045;9630.855537166948;9858.211343092535;9939.65211217604;10081.362573216402;10288.074073333435;13907;13942.721145577032;13951.302434878215;13956.720865582834;13988.300584970913;6995.405390541861;7371.336579707745;7415.555066695908;7447.218042105609;7538.208488108779;6887.311268873073;6904.689288982008;7079.04432901562;7312.670929808171;7346.265373462717;6002.789902353396;6061.575689701678;6101.633901965896;6255.937440625627;6335.873282534323;1751.7459968304524;1796.8921864688161;1836.2930271845435;1848.8890666560048;1849.537615596101;871.7036207689416;894.789724414762;894.8702438146563;1014.8376259798397;1016.8576399304103;17532.64934701299;18448.907755461136;18607.534811629546;18611.162497687637;18740.906295468434;897.6229983406985;919.2631951118815;949.349695458613;968.4141094637642;999.3254553176577;10094.09153176203;10314.638987635546;10441.164706823436;10516.631917882838;10650.467476626292;437806;438445;440828;442403;445309;58148.4185158143;59716;97379;99441;100709.49645251727;973.9026097390205;1003.4982508745627;1033.4653040235244;1035.177034257782;1056.3028401255135;16809.91595042017;17080.48758537196;17275.654486910444;17776.733348999518;18141.27434902589;37866;38266;43358.34962475629;43719.78140109279;44292.55707442884;54380.728096359264;55618;58771.70614146902;60725;60833.695831520556;8023.237792409712;8204.302634276153;8353.289970352587;8515.531645759544;8636.222739953435;12354.938225308815;12401.13192076546;12652.493900243888;12935.159214651017;13116.934415327862;11147.554097835995;11360.204785664924;11373.658790236306;11405.543778248777;11600.767984640428;10886.40124793144;11130.888691112985;11285.887141128813;11427.428628568372;11484.310941343547;11475.713107172387;11562;11581.594644187413;11699.88300116988;11924.940375298069;7477.775666730006;7670.884936725842;8270.875936860832;8514.574271286534;8540.829183416421;10815.242932994615;11178.441077946232;11253.268537545033;11488.885111149117;11596.072314215011 13:19:37 INFO - PROCESS | 4714 | |3;mootools.html;1184.7748927703733;1200.4537935239462;1297.6950416652087;1536.462238216625;1543.0433131458497;8206.302464290542;8396.580170991441;8728.214460698537;9376.953115234423;9393.530323483832;8735.257503112243;9049.72850814475;9058.365914385995;9228.215601673848;9327.113924177193;2470.6788117544693;2499.6500489931423;2505.386180385808;2507.7993760499207;2530.0891678995545;2460.7416221296776;2524.4320027993645;2534.3284029732135;2542.8220024598286;2547.732488088752;2471.530409222251;2478.603423452248;2503.3366157968153;2512.1835403493847;2517.622356646499;2440.463098118411;2443.4746529496156;2453.509298140379;2457.336519139831;2459.446624509489;2376.738558758535;2416.320657143286;2423.8303318767694;2433.4281443860855;2434.184548176363;9090.363674542785;9128.178463938211;9140.085991400807;9179.678711245142;9180.632774689004;5146.742662866879;5245.580353571705;5253.4221235664045;5269.235960785703;5291.523762861361;3320.5849268841393;3529.0824385659657;3541.3448512025357;3594.514740510024;3607.6211997740384;1057.6879820452984;1084.1976937066593;1097.7969075721016;1150.7238262816948;1167.8014737494561;13395.06234563581;13420.731585368336;13463.865361346458;13467.191968481824;13499.25754083525;4730.479647238801;4810.11012962596;4854.951450485521;4887.8513549315885;4959.454460009396;11164.385958772184;11193.27243729155;11216.102711783038;11229.606963756229;11247.718807029889;5321.866953326198;5322.92015619766;5323.813666521653;5325.840224793263;5333.786648534093;4658.487566367697;4826.61387089032;4863.392075990501;4875.171220892456;4907.460179380265;3787.8295476703065;3859.826307816155;3896.805159742058;3903.785291808978;3944.2111577684577;1156.5720683347215;1176.405915012913;1180.4097951024487;1189.9107566932341;1194.2356891589216;728.4318231779221;824.5547404401556;836;847.9236868681849;857.5112186054014;5656.318164161741;5837.766489340379;5862.560307976919;5890.322612899571;5974.312954010257;413.77035745161726;415.3561978932642;425.2494347476706;437.67393291997666;449;3857.864974725871;3985.880423587239;4005;4020.7386519876113;4033.0723933494874;11562.421878906189;11780.469878855472;11851.229670071418;11866.169368144147;11913.987311078483;11641.359725215025;11730.70673233176;11735.354555499358;11739.765204696028;11744.471498782576;8202;8403.915960840435;8456.238938495564;8557.871631925651;8615.3107751381;5832.387599302012;5989.101634754647;6076.665783381956;6083;6124.479419249235;10648.787024259627;10781.353118812896;10836.349819010884;10867.239293249397;10897.945510272399;10571.471426428801;10575.471226438802;10780.353178809297;10913.181511386836;10971.451427428437;7397.482176247611;7559;7594.088709354913;7774.961125194338;7998.120206777134;8816;8863.468191908507;8921.687740929035;8931.374803763934;8932.642694292155;7791.610419479117;7983.800404989922;7985.321247694011;7988.760337189894;8083.797905052185;7876.84246315082;7890.48711833729;7938.206179382016;8015.238552337519;8022.759317220492;7371.299726525972;7401.48189626721;7441.739539116105;7498.925010749823;7535.6985720570565;5187.533122019036;5263.447338029452;5271.578273738169;5410.783568657367;5437.912417516592;5322.387925388475;5325.733713314241;5329.9467005331;5400.756965936621;5478.972605136949 13:19:37 INFO - PROCESS | 4714 | |4;prototype.html;349.9177693242089;357.52984824955183;364.75014614988737;372.7614326830829;373.57599124993123;5588.938101760663;5715;5756.740946657405;5788.76844926203;5841.240638716966;5455.18172274159;5579.637323573965;5628.971855140719;5642.304290689594;5660.66036037837;4469.4636643602735;4471.686981911267;4472.597466228039;4477.350784136298;4482.7758612069265;4355.259605867011;4381.4129024649155;4406.71356361837;4469.932951005738;4478.708883922551;4399.098184872109;4413.227685155101;4422.292433210687;4423.447069116361;4425.7565833879125;4404.515503294635;4408.31671090983;4445.066536027438;4452.643788496913;4467;3749.4750734897134;3902.434147048662;3917.157811070605;3945.3292940200236;3952.4071389291835;5635.943640563582;5647.576431767593;5662.207290979266;5673.439804053877;5677.971610141964;5062.544371006627;5138.537531622172;5162.5095615916425;5163.7676304566385;5170.663906846081;5903.321118071433;5926.585139040269;5927.851803704899;5935.427111815372;5947.661776100343;4260.297050986584;4287.571242875719;4297.247981603238;4297.699161058727;4328.7835608219775;6086.147939288503;6212.72042758077;6274.1843560336865;6303.873922521524;6324.525660575475;4338.652907767371;4381.496127945327;4391.012022294958;4401.317795741666;4419.381286619876;4401.603855652943;4429.490608580055;4461.955380446154;4465.816558611906;4478.41780568524;4870.220764677634;5107.668001579886;5114.590832733373;5118.3090282811345;5147.3308469898675;5684.971575142098;6020.4280593343565;6038.33578306386;6041;6041.758329666764;1470.5661829760247;1475.8267177593839;1531.8851086168581;1538.7461068923503;1548.6902619475925;1003.6587560229557;1012.1801340913884;1044.9895501045044;1071.4374953149659;1071.6570697376765;5682.659040457585;5701.771929122789;5715.971420142872;5737.598368114275;5767.22142510764;6047.213862197974;6090.695465226721;6102.572819902653;6106.786262480792;6130.111133885651;5626;5676.233708449389;5724.341700704473;5757;5768.653880767168;2831.7115712350833;2832.886684532637;2845.601615773793;2852.3297025199063;2858.671252805954;5294.205869119663;5404.000259951921;5490.780368785284;5529.152486469471;5564.415736347706;5354.839354819362;5366.543843773245;5374.715745808094;5385.118961355656;5392.703401312887;5419.485148910847;5460.672359658433;5462.3445186577865;5483.533899618497;5515.972420137874;5310.548603368757;5326.840194794162;5394.514493695587;5729.71351432435;6188.752449901954;6132.356102609162;6137.3862613738265;6184.5052395809125;6194.659293738888;6204.3795620437595;6294.590851594632;6466.805995820133;6489.253735820441;6534.509911756732;6590.517133644891;4370.868873933787;4403.427554418034;4418;4428.380026796187;4431.955680443154;6098.878022439615;6211.751529938932;6220.937790622217;6242.719077641608;6250.843728906813;6034.39656034393;6060.000099983454;6066.180145956284;6071.423214794588;6132.141500190066;6025.3070896845675;6036.6679832609625;6042.425969532887;6049.334573196857;6072.603301240828;5727.312722473163;5981.581289309706;5984.551158663031;5986.725044483069;6045.365236650088;6082.5438092142385;6103.474131467133;6114.174586430953;6119.510439164945;6174.969125154345;5642.012647786703;5826.737796799239;5876.853078673067;5908.838771257357;5957.285125784933 13:19:37 INFO - PROCESS | 4714 | |5;yui.html;671.5634837355718;672.7947975867364;674.7098747538558;699.6571679876859;732.4433430592748;15034.924825375872;15472.845271547281;15664.216789160553;15710;16166.595835104128;16006;16007.83992160078;16025.599360016005;16094.517164485054;16130.274137663804;681.8840797064486;688.5730846874919;688.7933619914006;688.8450098727797;690.2131570010192;674.3189378727496;690.1373283395756;695.3290075077549;701.8070030741561;703.103542982696;720.6432815756208;724.3589423360338;727.6870945493436;728.4936968806682;728.785008422514;714.2500374606668;717.8994940708305;719.1334441997407;719.5179229915942;721.7509959064115;527.209186220669;530.2391068816222;530.5993974549191;532.2654736463694;532.6857154278955;13846.30768461583;13856.168629882239;13858.930705346509;13868.514601988882;13881.930590347085;13966.371513281927;14647.780283295759;14755.26223688822;14776.926115369462;14838.554843354717;12157.270563766202;12258.632241032783;12540.623781286577;12592.244465332109;13097.47610095595;4035.9798201009103;4052;4157.854475093357;4279.293916503773;4281.764502952336;83484.58257708733;85067.14932850654;85535;86492;88564.11435885623;10127.189824813997;10259.384436933808;10511.369317840954;10768.838467422995;10987.560497580167;20581.38255852327;20595.07322170506;20614.484637884172;20629.58740825205;20672.379828605164;8001.439899207;8142.837143257102;8199.590020498952;8370.204830541088;8460.365472589581;4695.389599352063;4737.360456338419;4770.928436073462;4790.089882922233;4892.168331383673;3641.672249497558;3694.094946738013;3737.7757334560015;3738.5139931809235;3752.7373083883867;651.0559688451764;653.3825534869503;657.4313219065474;677.7322957431787;725.9600721960343;596.4095545410013;677.109600874848;704.295704295694;717.7416130193126;745.530315900979;8701.17338852808;9407;9599.232061435068;9843.852342214872;9968.850467242997;585.968695096633;617.5954749638994;635.2123367024856;663.4625952978007;722.6820199112374;4067.3898915162963;4170.207660544487;4181.519125300569;4237.6821738369745;4411.18393097278;99639.50180249053;108190;123235;128266.35866820606;128425.15748425083;30662.846685766428;31100.68899310978;67319.66340168267;108337.45831270794;109897;58908.705456472446;60145;91123;92613.07386926179;94274;7618.933349330987;7930.801729956797;7976.401769867399;8104.918950810652;8177.264046235868;54379.72810135924;55754;56312.71843640756;56328.71835640795;57430.42569574251;68370.97443538251;69503.65248173727;78523;78643.60678196572;78674;12095.57665481739;12377.62867113988;13010.349482525646;13552.93223533876;14261.500847470288;14387.352569134206;14410.495632653226;14743.07770925616;15151;15599.298031588833;13744.931275343559;14031.298435078;14117.929410352883;14268.21524816145;14280.785788212977;14275.714485710436;15047.247637617857;15144;15165.696686065996;15687.137207453243;13583;14491.710165796414;14537.491187808799;14540.927295363455;14673.339699713326;10603.91012314109;10617.256792024484;11557.24877882935;11794.115441342105;12113.69715757113;10820.4048777318;10958.890411095786;12051.156419050581;12205.20666156697;12226.816597751218 13:19:37 INFO - PROCESS | 4714 | __end_tp_report 13:19:37 INFO - PROCESS | 4714 | __start_cc_report 13:19:37 INFO - PROCESS | 4714 | _x_x_mozilla_cycle_collect,299 13:19:37 INFO - PROCESS | 4714 | __end_cc_report 13:19:37 INFO - PROCESS | 4714 | __startTimestamp1474921177121__endTimestamp 13:19:37 INFO - PROCESS | 4714 | 13:19:37 INFO - PROCESS | 4714 | ------- Summary: start ------- 13:19:37 INFO - PROCESS | 4714 | Number of tests: 6 13:19:37 INFO - PROCESS | 4714 | 13:19:37 INFO - PROCESS | 4714 | [#0] dojo.html Cycles:165 Average:5670.95 Median:5936.29 stddev:694.92 (11.7%) stddev-sans-first:663.05 13:19:37 INFO - PROCESS | 4714 | Values: 2933.8 2940.5 2942.2 2957.7 2971.2 5561.1 5675.2 5692.7 5694.7 5728.6 5625.0 5713.6 5732.3 5744.7 5748.3 5150.6 5220.9 5225.9 5255.3 5279.6 5174.6 5178.9 5225.2 5333.7 5388.5 5182.1 5231.0 5232.5 5239.3 5242.2 5278.7 5323.8 5326.7 5366.5 5402.0 5034.0 5034.3 5094.5 5145.7 5154.6 5652.1 5699.9 5723.7 5759.8 5775.8 5949.1 5986.1 6058.2 6120.0 6130.3 6080.5 6081.9 6085.4 6093.5 6097.5 5588.1 5629.9 5630.3 5634.3 5693.5 6236.8 6335.4 6368.6 6369.9 6395.9 6102.5 6104.2 6107.1 6109.0 6125.4 5981.4 6022.9 6027.7 6175.4 6180.5 6038.5 6065.3 6082.0 6091.2 6120.8 6112.0 6113.4 6114.3 6126.1 6129.4 4536.7 4557.8 4572.8 4602.1 4688.7 4045.1 4050.2 4058.3 4079.6 4152.3 5706.3 5749.0 5812.1 5838.2 5870.9 6162.7 6202.7 6210.3 6212.3 6228.8 5919.7 5922.1 5933.9 5937.9 5989.9 5186.9 5221.0 5237.7 5374.1 5398.5 6198.9 6250.5 6254.5 6261.3 6314.7 6074.9 6097.2 6104.0 6110.3 6116.8 6164.2 6208.5 6237.8 6239.1 6311.8 5936.3 5976.2 5984.4 6020.2 6098.8 6136.0 6148.6 6153.6 6164.2 6165.5 5753.9 5997.8 6007.3 6009.3 6012.0 5843.0 5947.5 5963.1 6014.6 6096.5 5920.4 5951.9 5973.2 5990.9 5993.6 5915.9 5960.3 6001.7 6073.1 6087.2 5839.0 5908.3 5917.4 5922.3 5932.3 13:19:37 INFO - PROCESS | 4714 | 13:19:37 INFO - PROCESS | 4714 | [#1] ext.html Cycles:180 Average:60007.89 Median:36377.05 stddev:134745.37 (370.4%) stddev-sans-first:135049.45 13:19:37 INFO - PROCESS | 4714 | Values: 563.4 576.4 581.2 587.8 588.0 37439.3 39478.8 39521.8 41991.0 42037.2 40286.8 40287.4 40503.8 40514.8 40824.0 8185.6 8321.5 8333.4 8340.2 8360.2 8363.4 8392.7 8443.0 8446.5 8449.3 8352.1 8480.2 8480.4 8491.7 8493.3 8429.8 8449.8 8460.4 8469.3 8485.7 8254.3 8264.8 8301.6 8309.8 8317.2 34689.8 34841.7 34877.1 34915.8 34988.7 3285.2 3319.1 3338.4 3376.5 3662.3 28182.3 28409.0 28555.6 28979.6 29017.4 4340.7 4492.7 4574.7 4626.0 4644.5 328721.0 329600.0 332159.3 332391.0 332999.0 32381.8 50152.0 50396.5 50399.2 50402.5 33663.3 35181.6 35542.1 35727.1 35729.6 13100.9 13197.7 13215.4 13239.1 13301.1 10531.9 10553.9 10597.5 10599.3 10624.4 8403.8 8445.4 8483.2 8534.3 8540.7 3261.0 3266.9 3272.9 3313.1 3360.8 902.3 946.7 963.8 982.7 1008.0 28198.9 29661.3 29821.7 29999.9 30064.4 1007.8 1019.9 1042.4 1047.9 1084.3 14357.9 15159.4 15224.4 15557.8 15671.9 542257.0 549803.0 551725.0 600741.0 898634.0 50556.2 51200.0 51390.0 51418.7 51564.0 1249.4 1256.5 1271.3 1289.3 1292.7 28558.9 29384.6 29633.6 30519.8 30749.7 44408.6 44507.8 44523.0 44836.6 44858.6 475906.0 482222.0 482358.0 483440.0 484662.0 27281.0 27700.6 27765.4 27976.3 28088.2 39410.4 40259.0 40815.0 40826.6 41364.6 35565.0 35911.1 35985.5 35989.6 36392.5 36103.6 36361.6 36682.8 36797.0 36982.8 31335.0 31527.8 34492.3 35990.6 37103.0 26552.6 32981.0 33654.2 33880.2 34060.1 25273.9 25962.0 26095.9 26117.0 26331.7 13:19:37 INFO - PROCESS | 4714 | 13:19:37 INFO - PROCESS | 4714 | [#2] jquery.html Cycles:180 Average:27077.04 Median:19334.31 stddev:72914.22 (377.1%) stddev-sans-first:73091.26 13:19:37 INFO - PROCESS | 4714 | Values: 402.6 405.7 408.2 410.8 428.9 16761.0 18398.5 18416.9 18456.7 18806.8 15146.0 15745.8 15868.7 15904.8 16044.9 5275.9 5309.2 5507.7 5511.8 5523.0 5319.5 5428.2 5458.1 5471.5 5475.3 5268.5 5414.1 5422.6 5431.8 5438.2 5467.2 5504.6 5512.7 5526.3 5549.0 4798.1 4970.0 4970.9 4995.4 5011.8 20617.6 21115.0 21148.4 21164.3 21376.0 2439.1 2587.8 2626.4 2842.0 3065.8 13164.0 13296.0 13795.9 13901.6 14235.9 1883.9 1902.6 1954.7 1964.6 1984.6 77928.6 80256.6 81152.0 81771.0 81906.2 9630.9 9858.2 9939.7 10081.4 10288.1 13907.0 13942.7 13951.3 13956.7 13988.3 6995.4 7371.3 7415.6 7447.2 7538.2 6887.3 6904.7 7079.0 7312.7 7346.3 6002.8 6061.6 6101.6 6255.9 6335.9 1751.7 1796.9 1836.3 1848.9 1849.5 871.7 894.8 894.9 1014.8 1016.9 17532.6 18448.9 18607.5 18611.2 18740.9 897.6 919.3 949.3 968.4 999.3 10094.1 10314.6 10441.2 10516.6 10650.5 437806.0 438445.0 440828.0 442403.0 445309.0 58148.4 59716.0 97379.0 99441.0 100709.5 973.9 1003.5 1033.5 1035.2 1056.3 16809.9 17080.5 17275.7 17776.7 18141.3 37866.0 38266.0 43358.3 43719.8 44292.6 54380.7 55618.0 58771.7 60725.0 60833.7 8023.2 8204.3 8353.3 8515.5 8636.2 12354.9 12401.1 12652.5 12935.2 13116.9 11147.6 11360.2 11373.7 11405.5 11600.8 10886.4 11130.9 11285.9 11427.4 11484.3 11475.7 11562.0 11581.6 11699.9 11924.9 7477.8 7670.9 8270.9 8514.6 8540.8 10815.2 11178.4 11253.3 11488.9 11596.1 13:19:37 INFO - PROCESS | 4714 | 13:19:37 INFO - PROCESS | 4714 | [#3] mootools.html Cycles:180 Average:6016.82 Median:4694.48 stddev:3574.59 (76.1%) stddev-sans-first:3566.17 13:19:37 INFO - PROCESS | 4714 | Values: 1184.8 1200.5 1297.7 1536.5 1543.0 8206.3 8396.6 8728.2 9377.0 9393.5 8735.3 9049.7 9058.4 9228.2 9327.1 2470.7 2499.7 2505.4 2507.8 2530.1 2460.7 2524.4 2534.3 2542.8 2547.7 2471.5 2478.6 2503.3 2512.2 2517.6 2440.5 2443.5 2453.5 2457.3 2459.4 2376.7 2416.3 2423.8 2433.4 2434.2 9090.4 9128.2 9140.1 9179.7 9180.6 5146.7 5245.6 5253.4 5269.2 5291.5 3320.6 3529.1 3541.3 3594.5 3607.6 1057.7 1084.2 1097.8 1150.7 1167.8 13395.1 13420.7 13463.9 13467.2 13499.3 4730.5 4810.1 4855.0 4887.9 4959.5 11164.4 11193.3 11216.1 11229.6 11247.7 5321.9 5322.9 5323.8 5325.8 5333.8 4658.5 4826.6 4863.4 4875.2 4907.5 3787.8 3859.8 3896.8 3903.8 3944.2 1156.6 1176.4 1180.4 1189.9 1194.2 728.4 824.6 836.0 847.9 857.5 5656.3 5837.8 5862.6 5890.3 5974.3 413.8 415.4 425.2 437.7 449.0 3857.9 3985.9 4005.0 4020.7 4033.1 11562.4 11780.5 11851.2 11866.2 11914.0 11641.4 11730.7 11735.4 11739.8 11744.5 8202.0 8403.9 8456.2 8557.9 8615.3 5832.4 5989.1 6076.7 6083.0 6124.5 10648.8 10781.4 10836.3 10867.2 10897.9 10571.5 10575.5 10780.4 10913.2 10971.5 7397.5 7559.0 7594.1 7775.0 7998.1 8816.0 8863.5 8921.7 8931.4 8932.6 7791.6 7983.8 7985.3 7988.8 8083.8 7876.8 7890.5 7938.2 8015.2 8022.8 7371.3 7401.5 7441.7 7498.9 7535.7 5187.5 5263.4 5271.6 5410.8 5437.9 5322.4 5325.7 5329.9 5400.8 5479.0 13:19:37 INFO - PROCESS | 4714 | 13:19:37 INFO - PROCESS | 4714 | [#4] prototype.html Cycles:180 Average:4960.20 Median:5503.38 stddev:1458.01 (26.5%) stddev-sans-first:1420.44 13:19:37 INFO - PROCESS | 4714 | Values: 349.9 357.5 364.8 372.8 373.6 5588.9 5715.0 5756.7 5788.8 5841.2 5455.2 5579.6 5629.0 5642.3 5660.7 4469.5 4471.7 4472.6 4477.4 4482.8 4355.3 4381.4 4406.7 4469.9 4478.7 4399.1 4413.2 4422.3 4423.4 4425.8 4404.5 4408.3 4445.1 4452.6 4467.0 3749.5 3902.4 3917.2 3945.3 3952.4 5635.9 5647.6 5662.2 5673.4 5678.0 5062.5 5138.5 5162.5 5163.8 5170.7 5903.3 5926.6 5927.9 5935.4 5947.7 4260.3 4287.6 4297.2 4297.7 4328.8 6086.1 6212.7 6274.2 6303.9 6324.5 4338.7 4381.5 4391.0 4401.3 4419.4 4401.6 4429.5 4462.0 4465.8 4478.4 4870.2 5107.7 5114.6 5118.3 5147.3 5685.0 6020.4 6038.3 6041.0 6041.8 1470.6 1475.8 1531.9 1538.7 1548.7 1003.7 1012.2 1045.0 1071.4 1071.7 5682.7 5701.8 5716.0 5737.6 5767.2 6047.2 6090.7 6102.6 6106.8 6130.1 5626.0 5676.2 5724.3 5757.0 5768.7 2831.7 2832.9 2845.6 2852.3 2858.7 5294.2 5404.0 5490.8 5529.2 5564.4 5354.8 5366.5 5374.7 5385.1 5392.7 5419.5 5460.7 5462.3 5483.5 5516.0 5310.5 5326.8 5394.5 5729.7 6188.8 6132.4 6137.4 6184.5 6194.7 6204.4 6294.6 6466.8 6489.3 6534.5 6590.5 4370.9 4403.4 4418.0 4428.4 4432.0 6098.9 6211.8 6220.9 6242.7 6250.8 6034.4 6060.0 6066.2 6071.4 6132.1 6025.3 6036.7 6042.4 6049.3 6072.6 5727.3 5981.6 5984.6 5986.7 6045.4 6082.5 6103.5 6114.2 6119.5 6175.0 5642.0 5826.7 5876.9 5908.8 5957.3 13:19:37 INFO - PROCESS | 4714 | 13:19:37 INFO - PROCESS | 4714 | [#5] yui.html Cycles:180 Average:20274.56 Median:4280.53 stddev:29466.40 (688.4%) stddev-sans-first:29512.30 13:19:37 INFO - PROCESS | 4714 | Values: 671.6 672.8 674.7 699.7 732.4 15034.9 15472.8 15664.2 15710.0 16166.6 16006.0 16007.8 16025.6 16094.5 16130.3 681.9 688.6 688.8 688.8 690.2 674.3 690.1 695.3 701.8 703.1 720.6 724.4 727.7 728.5 728.8 714.3 717.9 719.1 719.5 721.8 527.2 530.2 530.6 532.3 532.7 13846.3 13856.2 13858.9 13868.5 13881.9 13966.4 14647.8 14755.3 14776.9 14838.6 12157.3 12258.6 12540.6 12592.2 13097.5 4036.0 4052.0 4157.9 4279.3 4281.8 83484.6 85067.1 85535.0 86492.0 88564.1 10127.2 10259.4 10511.4 10768.8 10987.6 20581.4 20595.1 20614.5 20629.6 20672.4 8001.4 8142.8 8199.6 8370.2 8460.4 4695.4 4737.4 4770.9 4790.1 4892.2 3641.7 3694.1 3737.8 3738.5 3752.7 651.1 653.4 657.4 677.7 726.0 596.4 677.1 704.3 717.7 745.5 8701.2 9407.0 9599.2 9843.9 9968.9 586.0 617.6 635.2 663.5 722.7 4067.4 4170.2 4181.5 4237.7 4411.2 99639.5 108190.0 123235.0 128266.4 128425.2 30662.8 31100.7 67319.7 108337.5 109897.0 58908.7 60145.0 91123.0 92613.1 94274.0 7618.9 7930.8 7976.4 8104.9 8177.3 54379.7 55754.0 56312.7 56328.7 57430.4 68371.0 69503.7 78523.0 78643.6 78674.0 12095.6 12377.6 13010.3 13552.9 14261.5 14387.4 14410.5 14743.1 15151.0 15599.3 13744.9 14031.3 14117.9 14268.2 14280.8 14275.7 15047.2 15144.0 15165.7 15687.1 13583.0 14491.7 14537.5 14540.9 14673.3 10603.9 10617.3 11557.2 11794.1 12113.7 10820.4 10958.9 12051.2 12205.2 12226.8 13:19:37 INFO - PROCESS | 4714 | -------- Summary: end -------- 13:19:37 INFO - PROCESS | 4714 | 13:19:38 INFO - TEST-INFO | 4714: exit 0 13:19:38 INFO - TEST-OK | dromaeo_css | took 1114466ms 13:19:38 INFO - TEST-START | kraken 13:19:38 INFO - operating with platform_type : linux_ 13:19:38 INFO - Initialising browser for kraken test... 13:19:38 INFO - TEST-INFO | started process 5074 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0boKS1/profile http://localhost:38793/getInfo.html) 13:19:42 INFO - PROCESS | 5074 | __metrics Screen width/height:1600/1200 13:19:42 INFO - PROCESS | 5074 | colorDepth:24 13:19:42 INFO - PROCESS | 5074 | Browser inner width/height: 1024/697 13:19:42 INFO - PROCESS | 5074 | __metrics 13:19:42 ERROR - PROCESS | 5074 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 13:19:43 INFO - TEST-INFO | 5074: exit 0 13:19:43 INFO - Browser initialized. 13:19:43 INFO - Running cycle 1/1 for kraken test... 13:19:43 INFO - TEST-INFO | started process 5198 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0boKS1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:19:55 INFO - PROCESS | 5198 | RSS: Main: 185323520 13:19:55 INFO - PROCESS | 5198 | 13:19:58 INFO - PROCESS | 5198 | Cycle 1(1): loaded http://localhost:38793/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38793/tests/kraken/driver.html?testName=audio-beat-detection) 13:19:59 INFO - PROCESS | 5198 | RSS: Main: 199467008 13:19:59 INFO - PROCESS | 5198 | 13:20:02 INFO - PROCESS | 5198 | Cycle 1(1): loaded http://localhost:38793/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38793/tests/kraken/driver.html?testName=audio-dft) 13:20:02 INFO - PROCESS | 5198 | RSS: Main: 197414912 13:20:02 INFO - PROCESS | 5198 | 13:20:05 INFO - PROCESS | 5198 | Cycle 1(1): loaded http://localhost:38793/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38793/tests/kraken/driver.html?testName=audio-fft) 13:20:06 INFO - PROCESS | 5198 | RSS: Main: 192286720 13:20:06 INFO - PROCESS | 5198 | 13:20:08 INFO - PROCESS | 5198 | Cycle 1(1): loaded http://localhost:38793/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38793/tests/kraken/driver.html?testName=audio-oscillator) 13:20:08 INFO - PROCESS | 5198 | RSS: Main: 193306624 13:20:08 INFO - PROCESS | 5198 | 13:20:10 INFO - PROCESS | 5198 | Cycle 1(1): loaded http://localhost:38793/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38793/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:20:11 INFO - PROCESS | 5198 | RSS: Main: 193024000 13:20:11 INFO - PROCESS | 5198 | 13:20:14 INFO - PROCESS | 5198 | Cycle 1(1): loaded http://localhost:38793/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38793/tests/kraken/driver.html?testName=imaging-darkroom) 13:20:15 INFO - PROCESS | 5198 | RSS: Main: 193290240 13:20:15 INFO - PROCESS | 5198 | 13:20:18 INFO - PROCESS | 5198 | Cycle 1(1): loaded http://localhost:38793/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38793/tests/kraken/driver.html?testName=imaging-desaturate) 13:20:19 INFO - PROCESS | 5198 | RSS: Main: 194023424 13:20:19 INFO - PROCESS | 5198 | 13:20:22 INFO - PROCESS | 5198 | Cycle 1(1): loaded http://localhost:38793/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38793/tests/kraken/driver.html?testName=json-parse-financial) 13:20:22 INFO - PROCESS | 5198 | RSS: Main: 193478656 13:20:22 INFO - PROCESS | 5198 | 13:20:24 INFO - PROCESS | 5198 | Cycle 1(1): loaded http://localhost:38793/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38793/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:20:24 INFO - PROCESS | 5198 | RSS: Main: 192860160 13:20:24 INFO - PROCESS | 5198 | 13:20:26 INFO - PROCESS | 5198 | Cycle 1(1): loaded http://localhost:38793/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38793/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:20:27 INFO - PROCESS | 5198 | RSS: Main: 192761856 13:20:27 INFO - PROCESS | 5198 | 13:20:29 INFO - PROCESS | 5198 | Cycle 1(1): loaded http://localhost:38793/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38793/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:20:30 INFO - PROCESS | 5198 | RSS: Main: 194232320 13:20:30 INFO - PROCESS | 5198 | 13:20:32 INFO - PROCESS | 5198 | Cycle 1(1): loaded http://localhost:38793/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38793/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:20:33 INFO - PROCESS | 5198 | RSS: Main: 193908736 13:20:33 INFO - PROCESS | 5198 | 13:20:36 INFO - PROCESS | 5198 | Cycle 1(1): loaded http://localhost:38793/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38793/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:20:36 INFO - PROCESS | 5198 | RSS: Main: 193302528 13:20:36 INFO - PROCESS | 5198 | 13:20:38 INFO - PROCESS | 5198 | Cycle 1(1): loaded http://localhost:38793/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38793/tests/kraken/driver.html?testName=ai-astar) 13:20:38 INFO - PROCESS | 5198 | RSS: Main: 195756032 13:20:38 INFO - PROCESS | 5198 | 13:20:38 INFO - PROCESS | 5198 | __start_tp_report 13:20:38 INFO - PROCESS | 5198 | _x_x_mozilla_page_load 13:20:38 INFO - PROCESS | 5198 | _x_x_mozilla_page_load_details 13:20:38 INFO - PROCESS | 5198 | |i|pagename|runs| 13:20:38 INFO - PROCESS | 5198 | |0;ai-astar;103;113;115;114;112;114;114;114;116;113 13:20:38 INFO - PROCESS | 5198 | |1;audio-beat-detection;147;123;121;170;119;123;119;121;149;127 13:20:38 INFO - PROCESS | 5198 | |2;audio-dft;162;164;165;164;167;168;163;162;162;163 13:20:38 INFO - PROCESS | 5198 | |3;audio-fft;76;76;76;93;75;75;76;75;102;75 13:20:38 INFO - PROCESS | 5198 | |4;audio-oscillator;84;85;117;83;84;83;100;82;82;104 13:20:38 INFO - PROCESS | 5198 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;119;117;117 13:20:38 INFO - PROCESS | 5198 | |6;imaging-darkroom;147;148;147;147;146;147;147;148;147;148 13:20:38 INFO - PROCESS | 5198 | |7;imaging-desaturate;97;97;95;96;96;96;95;96;95;95 13:20:38 INFO - PROCESS | 5198 | |8;json-parse-financial;50;51;50;51;53;53;55;55;52;52 13:20:38 INFO - PROCESS | 5198 | |9;json-stringify-tinderbox;60;60;59;59;60;59;59;60;60;60 13:20:38 INFO - PROCESS | 5198 | |10;stanford-crypto-aes;84;86;79;78;78;80;78;78;78;77 13:20:38 INFO - PROCESS | 5198 | |11;stanford-crypto-ccm;127;129;130;123;124;124;134;125;163;122 13:20:38 INFO - PROCESS | 5198 | |12;stanford-crypto-pbkdf2;163;174;166;162;163;178;166;167;164;161 13:20:38 INFO - PROCESS | 5198 | |13;stanford-crypto-sha256-iterative;64;63;64;67;64;63;63;63;64;63 13:20:38 INFO - PROCESS | 5198 | __end_tp_report 13:20:38 INFO - PROCESS | 5198 | __start_cc_report 13:20:38 INFO - PROCESS | 5198 | _x_x_mozilla_cycle_collect,755 13:20:38 INFO - PROCESS | 5198 | __end_cc_report 13:20:38 INFO - PROCESS | 5198 | __startTimestamp1474921238586__endTimestamp 13:20:38 INFO - PROCESS | 5198 | 13:20:38 INFO - PROCESS | 5198 | ------- Summary: start ------- 13:20:38 INFO - PROCESS | 5198 | Number of tests: 14 13:20:38 INFO - PROCESS | 5198 | 13:20:38 INFO - PROCESS | 5198 | [#0] ai-astar Cycles:10 Average:112.80 Median:114.00 stddev:3.61 (3.2%) stddev-sans-first:1.17 13:20:38 INFO - PROCESS | 5198 | Values: 103.0 113.0 115.0 114.0 112.0 114.0 114.0 114.0 116.0 113.0 13:20:38 INFO - PROCESS | 5198 | 13:20:38 INFO - PROCESS | 5198 | [#1] audio-beat-detection Cycles:10 Average:131.90 Median:125.00 stddev:17.40 (13.9%) stddev-sans-first:17.58 13:20:38 INFO - PROCESS | 5198 | Values: 147.0 123.0 121.0 170.0 119.0 123.0 119.0 121.0 149.0 127.0 13:20:38 INFO - PROCESS | 5198 | 13:20:38 INFO - PROCESS | 5198 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.00 stddev:2.11 (1.3%) stddev-sans-first:2.11 13:20:38 INFO - PROCESS | 5198 | Values: 162.0 164.0 165.0 164.0 167.0 168.0 163.0 162.0 162.0 163.0 13:20:38 INFO - PROCESS | 5198 | 13:20:38 INFO - PROCESS | 5198 | [#3] audio-fft Cycles:10 Average:79.90 Median:76.00 stddev:9.53 (12.5%) stddev-sans-first:10.00 13:20:38 INFO - PROCESS | 5198 | Values: 76.0 76.0 76.0 93.0 75.0 75.0 76.0 75.0 102.0 75.0 13:20:38 INFO - PROCESS | 5198 | 13:20:38 INFO - PROCESS | 5198 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:83.00 stddev:12.23 (14.7%) stddev-sans-first:12.75 13:20:38 INFO - PROCESS | 5198 | Values: 84.0 85.0 117.0 83.0 84.0 83.0 100.0 82.0 82.0 104.0 13:20:38 INFO - PROCESS | 5198 | 13:20:38 INFO - PROCESS | 5198 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 13:20:38 INFO - PROCESS | 5198 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 119.0 117.0 117.0 13:20:38 INFO - PROCESS | 5198 | 13:20:38 INFO - PROCESS | 5198 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 13:20:38 INFO - PROCESS | 5198 | Values: 147.0 148.0 147.0 147.0 146.0 147.0 147.0 148.0 147.0 148.0 13:20:38 INFO - PROCESS | 5198 | 13:20:38 INFO - PROCESS | 5198 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.71 13:20:38 INFO - PROCESS | 5198 | Values: 97.0 97.0 95.0 96.0 96.0 96.0 95.0 96.0 95.0 95.0 13:20:38 INFO - PROCESS | 5198 | 13:20:38 INFO - PROCESS | 5198 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.50 stddev:1.81 (3.5%) stddev-sans-first:1.74 13:20:38 INFO - PROCESS | 5198 | Values: 50.0 51.0 50.0 51.0 53.0 53.0 55.0 55.0 52.0 52.0 13:20:38 INFO - PROCESS | 5198 | 13:20:38 INFO - PROCESS | 5198 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:60.00 stddev:0.52 (0.9%) stddev-sans-first:0.53 13:20:38 INFO - PROCESS | 5198 | Values: 60.0 60.0 59.0 59.0 60.0 59.0 59.0 60.0 60.0 60.0 13:20:38 INFO - PROCESS | 5198 | 13:20:38 INFO - PROCESS | 5198 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:78.50 stddev:2.99 (3.8%) stddev-sans-first:2.71 13:20:38 INFO - PROCESS | 5198 | Values: 84.0 86.0 79.0 78.0 78.0 80.0 78.0 78.0 78.0 77.0 13:20:38 INFO - PROCESS | 5198 | 13:20:38 INFO - PROCESS | 5198 | [#11] stanford-crypto-ccm Cycles:10 Average:130.10 Median:128.00 stddev:12.13 (9.5%) stddev-sans-first:12.82 13:20:38 INFO - PROCESS | 5198 | Values: 127.0 129.0 130.0 123.0 124.0 124.0 134.0 125.0 163.0 122.0 13:20:38 INFO - PROCESS | 5198 | 13:20:38 INFO - PROCESS | 5198 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.40 Median:166.00 stddev:5.48 (3.3%) stddev-sans-first:5.67 13:20:38 INFO - PROCESS | 5198 | Values: 163.0 174.0 166.0 162.0 163.0 178.0 166.0 167.0 164.0 161.0 13:20:38 INFO - PROCESS | 5198 | 13:20:38 INFO - PROCESS | 5198 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.00 stddev:1.23 (1.9%) stddev-sans-first:1.30 13:20:38 INFO - PROCESS | 5198 | Values: 64.0 63.0 64.0 67.0 64.0 63.0 63.0 63.0 64.0 63.0 13:20:38 INFO - PROCESS | 5198 | -------- Summary: end -------- 13:20:38 INFO - PROCESS | 5198 | 13:20:38 INFO - PROCESS | 5198 | 13:20:38 INFO - PROCESS | 5198 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 13:20:38 INFO - PROCESS | 5198 | 13:20:38 INFO - PROCESS | 5198 | 13:20:38 INFO - PROCESS | 5198 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 13:20:38 INFO - PROCESS | 5198 | 13:20:38 INFO - PROCESS | 5198 | 13:20:38 INFO - PROCESS | 5198 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 13:20:38 INFO - PROCESS | 5198 | 13:20:38 INFO - PROCESS | 5198 | 13:20:38 INFO - PROCESS | 5198 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 13:20:38 INFO - PROCESS | 5198 | 13:20:38 INFO - PROCESS | 5198 | 13:20:38 INFO - PROCESS | 5198 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000B,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 13:20:38 INFO - PROCESS | 5198 | 13:20:39 INFO - TEST-INFO | 5198: exit 0 13:20:39 INFO - TEST-OK | kraken | took 61619ms 13:20:39 INFO - SUITE-END | took 1176s 13:20:39 INFO - Completed test suite (00:19:36) 13:20:39 INFO - javascript benchmark 13:20:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7164.704196129091, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2933.765298776098, 2940.4560156371085, 2942.2497263197884, 2957.7190166934133, 2971.2126286534067, 5561.082421400464, 5675.2338434311405, 5692.743826527806, 5694.743736531861, 5728.570357223214, 5625.043742563764, 5713.628614140078, 5732.254806875111, 5744.741486633101, 5748.2527271454655, 5150.639455238125, 5220.869478263055, 5225.947740522603, 5255.316808814849, 5279.5512381447625, 5174.611904107188, 5178.896422071556, 5225.163973764198, 5333.70664613448, 5388.515033646971, 5182.093133701587, 5231.032259032072, 5232.529072383485, 5239.292695486118, 5242.16125419931, 5278.736063196844, 5323.760430780624, 5326.7070311132675, 5366.490183432567, 5401.972990135064, 5033.974830125862, 5034.345535080416, 5094.5160209780015, 5145.742712864342, 5154.613403994716, 5652.123920792284, 5699.943000569982, 5723.713814309268, 5759.827205183851, 5775.797847075374, 5949.137375080632, 5986.102084687288, 6058.1518587397795, 6119.99004232014, 6130.264368275791, 6080.452759251689, 6081.939180608181, 6085.3914608539235, 6093.451589356979, 6097.542684298695, 5588.133839254922, 5629.943700562942, 5630.296212973379, 5634.267545219136, 5693.5445164387575, 6236.75052997875, 6335.36646335372, 6368.617882927039, 6369.8726025480155, 6395.872082558416, 6102.481289090477, 6104.236970378703, 6107.144999700045, 6108.969455152695, 6125.418085281891, 5981.431763982415, 6022.879542409215, 6027.6684782336515, 6175.3824617538785, 6180.505559555225, 6038.456538911519, 6065.302490213682, 6082.0, 6091.208142941389, 6120.782376608313, 6111.956402836248, 6113.354685976816, 6114.327782088734, 6126.059675755477, 6129.419919118773, 4536.6824322297125, 4557.794899229542, 4572.7942242599165, 4602.05657840142, 4688.742119183477, 4045.110075783323, 4050.1697152083752, 4058.289799285113, 4079.592040795956, 4152.273352163359, 5706.343770466367, 5748.971255143698, 5812.070068789058, 5838.241028666246, 5870.882582348329, 6162.691865406712, 6202.689865506707, 6210.31686514483, 6212.254529456494, 6228.750849966042, 5919.6744179070565, 5922.052471604523, 5933.910991335133, 5937.940620593825, 5989.850253743604, 5186.896262074737, 5221.0, 5237.738113094406, 5374.086405311028, 5398.460153984649, 6198.938010619926, 6250.468710159596, 6254.468370188585, 6261.279952805395, 6314.652694101868, 6074.939250607437, 6097.207363042776, 6103.969480152571, 6110.26676798787, 6116.755329786759, 6164.198654174928, 6208.503319734501, 6237.812865614039, 6239.0953311768635, 6311.810645680637, 5936.28764548257, 5976.163337132892, 5984.371640977809, 6020.157177995172, 6098.75604975796, 6135.969320153371, 6148.600340977822, 6153.569250152446, 6164.198654174928, 6165.537584681257, 5753.913691294718, 5997.760089596367, 6007.279126504847, 6009.338972712911, 6012.0, 5843.0, 5947.464728174485, 5963.135345374983, 6014.578979471395, 6096.512279017757, 5920.437558431942, 5951.880962380815, 5973.1637570741, 5990.910136347871, 5993.61041532299, 5915.91126133117, 5960.3443621202505, 6001.669908155093, 6073.14975903365, 6087.208662873798, 5839.0, 5908.291005079418, 5917.37867523921, 5922.2597175353085, 5932.317783454958], "value": 5617.265181142177, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.4450066684316, 576.3919065386018, 581.1747318807293, 587.7913340764029, 587.964722116673, 37439.25121497569, 39478.802605987, 39521.80239098808, 41991.0, 42037.15925681492, 40286.79856600713, 40287.39568906469, 40503.797481012625, 40514.79742601283, 40824.0, 8185.5907204639825, 8321.459105158145, 8333.416660833744, 8340.165983401672, 8360.163983601651, 8363.414560980735, 8392.748217553482, 8443.029051659076, 8446.493210407396, 8449.32405407566, 8352.081271060179, 8480.194381533744, 8480.363972702042, 8491.702790402338, 8493.278071363942, 8429.831403371929, 8449.788755281106, 8460.407771456, 8469.32245420365, 8485.66057357705, 8254.339652827759, 8264.793380165484, 8301.630231011875, 8309.750707478785, 8317.209865062809, 34689.826550867336, 34841.6515834841, 34877.12807179816, 34915.825420872985, 34988.65011349905, 3285.178705323669, 3319.0872510059685, 3338.4157772389735, 3376.5104059911423, 3662.322470342995, 28182.28244755494, 28409.0, 28555.57166642502, 28979.56530652042, 29017.419651607062, 4340.717853339523, 4492.663050271242, 4574.725516469022, 4625.953740462586, 4644.512326205768, 328721.0, 329600.0, 332159.33920330484, 332391.0, 332999.0, 32381.838090809397, 50152.0, 50396.49603503991, 50399.24401133986, 50402.49597503978, 33663.32673346519, 35181.648183517835, 35542.111447214025, 35727.106822329646, 35729.64270357263, 13100.868991309964, 13197.73604527904, 13215.405306761219, 13239.073264871558, 13301.06892517534, 10531.89468105309, 10553.894461055444, 10597.523111460003, 10599.258051936446, 10624.36253824773, 8403.823464714946, 8445.366597505088, 8483.236508714246, 8534.317254619615, 8540.658373665108, 3260.983695081557, 3266.8856590019236, 3272.9018129456153, 3313.072339744875, 3360.764746467724, 902.2871931174299, 946.7443790176613, 963.7831487915163, 982.7150126463246, 1008.0071129937006, 28198.85900570484, 29661.25846853846, 29821.701782982327, 29999.850000749855, 30064.398712025635, 1007.7883644434604, 1019.9439030853226, 1042.3641578637025, 1047.8654592496825, 1084.2897901874285, 14357.856421435861, 15159.393624255126, 15224.391024358902, 15557.766633500507, 15671.921640391725, 542257.0, 549803.0, 551725.0, 600741.0, 898634.0, 50556.24165637518, 51200.0, 51390.0, 51418.74290628523, 51564.0, 1249.419020155632, 1256.4597223194114, 1271.319843883518, 1289.2844471318322, 1292.7349893272044, 28558.857205713837, 29384.559231611114, 29633.555496667137, 30519.84740076374, 30749.692503074682, 44408.555914441735, 44507.777461112484, 44523.0, 44836.551634483236, 44858.55141448544, 475906.0, 482222.0, 482358.0, 483440.0, 484662.0, 27281.0, 27700.584491232243, 27765.444691105662, 27976.30059248535, 28088.157355279374, 39410.40884386794, 40259.0, 40814.9796255096, 40826.591734083464, 41364.586354137275, 35565.0, 35911.10222244465, 35985.460218096225, 35989.64010359863, 36392.45411318779, 36103.63896361003, 36361.636383636884, 36682.8165859169, 36797.0, 36982.815085925475, 31335.0, 31527.84236078805, 34492.31015379728, 35990.640093598726, 37103.0, 26552.601710974737, 32981.0, 33654.158646033065, 33880.15299617431, 34060.14849628779, 25273.87363063173, 25962.0, 26095.869520652275, 26117.0, 26331.736682633695], "value": 17561.227336719912, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.62756949821426, 405.6937012555521, 408.18566958916966, 410.80076163060914, 428.86919489555675, 16761.0, 18398.540036499093, 18416.907915460404, 18456.723149152756, 18806.81193188071, 15146.0, 15745.763813542806, 15868.682626347467, 15904.84095159048, 16044.919775401107, 5275.894482110365, 5309.150535914255, 5507.697076660782, 5511.779528818843, 5522.972385138089, 5319.5478384337375, 5428.212909128174, 5458.099413596771, 5471.534919531825, 5475.315585551806, 5268.525832675058, 5414.07960646689, 5422.6475279106735, 5431.809886653968, 5438.157085651711, 5467.20725494803, 5504.559635229172, 5512.6968016759065, 5526.281583394153, 5548.9722551387185, 4798.088363210979, 4969.975150124226, 4970.87572810679, 4995.400551933755, 5011.774470148852, 20617.5876482471, 21115.0, 21148.365549033555, 21164.259250926145, 21376.0, 2439.134107391868, 2587.8188526803133, 2626.3696712788983, 2841.957370639442, 3065.7700672449655, 13164.0, 13296.0, 13795.931020344935, 13901.58295251134, 14235.928820355935, 1883.8869667819974, 1902.5909429472729, 1954.6579348613936, 1964.6168997045581, 1984.563396052866, 77928.61035694786, 80256.59871700604, 81152.0, 81771.0, 81906.18093819045, 9630.855537166948, 9858.211343092535, 9939.65211217604, 10081.362573216402, 10288.074073333435, 13907.0, 13942.721145577032, 13951.302434878215, 13956.720865582834, 13988.300584970913, 6995.405390541861, 7371.336579707745, 7415.555066695908, 7447.218042105609, 7538.208488108779, 6887.311268873073, 6904.689288982008, 7079.04432901562, 7312.670929808171, 7346.265373462717, 6002.789902353396, 6061.575689701678, 6101.633901965896, 6255.937440625627, 6335.873282534323, 1751.7459968304524, 1796.8921864688161, 1836.2930271845435, 1848.8890666560048, 1849.537615596101, 871.7036207689416, 894.789724414762, 894.8702438146563, 1014.8376259798397, 1016.8576399304103, 17532.64934701299, 18448.907755461136, 18607.534811629546, 18611.162497687637, 18740.906295468434, 897.6229983406985, 919.2631951118815, 949.349695458613, 968.4141094637642, 999.3254553176577, 10094.09153176203, 10314.638987635546, 10441.164706823436, 10516.631917882838, 10650.467476626292, 437806.0, 438445.0, 440828.0, 442403.0, 445309.0, 58148.4185158143, 59716.0, 97379.0, 99441.0, 100709.49645251727, 973.9026097390205, 1003.4982508745627, 1033.4653040235244, 1035.177034257782, 1056.3028401255135, 16809.91595042017, 17080.48758537196, 17275.654486910444, 17776.733348999518, 18141.27434902589, 37866.0, 38266.0, 43358.34962475629, 43719.78140109279, 44292.55707442884, 54380.728096359264, 55618.0, 58771.70614146902, 60725.0, 60833.695831520556, 8023.237792409712, 8204.302634276153, 8353.289970352587, 8515.531645759544, 8636.222739953435, 12354.938225308815, 12401.13192076546, 12652.493900243888, 12935.159214651017, 13116.934415327862, 11147.554097835995, 11360.204785664924, 11373.658790236306, 11405.543778248777, 11600.767984640428, 10886.40124793144, 11130.888691112985, 11285.887141128813, 11427.428628568372, 11484.310941343547, 11475.713107172387, 11562.0, 11581.594644187413, 11699.88300116988, 11924.940375298069, 7477.775666730006, 7670.884936725842, 8270.875936860832, 8514.574271286534, 8540.829183416421, 10815.242932994615, 11178.441077946232, 11253.268537545033, 11488.885111149117, 11596.072314215011], "value": 8964.310624199734, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1184.7748927703733, 1200.4537935239462, 1297.6950416652087, 1536.462238216625, 1543.0433131458497, 8206.302464290542, 8396.580170991441, 8728.214460698537, 9376.953115234423, 9393.530323483832, 8735.257503112243, 9049.72850814475, 9058.365914385995, 9228.215601673848, 9327.113924177193, 2470.6788117544693, 2499.6500489931423, 2505.386180385808, 2507.7993760499207, 2530.0891678995545, 2460.7416221296776, 2524.4320027993645, 2534.3284029732135, 2542.8220024598286, 2547.732488088752, 2471.530409222251, 2478.603423452248, 2503.3366157968153, 2512.1835403493847, 2517.622356646499, 2440.463098118411, 2443.4746529496156, 2453.509298140379, 2457.336519139831, 2459.446624509489, 2376.738558758535, 2416.320657143286, 2423.8303318767694, 2433.4281443860855, 2434.184548176363, 9090.363674542785, 9128.178463938211, 9140.085991400807, 9179.678711245142, 9180.632774689004, 5146.742662866879, 5245.580353571705, 5253.4221235664045, 5269.235960785703, 5291.523762861361, 3320.5849268841393, 3529.0824385659657, 3541.3448512025357, 3594.514740510024, 3607.6211997740384, 1057.6879820452984, 1084.1976937066593, 1097.7969075721016, 1150.7238262816948, 1167.8014737494561, 13395.06234563581, 13420.731585368336, 13463.865361346458, 13467.191968481824, 13499.25754083525, 4730.479647238801, 4810.11012962596, 4854.951450485521, 4887.8513549315885, 4959.454460009396, 11164.385958772184, 11193.27243729155, 11216.102711783038, 11229.606963756229, 11247.718807029889, 5321.866953326198, 5322.92015619766, 5323.813666521653, 5325.840224793263, 5333.786648534093, 4658.487566367697, 4826.61387089032, 4863.392075990501, 4875.171220892456, 4907.460179380265, 3787.8295476703065, 3859.826307816155, 3896.805159742058, 3903.785291808978, 3944.2111577684577, 1156.5720683347215, 1176.405915012913, 1180.4097951024487, 1189.9107566932341, 1194.2356891589216, 728.4318231779221, 824.5547404401556, 836.0, 847.9236868681849, 857.5112186054014, 5656.318164161741, 5837.766489340379, 5862.560307976919, 5890.322612899571, 5974.312954010257, 413.77035745161726, 415.3561978932642, 425.2494347476706, 437.67393291997666, 449.0, 3857.864974725871, 3985.880423587239, 4005.0, 4020.7386519876113, 4033.0723933494874, 11562.421878906189, 11780.469878855472, 11851.229670071418, 11866.169368144147, 11913.987311078483, 11641.359725215025, 11730.70673233176, 11735.354555499358, 11739.765204696028, 11744.471498782576, 8202.0, 8403.915960840435, 8456.238938495564, 8557.871631925651, 8615.3107751381, 5832.387599302012, 5989.101634754647, 6076.665783381956, 6083.0, 6124.479419249235, 10648.787024259627, 10781.353118812896, 10836.349819010884, 10867.239293249397, 10897.945510272399, 10571.471426428801, 10575.471226438802, 10780.353178809297, 10913.181511386836, 10971.451427428437, 7397.482176247611, 7559.0, 7594.088709354913, 7774.961125194338, 7998.120206777134, 8816.0, 8863.468191908507, 8921.687740929035, 8931.374803763934, 8932.642694292155, 7791.610419479117, 7983.800404989922, 7985.321247694011, 7988.760337189894, 8083.797905052185, 7876.84246315082, 7890.48711833729, 7938.206179382016, 8015.238552337519, 8022.759317220492, 7371.299726525972, 7401.48189626721, 7441.739539116105, 7498.925010749823, 7535.6985720570565, 5187.533122019036, 5263.447338029452, 5271.578273738169, 5410.783568657367, 5437.912417516592, 5322.387925388475, 5325.733713314241, 5329.9467005331, 5400.756965936621, 5478.972605136949], "value": 4641.785402177835, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.9177693242089, 357.52984824955183, 364.75014614988737, 372.7614326830829, 373.57599124993123, 5588.938101760663, 5715.0, 5756.740946657405, 5788.76844926203, 5841.240638716966, 5455.18172274159, 5579.637323573965, 5628.971855140719, 5642.304290689594, 5660.66036037837, 4469.4636643602735, 4471.686981911267, 4472.597466228039, 4477.350784136298, 4482.7758612069265, 4355.259605867011, 4381.4129024649155, 4406.71356361837, 4469.932951005738, 4478.708883922551, 4399.098184872109, 4413.227685155101, 4422.292433210687, 4423.447069116361, 4425.7565833879125, 4404.515503294635, 4408.31671090983, 4445.066536027438, 4452.643788496913, 4467.0, 3749.4750734897134, 3902.434147048662, 3917.157811070605, 3945.3292940200236, 3952.4071389291835, 5635.943640563582, 5647.576431767593, 5662.207290979266, 5673.439804053877, 5677.971610141964, 5062.544371006627, 5138.537531622172, 5162.5095615916425, 5163.7676304566385, 5170.663906846081, 5903.321118071433, 5926.585139040269, 5927.851803704899, 5935.427111815372, 5947.661776100343, 4260.297050986584, 4287.571242875719, 4297.247981603238, 4297.699161058727, 4328.7835608219775, 6086.147939288503, 6212.72042758077, 6274.1843560336865, 6303.873922521524, 6324.525660575475, 4338.652907767371, 4381.496127945327, 4391.012022294958, 4401.317795741666, 4419.381286619876, 4401.603855652943, 4429.490608580055, 4461.955380446154, 4465.816558611906, 4478.41780568524, 4870.220764677634, 5107.668001579886, 5114.590832733373, 5118.3090282811345, 5147.3308469898675, 5684.971575142098, 6020.4280593343565, 6038.33578306386, 6041.0, 6041.758329666764, 1470.5661829760247, 1475.8267177593839, 1531.8851086168581, 1538.7461068923503, 1548.6902619475925, 1003.6587560229557, 1012.1801340913884, 1044.9895501045044, 1071.4374953149659, 1071.6570697376765, 5682.659040457585, 5701.771929122789, 5715.971420142872, 5737.598368114275, 5767.22142510764, 6047.213862197974, 6090.695465226721, 6102.572819902653, 6106.786262480792, 6130.111133885651, 5626.0, 5676.233708449389, 5724.341700704473, 5757.0, 5768.653880767168, 2831.7115712350833, 2832.886684532637, 2845.601615773793, 2852.3297025199063, 2858.671252805954, 5294.205869119663, 5404.000259951921, 5490.780368785284, 5529.152486469471, 5564.415736347706, 5354.839354819362, 5366.543843773245, 5374.715745808094, 5385.118961355656, 5392.703401312887, 5419.485148910847, 5460.672359658433, 5462.3445186577865, 5483.533899618497, 5515.972420137874, 5310.548603368757, 5326.840194794162, 5394.514493695587, 5729.71351432435, 6188.752449901954, 6132.356102609162, 6137.3862613738265, 6184.5052395809125, 6194.659293738888, 6204.3795620437595, 6294.590851594632, 6466.805995820133, 6489.253735820441, 6534.509911756732, 6590.517133644891, 4370.868873933787, 4403.427554418034, 4418.0, 4428.380026796187, 4431.955680443154, 6098.878022439615, 6211.751529938932, 6220.937790622217, 6242.719077641608, 6250.843728906813, 6034.39656034393, 6060.000099983454, 6066.180145956284, 6071.423214794588, 6132.141500190066, 6025.3070896845675, 6036.6679832609625, 6042.425969532887, 6049.334573196857, 6072.603301240828, 5727.312722473163, 5981.581289309706, 5984.551158663031, 5986.725044483069, 6045.365236650088, 6082.5438092142385, 6103.474131467133, 6114.174586430953, 6119.510439164945, 6174.969125154345, 5642.012647786703, 5826.737796799239, 5876.853078673067, 5908.838771257357, 5957.285125784933], "value": 4500.2387849029865, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [671.5634837355718, 672.7947975867364, 674.7098747538558, 699.6571679876859, 732.4433430592748, 15034.924825375872, 15472.845271547281, 15664.216789160553, 15710.0, 16166.595835104128, 16006.0, 16007.83992160078, 16025.599360016005, 16094.517164485054, 16130.274137663804, 681.8840797064486, 688.5730846874919, 688.7933619914006, 688.8450098727797, 690.2131570010192, 674.3189378727496, 690.1373283395756, 695.3290075077549, 701.8070030741561, 703.103542982696, 720.6432815756208, 724.3589423360338, 727.6870945493436, 728.4936968806682, 728.785008422514, 714.2500374606668, 717.8994940708305, 719.1334441997407, 719.5179229915942, 721.7509959064115, 527.209186220669, 530.2391068816222, 530.5993974549191, 532.2654736463694, 532.6857154278955, 13846.30768461583, 13856.168629882239, 13858.930705346509, 13868.514601988882, 13881.930590347085, 13966.371513281927, 14647.780283295759, 14755.26223688822, 14776.926115369462, 14838.554843354717, 12157.270563766202, 12258.632241032783, 12540.623781286577, 12592.244465332109, 13097.47610095595, 4035.9798201009103, 4052.0, 4157.854475093357, 4279.293916503773, 4281.764502952336, 83484.58257708733, 85067.14932850654, 85535.0, 86492.0, 88564.11435885623, 10127.189824813997, 10259.384436933808, 10511.369317840954, 10768.838467422995, 10987.560497580167, 20581.38255852327, 20595.07322170506, 20614.484637884172, 20629.58740825205, 20672.379828605164, 8001.439899207, 8142.837143257102, 8199.590020498952, 8370.204830541088, 8460.365472589581, 4695.389599352063, 4737.360456338419, 4770.928436073462, 4790.089882922233, 4892.168331383673, 3641.672249497558, 3694.094946738013, 3737.7757334560015, 3738.5139931809235, 3752.7373083883867, 651.0559688451764, 653.3825534869503, 657.4313219065474, 677.7322957431787, 725.9600721960343, 596.4095545410013, 677.109600874848, 704.295704295694, 717.7416130193126, 745.530315900979, 8701.17338852808, 9407.0, 9599.232061435068, 9843.852342214872, 9968.850467242997, 585.968695096633, 617.5954749638994, 635.2123367024856, 663.4625952978007, 722.6820199112374, 4067.3898915162963, 4170.207660544487, 4181.519125300569, 4237.6821738369745, 4411.18393097278, 99639.50180249053, 108190.0, 123235.0, 128266.35866820606, 128425.15748425083, 30662.846685766428, 31100.68899310978, 67319.66340168267, 108337.45831270794, 109897.0, 58908.705456472446, 60145.0, 91123.0, 92613.07386926179, 94274.0, 7618.933349330987, 7930.801729956797, 7976.401769867399, 8104.918950810652, 8177.264046235868, 54379.72810135924, 55754.0, 56312.71843640756, 56328.71835640795, 57430.42569574251, 68370.97443538251, 69503.65248173727, 78523.0, 78643.60678196572, 78674.0, 12095.57665481739, 12377.62867113988, 13010.349482525646, 13552.93223533876, 14261.500847470288, 14387.352569134206, 14410.495632653226, 14743.07770925616, 15151.0, 15599.298031588833, 13744.931275343559, 14031.298435078, 14117.929410352883, 14268.21524816145, 14280.785788212977, 14275.714485710436, 15047.247637617857, 15144.0, 15165.696686065996, 15687.137207453243, 13583.0, 14491.710165796414, 14537.491187808799, 14540.927295363455, 14673.339699713326, 10603.91012314109, 10617.256792024484, 11557.24877882935, 11794.115441342105, 12113.69715757113, 10820.4048777318, 10958.890411095786, 12051.156419050581, 12205.20666156697, 12226.816597751218], "value": 7322.107768108227, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1490.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 115.0, 114.0, 112.0, 114.0, 114.0, 114.0, 116.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 123.0, 121.0, 170.0, 119.0, 123.0, 119.0, 121.0, 149.0, 127.0], "value": 131.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 165.0, 164.0, 167.0, 168.0, 163.0, 162.0, 162.0, 163.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 93.0, 75.0, 75.0, 76.0, 75.0, 102.0, 75.0], "value": 79.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 117.0, 83.0, 84.0, 83.0, 100.0, 82.0, 82.0, 104.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 119.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 146.0, 147.0, 147.0, 148.0, 147.0, 148.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 50.0, 51.0, 53.0, 53.0, 55.0, 55.0, 52.0, 52.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 59.0, 60.0, 59.0, 59.0, 60.0, 60.0, 60.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 79.0, 78.0, 78.0, 80.0, 78.0, 78.0, 78.0, 77.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 129.0, 130.0, 123.0, 124.0, 124.0, 134.0, 125.0, 163.0, 122.0], "value": 130.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 174.0, 166.0, 162.0, 163.0, 178.0, 166.0, 167.0, 164.0, 161.0], "value": 166.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 67.0, 64.0, 63.0, 63.0, 63.0, 64.0, 63.0], "value": 63.8, "unit": "score"}]}]} 13:20:39 INFO - Return code: 0 13:20:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:20:39 ERROR - # TBPL SUCCESS # 13:20:39 INFO - Running post-action listener: _resource_record_post_action 13:20:39 INFO - [mozharness: 2016-09-26 20:20:39.866550Z] Finished run-tests step (success) 13:20:39 INFO - Running post-run listener: _resource_record_post_run 13:20:39 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 365473792; Read time: 240; Write time: 233248 13:20:39 INFO - TinderboxPrint: CPU usage
13.4% 13:20:39 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 240 13:20:39 INFO - TinderboxPrint: I/O write bytes / time
365,473,792 / 233,248 13:20:39 INFO - TinderboxPrint: CPU idle
8,226.0 (86.6%) 13:20:39 INFO - TinderboxPrint: CPU user
1,212.1 (12.8%) 13:20:39 INFO - TinderboxPrint: Swap in / out
0 / 0 13:20:39 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 107442176; Read time: 0; Write time: 53528 13:20:39 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 258031616; Read time: 224; Write time: 179720 13:20:40 INFO - Running post-run listener: _upload_blobber_files 13:20:40 INFO - Blob upload gear active. 13:20:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:20:40 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:40 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:40 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:40 INFO - (blobuploader) - INFO - Open directory for files ... 13:20:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:20:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:20:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:20:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:20:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:20:41 INFO - (blobuploader) - INFO - Done attempting. 13:20:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:20:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:20:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:20:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:20:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:20:45 INFO - (blobuploader) - INFO - Done attempting. 13:20:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:20:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:20:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:20:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:20:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:20:45 INFO - (blobuploader) - INFO - Done attempting. 13:20:45 INFO - (blobuploader) - INFO - Iteration through files over. 13:20:45 INFO - Return code: 0 13:20:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:20:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:20:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/1185cba3e5074362aa49c3d89aaad5ab51ea53e2e77900f00cb3d589dc818f68375f3802fd4d6c0adc134549bb9d203742285a17b1942d0581b9f8f1a99618d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/20adb41c60cff1a0ff57a3a592d96b1ba929c6c8ef5ab8c40b14b58ec54ce6a26ff895566ad2837e7d5e2515a3a2a53dd1ccbbf04b8b92595a51f929619592e3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/18696ef4ade3f0351bc69ec67ef44fad9b7a1534e70f17de3fe49f2bd37a69d69a300e5779251df5d6d6dd595504a27bd5bdb51a507e35666f98b31b4697176b"} 13:20:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:20:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:20:45 INFO - Contents: 13:20:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/1185cba3e5074362aa49c3d89aaad5ab51ea53e2e77900f00cb3d589dc818f68375f3802fd4d6c0adc134549bb9d203742285a17b1942d0581b9f8f1a99618d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/20adb41c60cff1a0ff57a3a592d96b1ba929c6c8ef5ab8c40b14b58ec54ce6a26ff895566ad2837e7d5e2515a3a2a53dd1ccbbf04b8b92595a51f929619592e3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/18696ef4ade3f0351bc69ec67ef44fad9b7a1534e70f17de3fe49f2bd37a69d69a300e5779251df5d6d6dd595504a27bd5bdb51a507e35666f98b31b4697176b"} 13:20:45 INFO - Running post-run listener: copy_logs_to_upload_dir 13:20:45 INFO - Copying logs to upload dir... 13:20:45 INFO - mkdir: /builds/slave/test/build/upload/logs 13:20:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.985204 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-09-26 13:20:44.353904) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 13:20:44.357201) ========= 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=826874ccc97bd7bf541b4875000001d5-1474915074.520715-556995881 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/1185cba3e5074362aa49c3d89aaad5ab51ea53e2e77900f00cb3d589dc818f68375f3802fd4d6c0adc134549bb9d203742285a17b1942d0581b9f8f1a99618d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/20adb41c60cff1a0ff57a3a592d96b1ba929c6c8ef5ab8c40b14b58ec54ce6a26ff895566ad2837e7d5e2515a3a2a53dd1ccbbf04b8b92595a51f929619592e3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/18696ef4ade3f0351bc69ec67ef44fad9b7a1534e70f17de3fe49f2bd37a69d69a300e5779251df5d6d6dd595504a27bd5bdb51a507e35666f98b31b4697176b"} 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.011183 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/1185cba3e5074362aa49c3d89aaad5ab51ea53e2e77900f00cb3d589dc818f68375f3802fd4d6c0adc134549bb9d203742285a17b1942d0581b9f8f1a99618d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/20adb41c60cff1a0ff57a3a592d96b1ba929c6c8ef5ab8c40b14b58ec54ce6a26ff895566ad2837e7d5e2515a3a2a53dd1ccbbf04b8b92595a51f929619592e3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/18696ef4ade3f0351bc69ec67ef44fad9b7a1534e70f17de3fe49f2bd37a69d69a300e5779251df5d6d6dd595504a27bd5bdb51a507e35666f98b31b4697176b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 13:20:44.382478) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 13:20:44.382826) ========= 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=826874ccc97bd7bf541b4875000001d5-1474915074.520715-556995881 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 13:20:44.464557) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 13:20:44.464873) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 13:20:44.465154) ========= ========= Total master_lag: 0.15 =========