builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-009 starttime: 1482335759.22 results: success (0) buildid: 20161221061453 builduid: c51e07f878bb468f8d28bff96353b9d0 revision: 3e82bc16778aa475bc537506df9c0ae6c44518da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 07:55:59.223917) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 07:55:59.224363) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 07:55:59.224651) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 07:55:59.269643) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 07:55:59.269926) ========= 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=17051fcd5208b27b50bedfeb000001dd-1482335624.985035-1704448650 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-21 07:55:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.5M=0s 2016-12-21 07:55:59 (34.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.199921 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 07:55:59.522882) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 07:55:59.523199) ========= 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=17051fcd5208b27b50bedfeb000001dd-1482335624.985035-1704448650 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.082965 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 07:55:59.619623) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 07:55:59.619931) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3e82bc16778aa475bc537506df9c0ae6c44518da --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3e82bc16778aa475bc537506df9c0ae6c44518da --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=17051fcd5208b27b50bedfeb000001dd-1482335624.985035-1704448650 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-21 07:55:59,742 truncating revision to first 12 chars 2016-12-21 07:55:59,742 Setting DEBUG logging. 2016-12-21 07:55:59,742 attempt 1/10 2016-12-21 07:55:59,742 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3e82bc16778a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-21 07:56:00,052 unpacking tar archive at: mozilla-aurora-3e82bc16778a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.666384 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 07:56:00.309826) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 07:56:00.310131) ========= script_repo_revision: 3e82bc16778aa475bc537506df9c0ae6c44518da ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 07:56:00.310507) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 07:56:00.310784) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 07:56:00.334683) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-12-21 07:56:00.334979) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=17051fcd5208b27b50bedfeb000001dd-1482335624.985035-1704448650 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:56:00 INFO - MultiFileLogger online at 20161221 07:56:00 in /builds/slave/test 07:56:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:56:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:56:00 INFO - {'append_to_log': False, 07:56:00 INFO - 'base_work_dir': '/builds/slave/test', 07:56:00 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:56:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:56:00 INFO - 'branch': 'Mozilla-Aurora', 07:56:00 INFO - 'buildbot_json_path': 'buildprops.json', 07:56:00 INFO - 'config_files': ('talos/linux_config.py',), 07:56:00 INFO - 'default_actions': ('clobber', 07:56:00 INFO - 'read-buildbot-config', 07:56:00 INFO - 'download-and-extract', 07:56:00 INFO - 'populate-webroot', 07:56:00 INFO - 'create-virtualenv', 07:56:00 INFO - 'install', 07:56:00 INFO - 'run-tests'), 07:56:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:56:00 INFO - 'download_minidump_stackwalk': True, 07:56:00 INFO - 'download_symbols': 'ondemand', 07:56:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:56:00 INFO - 'tooltool.py': '/tools/tooltool.py', 07:56:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:56:00 INFO - '/tools/misc-python/virtualenv.py')}, 07:56:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:56:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:56:00 INFO - 'installer_path': 'installer.exe', 07:56:00 INFO - 'log_level': 'info', 07:56:00 INFO - 'log_name': 'talos', 07:56:00 INFO - 'log_to_console': True, 07:56:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:56:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:56:00 INFO - 'opt_config_files': (), 07:56:00 INFO - 'pip_index': False, 07:56:00 INFO - 'sps_profile': False, 07:56:00 INFO - 'sps_profile_interval': 0, 07:56:00 INFO - 'suite': 'dromaeojs', 07:56:00 INFO - 'system_bits': '32', 07:56:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:56:00 INFO - 'title': 'talos-linux64-ix-009', 07:56:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:56:00 INFO - 'use_talos_json': True, 07:56:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:56:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:56:00 INFO - 'work_dir': 'build'} 07:56:00 INFO - [mozharness: 2016-12-21 15:56:00.664487Z] Running clobber step. 07:56:00 INFO - Running pre-action listener: _resource_record_pre_action 07:56:00 INFO - Running main action method: clobber 07:56:00 INFO - rmtree: /builds/slave/test/build 07:56:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:56:05 INFO - Running post-action listener: _resource_record_post_action 07:56:05 INFO - [mozharness: 2016-12-21 15:56:05.306242Z] Finished clobber step (success) 07:56:05 INFO - [mozharness: 2016-12-21 15:56:05.306355Z] Running read-buildbot-config step. 07:56:05 INFO - Running pre-action listener: _resource_record_pre_action 07:56:05 INFO - Running main action method: read_buildbot_config 07:56:05 INFO - Using buildbot properties: 07:56:05 INFO - { 07:56:05 INFO - "project": "", 07:56:05 INFO - "product": "firefox", 07:56:05 INFO - "script_repo_revision": "production", 07:56:05 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 07:56:05 INFO - "repository": "", 07:56:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 07:56:05 INFO - "buildid": "20161221061453", 07:56:05 INFO - "pgo_build": "True", 07:56:05 INFO - "basedir": "/builds/slave/test", 07:56:05 INFO - "buildnumber": 653, 07:56:05 INFO - "slavename": "talos-linux64-ix-009", 07:56:05 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:56:05 INFO - "platform": "ubuntu64_hw", 07:56:05 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 07:56:05 INFO - "branch": "mozilla-aurora", 07:56:05 INFO - "repo_path": "releases/mozilla-aurora", 07:56:05 INFO - "revision": "3e82bc16778aa475bc537506df9c0ae6c44518da", 07:56:05 INFO - "stage_platform": "linux64-pgo", 07:56:05 INFO - "builduid": "c51e07f878bb468f8d28bff96353b9d0", 07:56:05 INFO - "slavebuilddir": "test" 07:56:05 INFO - } 07:56:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/alJ5DbOnSoWeZ5A4hTVqaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 07:56:05 INFO - Running post-action listener: _resource_record_post_action 07:56:05 INFO - [mozharness: 2016-12-21 15:56:05.309138Z] Finished read-buildbot-config step (success) 07:56:05 INFO - [mozharness: 2016-12-21 15:56:05.309240Z] Running download-and-extract step. 07:56:05 INFO - Running pre-action listener: _resource_record_pre_action 07:56:05 INFO - Running main action method: download_and_extract 07:56:05 INFO - mkdir: /builds/slave/test/build/tests 07:56:05 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')]} 07:56:05 INFO - trying https://queue.taskcluster.net/v1/task/alJ5DbOnSoWeZ5A4hTVqaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 07:56:05 INFO - Downloading https://queue.taskcluster.net/v1/task/alJ5DbOnSoWeZ5A4hTVqaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 07:56:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/alJ5DbOnSoWeZ5A4hTVqaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:56:05 INFO - Downloaded 1361 bytes. 07:56:05 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 07:56:05 INFO - Using the following test package requirements: 07:56:05 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 07:56:05 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:56:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 07:56:05 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:56:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 07:56:05 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:56:05 INFO - u'jsshell-linux-x86_64.zip'], 07:56:05 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:56:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 07:56:05 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 07:56:05 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:56:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 07:56:05 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:56:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 07:56:05 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:56:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 07:56:05 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:56:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 07:56:05 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:56:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/alJ5DbOnSoWeZ5A4hTVqaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 07:56:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/alJ5DbOnSoWeZ5A4hTVqaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:56:05 INFO - Fetch https://queue.taskcluster.net/v1/task/alJ5DbOnSoWeZ5A4hTVqaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 07:56:06 INFO - Http code: 200 07:56:06 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 07:56:06 INFO - x-amz-cf-id: Qqz0U2tGdqAjg8ZyS89SXW8VURbcJfSyn80Y-eWk0NG3f6XFNGPlfQ== 07:56:06 INFO - x-amz-version-id: nbg6txblIR243Ma_R7A4hqe2jJXJ4qYE 07:56:06 INFO - Expected file size: 21939092 07:56:06 INFO - Obtained file size: 21939092 07:56:11 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:56:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/alJ5DbOnSoWeZ5A4hTVqaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 07:56:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/alJ5DbOnSoWeZ5A4hTVqaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:56:11 INFO - Fetch https://queue.taskcluster.net/v1/task/alJ5DbOnSoWeZ5A4hTVqaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 07:56:12 INFO - Http code: 200 07:56:12 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 07:56:12 INFO - x-amz-cf-id: RA3nwZLhm_VAXzaAP8fC5yrbgR29rI7joIJ4Z_br-dgdRDhYdVp9wA== 07:56:12 INFO - x-amz-version-id: nbg6txblIR243Ma_R7A4hqe2jJXJ4qYE 07:56:12 INFO - Expected file size: 21939092 07:56:12 INFO - Obtained file size: 21939092 07:56:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/alJ5DbOnSoWeZ5A4hTVqaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 07:56:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/alJ5DbOnSoWeZ5A4hTVqaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:56:17 INFO - Fetch https://queue.taskcluster.net/v1/task/alJ5DbOnSoWeZ5A4hTVqaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 07:56:17 INFO - Http code: 200 07:56:17 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 07:56:17 INFO - x-amz-cf-id: wVG6a1tzHJpIyUsXpaG3MRKbfWL1m6vfyQc1SrbzG0bzFadP7OR9Qg== 07:56:17 INFO - x-amz-version-id: dgCPQRe7Ua9_cL70EdL.JS7dq.3KyrLO 07:56:18 INFO - Expected file size: 14409038 07:56:18 INFO - Obtained file size: 14409038 07:56:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:18 INFO - trying https://queue.taskcluster.net/v1/task/alJ5DbOnSoWeZ5A4hTVqaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 07:56:18 INFO - Downloading https://queue.taskcluster.net/v1/task/alJ5DbOnSoWeZ5A4hTVqaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 07:56:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/alJ5DbOnSoWeZ5A4hTVqaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:56:20 INFO - Downloaded 63979105 bytes. 07:56:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/alJ5DbOnSoWeZ5A4hTVqaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 07:56:20 INFO - mkdir: /builds/slave/test/properties 07:56:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:56:20 INFO - Writing to file /builds/slave/test/properties/build_url 07:56:20 INFO - Contents: 07:56:20 INFO - build_url:https://queue.taskcluster.net/v1/task/alJ5DbOnSoWeZ5A4hTVqaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 07:56:21 INFO - Running post-action listener: _resource_record_post_action 07:56:21 INFO - Running post-action listener: set_extra_try_arguments 07:56:21 INFO - [mozharness: 2016-12-21 15:56:21.616600Z] Finished download-and-extract step (success) 07:56:21 INFO - [mozharness: 2016-12-21 15:56:21.616829Z] Running populate-webroot step. 07:56:21 INFO - Running pre-action listener: _resource_record_pre_action 07:56:21 INFO - Running main action method: populate_webroot 07:56:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:56:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:56:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:56:21 INFO - '--tppagecycles', 07:56:21 INFO - '7'], 07:56:21 INFO - 'tests': ['tsvgm']}}, 07:56:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:56:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:56:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:56:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:56:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:56:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:56:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:21 INFO - 'talos_options': ['--disable-e10s'], 07:56:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:56:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:56:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:21 INFO - 'talos_options': ['--disable-e10s'], 07:56:21 INFO - 'tests': ['damp', 'tps']}, 07:56:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:21 INFO - 'tests': ['damp', 'tps']}, 07:56:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:56:21 INFO - 'tests': ['dromaeo_dom']}, 07:56:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:56:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:56:21 INFO - 'tests': ['basic_compositor_video']}, 07:56:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:56:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:56:21 INFO - 'tests': ['a11yr', 07:56:21 INFO - 'ts_paint', 07:56:21 INFO - 'tpaint', 07:56:21 INFO - 'sessionrestore', 07:56:21 INFO - 'sessionrestore_no_auto_restore', 07:56:21 INFO - 'tabpaint']}, 07:56:21 INFO - 'other-e10s': {'tests': ['a11yr', 07:56:21 INFO - 'ts_paint', 07:56:21 INFO - 'tpaint', 07:56:21 INFO - 'sessionrestore', 07:56:21 INFO - 'sessionrestore_no_auto_restore', 07:56:21 INFO - 'tabpaint']}, 07:56:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:56:21 INFO - 'ts_paint', 07:56:21 INFO - 'tpaint', 07:56:21 INFO - 'sessionrestore', 07:56:21 INFO - 'sessionrestore_no_auto_restore', 07:56:21 INFO - 'tabpaint']}, 07:56:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:56:21 INFO - 'ts_paint', 07:56:21 INFO - 'tpaint', 07:56:21 INFO - 'sessionrestore', 07:56:21 INFO - 'sessionrestore_no_auto_restore', 07:56:21 INFO - 'tabpaint']}, 07:56:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:56:21 INFO - 'tests': ['a11yr', 07:56:21 INFO - 'ts_paint', 07:56:21 INFO - 'tpaint', 07:56:21 INFO - 'sessionrestore', 07:56:21 INFO - 'sessionrestore_no_auto_restore', 07:56:21 INFO - 'tabpaint']}, 07:56:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:56:21 INFO - 'tests': ['a11yr', 07:56:21 INFO - 'ts_paint', 07:56:21 INFO - 'tpaint', 07:56:21 INFO - 'sessionrestore', 07:56:21 INFO - 'sessionrestore_no_auto_restore', 07:56:21 INFO - 'tabpaint']}, 07:56:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:56:21 INFO - 'tests': ['tsvgx', 07:56:21 INFO - 'tsvgr_opacity', 07:56:21 INFO - 'tart', 07:56:21 INFO - 'tscrollx', 07:56:21 INFO - 'cart']}, 07:56:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:56:21 INFO - 'tsvgr_opacity', 07:56:21 INFO - 'tart', 07:56:21 INFO - 'tscrollx', 07:56:21 INFO - 'cart']}, 07:56:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:21 INFO - 'talos_options': ['--disable-e10s'], 07:56:21 INFO - 'tests': ['tp5o']}, 07:56:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:21 INFO - 'tests': ['tp5o']}, 07:56:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:21 INFO - 'talos_options': ['--disable-e10s', 07:56:21 INFO - '--xperf_path', 07:56:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:56:21 INFO - 'tests': ['tp5n']}, 07:56:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:21 INFO - 'talos_options': ['--xperf_path', 07:56:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:56:21 INFO - 'tests': ['tp5n']}}, 07:56:21 INFO - 'talos.zip': {'path': '', 07:56:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:56:21 INFO - Running post-action listener: _resource_record_post_action 07:56:21 INFO - [mozharness: 2016-12-21 15:56:21.633114Z] Finished populate-webroot step (success) 07:56:21 INFO - [mozharness: 2016-12-21 15:56:21.633202Z] Running create-virtualenv step. 07:56:21 INFO - Running pre-action listener: _resource_record_pre_action 07:56:21 INFO - Running main action method: create_virtualenv 07:56:21 INFO - Creating virtualenv /builds/slave/test/build/venv 07:56:21 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 07:56:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:56:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:56:21 INFO - Using real prefix '/usr' 07:56:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:56:22 INFO - Installing distribute.............................................................................................................................................................................................done. 07:56:24 INFO - Installing pip.................done. 07:56:24 INFO - Return code: 0 07:56:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:56:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:56:24 INFO - Reading from file tmpfile_stdout 07:56:24 INFO - Output received: 07:56:24 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) 07:56:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:56: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')]} 07:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56: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')]} 07:56:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4c8a7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1979ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1976f60>, '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 0x1977d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19781d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1482335624.985035-1704448650', '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 07:56:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:56:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:56:24 INFO - Using env: {'DISPLAY': ':0', 07:56:24 INFO - 'HOME': '/home/cltbld', 07:56:24 INFO - 'LANG': 'en_US.UTF-8', 07:56:24 INFO - 'LANGUAGE': 'en_US:en', 07:56:24 INFO - 'LOGNAME': 'cltbld', 07:56:24 INFO - 'MAIL': '/var/mail/cltbld', 07:56:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:24 INFO - 'MOZ_NO_REMOTE': '1', 07:56:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:24 INFO - 'NO_EM_RESTART': '1', 07:56:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:24 INFO - 'PWD': '/builds/slave/test', 07:56:24 INFO - 'SHELL': '/bin/bash', 07:56:24 INFO - 'SHLVL': '1', 07:56:24 INFO - 'TERM': 'linux', 07:56:24 INFO - 'TMOUT': '86400', 07:56:24 INFO - 'USER': 'cltbld', 07:56:24 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1482335624.985035-1704448650', 07:56:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:24 INFO - '_': '/tools/buildbot/bin/python'} 07:56:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:24 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 07:56:24 INFO - Cleaning up... 07:56:24 INFO - Return code: 0 07:56:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:56: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')]} 07:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56: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')]} 07:56:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff4c8a7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1979ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1976f60>, '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 0x1977d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19781d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1482335624.985035-1704448650', '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 07:56:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:56:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:56:24 INFO - Using env: {'DISPLAY': ':0', 07:56:24 INFO - 'HOME': '/home/cltbld', 07:56:24 INFO - 'LANG': 'en_US.UTF-8', 07:56:24 INFO - 'LANGUAGE': 'en_US:en', 07:56:24 INFO - 'LOGNAME': 'cltbld', 07:56:24 INFO - 'MAIL': '/var/mail/cltbld', 07:56:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:24 INFO - 'MOZ_NO_REMOTE': '1', 07:56:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:24 INFO - 'NO_EM_RESTART': '1', 07:56:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:24 INFO - 'PWD': '/builds/slave/test', 07:56:24 INFO - 'SHELL': '/bin/bash', 07:56:24 INFO - 'SHLVL': '1', 07:56:24 INFO - 'TERM': 'linux', 07:56:24 INFO - 'TMOUT': '86400', 07:56:24 INFO - 'USER': 'cltbld', 07:56:24 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1482335624.985035-1704448650', 07:56:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:24 INFO - '_': '/tools/buildbot/bin/python'} 07:56:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:25 INFO - Downloading/unpacking psutil>=3.1.1 07:56:25 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 07:56:25 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 07:56:25 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 07:56:25 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 07:56:25 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 07:56:25 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 07:56:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:56:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:56:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:56:27 INFO - Installing collected packages: psutil 07:56:27 INFO - Running setup.py install for psutil 07:56:27 INFO - building 'psutil._psutil_linux' extension 07:56:27 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 07:56:28 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 07:56:28 INFO - building 'psutil._psutil_posix' extension 07:56:28 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 07:56:28 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 07:56:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:56:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:56:28 INFO - Successfully installed psutil 07:56:28 INFO - Cleaning up... 07:56:28 INFO - Return code: 0 07:56:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:56: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')]} 07:56:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56: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')]} 07:56:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4c8a7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1979ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1976f60>, '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 0x1977d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19781d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1482335624.985035-1704448650', '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 07:56: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:56: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 mozsystemmonitor==0.3 07:56:28 INFO - Using env: {'DISPLAY': ':0', 07:56:28 INFO - 'HOME': '/home/cltbld', 07:56:28 INFO - 'LANG': 'en_US.UTF-8', 07:56:28 INFO - 'LANGUAGE': 'en_US:en', 07:56:28 INFO - 'LOGNAME': 'cltbld', 07:56:28 INFO - 'MAIL': '/var/mail/cltbld', 07:56:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:28 INFO - 'MOZ_NO_REMOTE': '1', 07:56:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:28 INFO - 'NO_EM_RESTART': '1', 07:56:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:28 INFO - 'PWD': '/builds/slave/test', 07:56:28 INFO - 'SHELL': '/bin/bash', 07:56:28 INFO - 'SHLVL': '1', 07:56:28 INFO - 'TERM': 'linux', 07:56:28 INFO - 'TMOUT': '86400', 07:56:28 INFO - 'USER': 'cltbld', 07:56:28 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1482335624.985035-1704448650', 07:56:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:28 INFO - '_': '/tools/buildbot/bin/python'} 07:56:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:56:28 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 07:56:28 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 07:56:28 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 07:56:28 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 07:56:28 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 07:56:28 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 07:56:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:56:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:56:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:56:31 INFO - Installing collected packages: mozsystemmonitor 07:56:31 INFO - Running setup.py install for mozsystemmonitor 07:56:31 INFO - Successfully installed mozsystemmonitor 07:56:31 INFO - Cleaning up... 07:56:31 INFO - Return code: 0 07:56:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:56: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')]} 07:56:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56: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')]} 07:56:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56: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', '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 0x7ff4c8a7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1979ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1976f60>, '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 0x1977d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19781d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1482335624.985035-1704448650', '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 07:56: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:56: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 jsonschema==2.5.1 07:56:31 INFO - Using env: {'DISPLAY': ':0', 07:56:31 INFO - 'HOME': '/home/cltbld', 07:56:31 INFO - 'LANG': 'en_US.UTF-8', 07:56:31 INFO - 'LANGUAGE': 'en_US:en', 07:56:31 INFO - 'LOGNAME': 'cltbld', 07:56:31 INFO - 'MAIL': '/var/mail/cltbld', 07:56:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:31 INFO - 'MOZ_NO_REMOTE': '1', 07:56:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:31 INFO - 'NO_EM_RESTART': '1', 07:56:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:31 INFO - 'PWD': '/builds/slave/test', 07:56:31 INFO - 'SHELL': '/bin/bash', 07:56:31 INFO - 'SHLVL': '1', 07:56:31 INFO - 'TERM': 'linux', 07:56:31 INFO - 'TMOUT': '86400', 07:56:31 INFO - 'USER': 'cltbld', 07:56:31 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1482335624.985035-1704448650', 07:56:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:31 INFO - '_': '/tools/buildbot/bin/python'} 07:56:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:31 INFO - Downloading/unpacking jsonschema==2.5.1 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:56:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:56:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:33 INFO - Downloading functools32-3.2.3-2.tar.gz 07:56:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:56:33 INFO - warning: no files found matching '*.txt' 07:56:33 INFO - no previously-included directories found matching 'build' 07:56:33 INFO - no previously-included directories found matching 'dist' 07:56:33 INFO - no previously-included directories found matching '.git*' 07:56:33 INFO - Installing collected packages: jsonschema, functools32 07:56:33 INFO - Running setup.py install for functools32 07:56:33 INFO - warning: no files found matching '*.txt' 07:56:33 INFO - no previously-included directories found matching 'build' 07:56:33 INFO - no previously-included directories found matching 'dist' 07:56:33 INFO - no previously-included directories found matching '.git*' 07:56:33 INFO - Successfully installed jsonschema functools32 07:56:33 INFO - Cleaning up... 07:56:33 INFO - Return code: 0 07:56:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:56:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff4c8a7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1979ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1976f60>, '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 0x1977d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19781d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1482335624.985035-1704448650', '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 07:56:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:56:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:56:33 INFO - Using env: {'DISPLAY': ':0', 07:56:33 INFO - 'HOME': '/home/cltbld', 07:56:33 INFO - 'LANG': 'en_US.UTF-8', 07:56:33 INFO - 'LANGUAGE': 'en_US:en', 07:56:33 INFO - 'LOGNAME': 'cltbld', 07:56:33 INFO - 'MAIL': '/var/mail/cltbld', 07:56:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:33 INFO - 'MOZ_NO_REMOTE': '1', 07:56:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:33 INFO - 'NO_EM_RESTART': '1', 07:56:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:33 INFO - 'PWD': '/builds/slave/test', 07:56:33 INFO - 'SHELL': '/bin/bash', 07:56:33 INFO - 'SHLVL': '1', 07:56:33 INFO - 'TERM': 'linux', 07:56:33 INFO - 'TMOUT': '86400', 07:56:33 INFO - 'USER': 'cltbld', 07:56:33 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1482335624.985035-1704448650', 07:56:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:33 INFO - '_': '/tools/buildbot/bin/python'} 07:56:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:56:34 INFO - Cleaning up... 07:56:34 INFO - Return code: 0 07:56:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:56: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')]} 07:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56: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')]} 07:56:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56: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', '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 0x7ff4c8a7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1979ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1976f60>, '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 0x1977d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19781d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1482335624.985035-1704448650', '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 07:56: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:56: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 blobuploader==1.2.4 07:56:34 INFO - Using env: {'DISPLAY': ':0', 07:56:34 INFO - 'HOME': '/home/cltbld', 07:56:34 INFO - 'LANG': 'en_US.UTF-8', 07:56:34 INFO - 'LANGUAGE': 'en_US:en', 07:56:34 INFO - 'LOGNAME': 'cltbld', 07:56:34 INFO - 'MAIL': '/var/mail/cltbld', 07:56:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:34 INFO - 'MOZ_NO_REMOTE': '1', 07:56:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:34 INFO - 'NO_EM_RESTART': '1', 07:56:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:34 INFO - 'PWD': '/builds/slave/test', 07:56:34 INFO - 'SHELL': '/bin/bash', 07:56:34 INFO - 'SHLVL': '1', 07:56:34 INFO - 'TERM': 'linux', 07:56:34 INFO - 'TMOUT': '86400', 07:56:34 INFO - 'USER': 'cltbld', 07:56:34 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1482335624.985035-1704448650', 07:56:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:34 INFO - '_': '/tools/buildbot/bin/python'} 07:56:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:34 INFO - Downloading/unpacking blobuploader==1.2.4 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56:36 INFO - Downloading blobuploader-1.2.4.tar.gz 07:56:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:56:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:56:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56:37 INFO - Downloading docopt-0.6.1.tar.gz 07:56:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:56:37 INFO - Installing collected packages: blobuploader, requests, docopt 07:56:37 INFO - Running setup.py install for blobuploader 07:56:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:56:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:56:37 INFO - Running setup.py install for requests 07:56:37 INFO - Running setup.py install for docopt 07:56:37 INFO - Successfully installed blobuploader requests docopt 07:56:37 INFO - Cleaning up... 07:56:37 INFO - Return code: 0 07:56:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:56: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')]} 07:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56: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')]} 07:56:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:37 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 0x7ff4c8a7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1979ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1976f60>, '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 0x1977d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19781d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1482335624.985035-1704448650', '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 07:56:37 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 07:56:37 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 07:56:37 INFO - Using env: {'DISPLAY': ':0', 07:56:37 INFO - 'HOME': '/home/cltbld', 07:56:37 INFO - 'LANG': 'en_US.UTF-8', 07:56:37 INFO - 'LANGUAGE': 'en_US:en', 07:56:37 INFO - 'LOGNAME': 'cltbld', 07:56:37 INFO - 'MAIL': '/var/mail/cltbld', 07:56:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:37 INFO - 'MOZ_NO_REMOTE': '1', 07:56:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:37 INFO - 'NO_EM_RESTART': '1', 07:56:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:37 INFO - 'PWD': '/builds/slave/test', 07:56:37 INFO - 'SHELL': '/bin/bash', 07:56:37 INFO - 'SHLVL': '1', 07:56:37 INFO - 'TERM': 'linux', 07:56:37 INFO - 'TMOUT': '86400', 07:56:37 INFO - 'USER': 'cltbld', 07:56:37 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1482335624.985035-1704448650', 07:56:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:37 INFO - '_': '/tools/buildbot/bin/python'} 07:56:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:56:37 INFO - Running setup.py (path:/tmp/pip-PVWskW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:56:38 INFO - Running setup.py (path:/tmp/pip-8qn0pH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:56:38 INFO - Running setup.py (path:/tmp/pip-0wUL_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:56:38 INFO - Running setup.py (path:/tmp/pip-vMiMiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:56:38 INFO - Running setup.py (path:/tmp/pip-kjFnKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:56:38 INFO - Running setup.py (path:/tmp/pip-3Whl6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:56:38 INFO - Running setup.py (path:/tmp/pip-aRhNT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:56:38 INFO - Running setup.py (path:/tmp/pip-ZYXZO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:56:38 INFO - Running setup.py (path:/tmp/pip-JaS2Kf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:56:38 INFO - Running setup.py (path:/tmp/pip-f_zfg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:56:38 INFO - Running setup.py (path:/tmp/pip-hcdsqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:56:38 INFO - Running setup.py (path:/tmp/pip-G8zihM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:56:38 INFO - Running setup.py (path:/tmp/pip-2kYwMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:56:38 INFO - Running setup.py (path:/tmp/pip-5C_kjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:56:39 INFO - Running setup.py (path:/tmp/pip-v4rb5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:56:39 INFO - Running setup.py (path:/tmp/pip-X_Diqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:56:39 INFO - Running setup.py (path:/tmp/pip-lXqCxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:56:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:56:39 INFO - Running setup.py install for manifestparser 07:56:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:56:39 INFO - Running setup.py install for mozcrash 07:56:39 INFO - Running setup.py install for mozdebug 07:56:39 INFO - Running setup.py install for mozdevice 07:56:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:56:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:56:39 INFO - Running setup.py install for mozfile 07:56:39 INFO - Running setup.py install for mozhttpd 07:56:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:56:39 INFO - Running setup.py install for mozinfo 07:56:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:56:39 INFO - Running setup.py install for mozInstall 07:56:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:56:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:56:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:56:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:56:40 INFO - Running setup.py install for mozleak 07:56:40 INFO - Running setup.py install for mozlog 07:56:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:56:40 INFO - Running setup.py install for moznetwork 07:56:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:56:40 INFO - Running setup.py install for mozprocess 07:56:40 INFO - Running setup.py install for mozprofile 07:56:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:56:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:56:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:56:40 INFO - Running setup.py install for mozrunner 07:56:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:56:40 INFO - Running setup.py install for mozscreenshot 07:56:40 INFO - Running setup.py install for moztest 07:56:40 INFO - Running setup.py install for mozversion 07:56:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:56:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:56:41 INFO - Cleaning up... 07:56:41 INFO - Return code: 0 07:56:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:56:41 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')]} 07:56:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:41 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')]} 07:56:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:41 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 0x7ff4c8a7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1979ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1976f60>, '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 0x1977d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19781d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1482335624.985035-1704448650', '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 07:56:41 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 07:56:41 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 07:56:41 INFO - Using env: {'DISPLAY': ':0', 07:56:41 INFO - 'HOME': '/home/cltbld', 07:56:41 INFO - 'LANG': 'en_US.UTF-8', 07:56:41 INFO - 'LANGUAGE': 'en_US:en', 07:56:41 INFO - 'LOGNAME': 'cltbld', 07:56:41 INFO - 'MAIL': '/var/mail/cltbld', 07:56:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:41 INFO - 'MOZ_NO_REMOTE': '1', 07:56:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:41 INFO - 'NO_EM_RESTART': '1', 07:56:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:41 INFO - 'PWD': '/builds/slave/test', 07:56:41 INFO - 'SHELL': '/bin/bash', 07:56:41 INFO - 'SHLVL': '1', 07:56:41 INFO - 'TERM': 'linux', 07:56:41 INFO - 'TMOUT': '86400', 07:56:41 INFO - 'USER': 'cltbld', 07:56:41 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1482335624.985035-1704448650', 07:56:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:41 INFO - '_': '/tools/buildbot/bin/python'} 07:56:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:56:41 INFO - Running setup.py (path:/tmp/pip-xkGPYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:56:41 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)) 07:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:56:41 INFO - Running setup.py (path:/tmp/pip-ftZeEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:56:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:56:41 INFO - Running setup.py (path:/tmp/pip-9E0v4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:56:41 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)) 07:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:56:41 INFO - Running setup.py (path:/tmp/pip-yZDncL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:56:41 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)) 07:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:56:41 INFO - Running setup.py (path:/tmp/pip-iIXFSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:56:41 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)) 07:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:56:41 INFO - Running setup.py (path:/tmp/pip-a42uQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:56:41 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)) 07:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:56:41 INFO - Running setup.py (path:/tmp/pip-fAJdko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:56:41 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)) 07:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:56:41 INFO - Running setup.py (path:/tmp/pip-EA7yom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:56:41 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)) 07:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:56:41 INFO - Running setup.py (path:/tmp/pip-2SCLH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:56:41 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)) 07:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:56:41 INFO - Running setup.py (path:/tmp/pip-SUsufr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:56:41 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)) 07:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:56:41 INFO - Running setup.py (path:/tmp/pip-HstGG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:56:42 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)) 07:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:56:42 INFO - Running setup.py (path:/tmp/pip-0XN6kU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:56:42 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)) 07:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:56:42 INFO - Running setup.py (path:/tmp/pip-0q8iGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:56:42 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)) 07:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:56:42 INFO - Running setup.py (path:/tmp/pip-Y8hgtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:56:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:56:42 INFO - Running setup.py (path:/tmp/pip-lrF_ZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:56:42 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)) 07:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:56:42 INFO - Running setup.py (path:/tmp/pip-DbYe4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:56:42 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)) 07:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:56:42 INFO - Running setup.py (path:/tmp/pip-aNviC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:56:42 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)) 07:56:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:56:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:56:42 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)) 07:56:42 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)) 07:56:42 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)) 07:56:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:56:42 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 07:56:42 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 07:56:42 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 07:56:42 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 07:56:42 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 07:56:42 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 07:56:44 INFO - Downloading blessings-1.6.tar.gz 07:56:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:56:44 INFO - Installing collected packages: blessings 07:56:44 INFO - Running setup.py install for blessings 07:56:44 INFO - Successfully installed blessings 07:56:44 INFO - Cleaning up... 07:56:44 INFO - Return code: 0 07:56:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:56:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:56:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:56:45 INFO - Reading from file tmpfile_stdout 07:56:45 INFO - Current package versions: 07:56:45 INFO - argparse == 1.2.1 07:56:45 INFO - blessings == 1.6 07:56:45 INFO - blobuploader == 1.2.4 07:56:45 INFO - docopt == 0.6.1 07:56:45 INFO - functools32 == 3.2.3-2 07:56:45 INFO - jsonschema == 2.5.1 07:56:45 INFO - manifestparser == 1.1 07:56:45 INFO - mozInstall == 1.12 07:56:45 INFO - mozcrash == 1.0 07:56:45 INFO - mozdebug == 0.1 07:56:45 INFO - mozdevice == 0.48 07:56:45 INFO - mozfile == 1.2 07:56:45 INFO - mozhttpd == 0.7 07:56:45 INFO - mozinfo == 0.9 07:56:45 INFO - mozleak == 0.1 07:56:45 INFO - mozlog == 3.4 07:56:45 INFO - moznetwork == 0.27 07:56:45 INFO - mozprocess == 0.23 07:56:45 INFO - mozprofile == 0.28 07:56:45 INFO - mozrunner == 6.13 07:56:45 INFO - mozscreenshot == 0.1 07:56:45 INFO - mozsystemmonitor == 0.3 07:56:45 INFO - moztest == 0.7 07:56:45 INFO - mozversion == 1.4 07:56:45 INFO - psutil == 3.1.1 07:56:45 INFO - requests == 1.2.3 07:56:45 INFO - wsgiref == 0.1.2 07:56:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:56:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:45 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 0x7ff4c8a7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1979ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1976f60>, '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 0x1977d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19781d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1482335624.985035-1704448650', '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 07:56:45 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 07:56:45 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 07:56:45 INFO - Using env: {'DISPLAY': ':0', 07:56:45 INFO - 'HOME': '/home/cltbld', 07:56:45 INFO - 'LANG': 'en_US.UTF-8', 07:56:45 INFO - 'LANGUAGE': 'en_US:en', 07:56:45 INFO - 'LOGNAME': 'cltbld', 07:56:45 INFO - 'MAIL': '/var/mail/cltbld', 07:56:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:45 INFO - 'MOZ_NO_REMOTE': '1', 07:56:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:45 INFO - 'NO_EM_RESTART': '1', 07:56:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:45 INFO - 'PWD': '/builds/slave/test', 07:56:45 INFO - 'SHELL': '/bin/bash', 07:56:45 INFO - 'SHLVL': '1', 07:56:45 INFO - 'TERM': 'linux', 07:56:45 INFO - 'TMOUT': '86400', 07:56:45 INFO - 'USER': 'cltbld', 07:56:45 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1482335624.985035-1704448650', 07:56:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:45 INFO - '_': '/tools/buildbot/bin/python'} 07:56:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:45 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)) 07:56:45 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)) 07:56:45 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)) 07:56:45 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)) 07:56:45 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)) 07:56:45 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)) 07:56:45 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)) 07:56:45 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)) 07:56:45 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)) 07:56:45 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)) 07:56:45 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)) 07:56:45 INFO - Cleaning up... 07:56:45 INFO - Return code: 0 07:56:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:56:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4c8a7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1979ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1976f60>, '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 0x1977d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19781d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1482335624.985035-1704448650', '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 07:56:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:56:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:56:45 INFO - Using env: {'DISPLAY': ':0', 07:56:45 INFO - 'HOME': '/home/cltbld', 07:56:45 INFO - 'LANG': 'en_US.UTF-8', 07:56:45 INFO - 'LANGUAGE': 'en_US:en', 07:56:45 INFO - 'LOGNAME': 'cltbld', 07:56:45 INFO - 'MAIL': '/var/mail/cltbld', 07:56:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:45 INFO - 'MOZ_NO_REMOTE': '1', 07:56:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:45 INFO - 'NO_EM_RESTART': '1', 07:56:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:45 INFO - 'PWD': '/builds/slave/test', 07:56:45 INFO - 'SHELL': '/bin/bash', 07:56:45 INFO - 'SHLVL': '1', 07:56:45 INFO - 'TERM': 'linux', 07:56:45 INFO - 'TMOUT': '86400', 07:56:45 INFO - 'USER': 'cltbld', 07:56:45 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1482335624.985035-1704448650', 07:56:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:45 INFO - '_': '/tools/buildbot/bin/python'} 07:56:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:56:45 INFO - Cleaning up... 07:56:45 INFO - Return code: 0 07:56:45 INFO - Running post-action listener: _resource_record_post_action 07:56:45 INFO - Running post-action listener: _start_resource_monitoring 07:56:45 INFO - Starting resource monitoring. 07:56:45 INFO - [mozharness: 2016-12-21 15:56:45.540151Z] Finished create-virtualenv step (success) 07:56:45 INFO - [mozharness: 2016-12-21 15:56:45.541048Z] Running install step. 07:56:45 INFO - Running pre-action listener: _resource_record_pre_action 07:56:45 INFO - Running main action method: install 07:56:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:56:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:56:45 INFO - Reading from file tmpfile_stdout 07:56:45 INFO - Detecting whether we're running mozinstall >=1.0... 07:56:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:56:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:56:45 INFO - Reading from file tmpfile_stdout 07:56:45 INFO - Output received: 07:56:45 INFO - Usage: mozinstall [options] installer 07:56:45 INFO - Options: 07:56:45 INFO - -h, --help show this help message and exit 07:56:45 INFO - -d DEST, --destination=DEST 07:56:45 INFO - Directory to install application into. [default: 07:56:45 INFO - "/builds/slave/test"] 07:56:45 INFO - --app=APP Application being installed. [default: firefox] 07:56:45 INFO - mkdir: /builds/slave/test/build/application 07:56:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:56:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:57:01 INFO - Reading from file tmpfile_stdout 07:57:01 INFO - Output received: 07:57:01 INFO - /builds/slave/test/build/application/firefox/firefox 07:57:01 INFO - Running post-action listener: _resource_record_post_action 07:57:01 INFO - [mozharness: 2016-12-21 15:57:01.757103Z] Finished install step (success) 07:57:01 INFO - [mozharness: 2016-12-21 15:57:01.757347Z] Running run-tests step. 07:57:01 INFO - Running pre-action listener: _resource_record_pre_action 07:57:01 INFO - Running main action method: run_tests 07:57:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:57:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:57:01 INFO - Python 2.7.3 07:57:01 INFO - Return code: 0 07:57:01 INFO - grabbing minidump binary from tooltool 07:57:01 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')]} 07:57:01 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 0x1976f60>, '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 0x1977d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19781d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:57:01 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 07:57:01 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 07:57:01 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 07:57:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:57:02 INFO - Return code: 0 07:57:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:57:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:57:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:57:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:57:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:57:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/alJ5DbOnSoWeZ5A4hTVqaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:57:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/alJ5DbOnSoWeZ5A4hTVqaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:57:02 INFO - Using env: {'DISPLAY': ':0', 07:57:02 INFO - 'HOME': '/home/cltbld', 07:57:02 INFO - 'LANG': 'en_US.UTF-8', 07:57:02 INFO - 'LANGUAGE': 'en_US:en', 07:57:02 INFO - 'LOGNAME': 'cltbld', 07:57:02 INFO - 'MAIL': '/var/mail/cltbld', 07:57:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:57:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:02 INFO - 'MOZ_NO_REMOTE': '1', 07:57:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:57:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:57:02 INFO - 'NO_EM_RESTART': '1', 07:57:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:02 INFO - 'PWD': '/builds/slave/test', 07:57:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:57:02 INFO - 'SHELL': '/bin/bash', 07:57:02 INFO - 'SHLVL': '1', 07:57:02 INFO - 'TERM': 'linux', 07:57:02 INFO - 'TMOUT': '86400', 07:57:02 INFO - 'USER': 'cltbld', 07:57:02 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1482335624.985035-1704448650', 07:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:02 INFO - '_': '/tools/buildbot/bin/python'} 07:57:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/alJ5DbOnSoWeZ5A4hTVqaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:57:02 INFO - mozversion application_buildid: 20161221061453 07:57:02 INFO - mozversion application_changeset: 3e82bc16778aa475bc537506df9c0ae6c44518da 07:57:02 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:57:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:57:02 INFO - mozversion application_name: Firefox 07:57:02 INFO - mozversion application_remotingname: firefox-dev 07:57:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:57:02 INFO - mozversion application_vendor: Mozilla 07:57:02 INFO - mozversion application_version: 52.0a2 07:57:02 INFO - mozversion platform_buildid: 20161221061453 07:57:02 INFO - mozversion platform_changeset: 3e82bc16778aa475bc537506df9c0ae6c44518da 07:57:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:57:02 INFO - mozversion platform_version: 52.0a2 07:57:02 INFO - using testdate: 1482335822 07:57:02 INFO - actual date: 1482335822 07:57:02 INFO - starting webserver on 'localhost:42986' 07:57:02 INFO - SUITE-START | Running 2 tests 07:57:02 INFO - TEST-START | dromaeo_css 07:57:02 INFO - operating with platform_type : linux_ 07:57:02 INFO - Initialising browser for dromaeo_css test... 07:57:02 INFO - TEST-INFO | started process 3281 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj8v2rZ/profile http://localhost:42986/getInfo.html) 07:57:08 INFO - PROCESS | 3281 | __metrics Screen width/height:1600/1200 07:57:08 INFO - PROCESS | 3281 | colorDepth:24 07:57:08 INFO - PROCESS | 3281 | Browser inner width/height: 1024/697 07:57:08 INFO - PROCESS | 3281 | __metrics 07:57:09 INFO - PROCESS | 3281 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:57:09 INFO - PROCESS | 3281 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:57:09 INFO - PROCESS | 3281 | console.error: PushService: 07:57:09 INFO - PROCESS | 3281 | stateChangeProcessEnqueue: Error transitioning state 07:57:09 INFO - PROCESS | 3281 | UnknownError 07:57:10 INFO - TEST-INFO | 3281: exit 0 07:57:10 INFO - Browser initialized. 07:57:10 INFO - Running cycle 1/1 for dromaeo_css test... 07:57:10 INFO - TEST-INFO | started process 3372 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj8v2rZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:57:22 INFO - PROCESS | 3372 | RSS: Main: 144379904 07:57:22 INFO - PROCESS | 3372 | 07:58:13 INFO - PROCESS | 3372 | 1482335893534 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] 08:00:24 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:42986/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42986/tests/dromaeo/cssquery-ext.html) 08:00:25 INFO - PROCESS | 3372 | RSS: Main: 252137472 08:00:25 INFO - PROCESS | 3372 | 08:03:27 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:42986/tests/dromaeo/cssquery-ext.html (next: http://localhost:42986/tests/dromaeo/cssquery-jquery.html) 08:03:28 INFO - PROCESS | 3372 | RSS: Main: 229797888 08:03:28 INFO - PROCESS | 3372 | 08:06:30 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:42986/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42986/tests/dromaeo/cssquery-mootools.html) 08:06:31 INFO - PROCESS | 3372 | RSS: Main: 219660288 08:06:31 INFO - PROCESS | 3372 | 08:09:33 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:42986/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42986/tests/dromaeo/cssquery-prototype.html) 08:09:33 INFO - PROCESS | 3372 | RSS: Main: 217956352 08:09:33 INFO - PROCESS | 3372 | 08:12:36 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:42986/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42986/tests/dromaeo/cssquery-yui.html) 08:12:36 INFO - PROCESS | 3372 | RSS: Main: 172388352 08:12:36 INFO - PROCESS | 3372 | 08:15:39 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:42986/tests/dromaeo/cssquery-yui.html (next: http://localhost:42986/tests/dromaeo/cssquery-dojo.html) 08:15:39 INFO - PROCESS | 3372 | RSS: Main: 263630848 08:15:39 INFO - PROCESS | 3372 | 08:15:39 INFO - PROCESS | 3372 | __start_tp_report 08:15:39 INFO - PROCESS | 3372 | _x_x_mozilla_page_load 08:15:39 INFO - PROCESS | 3372 | _x_x_mozilla_page_load_details 08:15:39 INFO - PROCESS | 3372 | |i|pagename|runs| 08:15:39 INFO - PROCESS | 3372 | |0;dojo.html;3251.05719341391;3277.5411442398054;3281.458559337709;3291.8683252669894;3308.2556424804407;5461.017016936949;5522.254495643087;5540.806071787489;5546.362168350646;5547.805826796063;5590.86022849428;5633.324001119871;5635.239242702234;5638.859028524289;5682.403347648489;5110.412302585213;5130.9994551062555;5158.432572417031;5199.584033277348;5215.087359712054;5038.470960549144;5056.165732654126;5056.898862022757;5184.066867963765;5242.68543887368;5111.718855462948;5175;5188.6367954243215;5210.16637338026;5214.895702085956;5197.688138711689;5208.661437006583;5214.478552144774;5217.869553261161;5231.8168864089575;4990.176620857555;5004.574611158056;5045.091883460976;5093.643444958854;5095.439501654815;5482.972585137089;5483.7806487740445;5486.478784515464;5490.286262785852;5574.804881829116;5960.374160713106;6008.068749343859;6014;6015.398460153993;6016.488598469092;5896.734646940898;5972;6016.669083200466;6058.39416058395;6065.332813390523;5518;5558.805441809558;5563.443655634404;5574.1081426972305;5619.157126430986;6117.510599152057;6120.816375508742;6121.204243448412;6122.204113465221;6126.969365153146;5810.854728631818;5826;5885.646861188342;5891.116332550066;5900.940990590039;5916.556258280646;5936.168936348915;5952.136940143655;6020.157177995085;6053.788117415869;5959.493443057302;5969.671668058299;5977.163197152402;5987.042073268256;6026.849328766816;5874.060150375919;5953.493953014043;5998.130271110752;6005.759769609254;6007.849803754941;4568.360429539867;4577.61090307321;4586.954130458719;4600.930986035212;4638.721676699409;4108.609682080198;4125.422440858282;4133.524644665902;4137.482814648169;4156;5794.0439827428;5810.041343178328;5816.458638460811;5818.709064546756;5856.00447923854;5801.738921748447;5836.737346819404;5849.561282903799;5860.853478663067;5868.2077919480325;5652.3217213934595;5674.801381951612;5677.148427735872;5680.375158732536;5689.544836413077;5020.3724534433195;5031.245313203049;5032.672876263105;5037.773300201499;5074;6077.4226448487325;6172.043333283348;6179.721912513858;6198.380161983766;6212.223472065992;6082.452579267887;6084.209052823105;6086.2087928569;6092.329843717276;6120.17377654011;6312.873742525216;6336.746530138743;6341.112244285711;6346.777862774781;6366.045093236052;5732.942670573241;5763.6541807491685;5917.023691090922;6009.519238461;6010.759569617167;6029.095635654687;6121.666376154749;6135.293912123195;6137.223770008752;6137.346341658241;5920.911186332295;5991.880162396815;5995.580309378476;5996.190514280516;5998.040313549811;5632.5775566831835;5732.05421105513;5934.7922822701;5952.196453478725;5957.404259574181;5784.5083167929515;5826.096954971986;5831.979403604268;5881.882362352814;5931.940680593311;5962.940370596239;5976.671283079472;5993.670348130895;6006.039033754579;6007.669578173068;5524.613277070566;5626.2685850839125;5630.408807075362;5642.5485961122195;5806.129080637938 08:15:39 INFO - PROCESS | 3372 | |1;ext.html;588.5732843688327;606.7360698096328;645.9838504037399;663.8141320430282;669.8593295407964;34428.13929651757;45542.77228613861;46597.7670111649;46598.53401465985;46662;46292;46872;46932.765336173354;46956.76521617387;46973;8264.132266112061;8812.1187881212;8936.55317234139;8950.104989501064;8957.507337096456;8192.631331590062;8461.111583283759;8463.703770368038;10490.31812932157;10761.08530774885;10847.294925829836;10906.727331816688;10909.23635345526;10909.618163364285;10918.50866710996;10441.634542791004;10462.843057354146;10481.213908956859;10481.842772358421;10483.58065677372;10300.381977081399;10355.068043876012;10370.222233332455;10370.37777733331;10384.376937383706;44088.338674919905;44337.77831110824;44364.77817610891;44451.55548444507;44472.33291500598;3822.5582810458122;3977.3835055566433;4344.674149438804;4358.455193100863;4447.888802779924;32993.175170620685;33368;33738.66261337404;34140.48789268163;34320.82839585786;4322.848700295506;4606.838760643395;4622.422197225347;4626.699264547794;4747.83382581608;353865;355860;357824;357898;358698;63399;63652.36347636464;63764;63793.68103159455;63846.36153638497;39260.21479570393;40321.798391007855;40506.77212753268;42275.57724422778;68578.31421685818;19487.415377538695;19717.50706232327;19724.605507889763;19728.11223494946;19734.111964961612;13513.378394592712;14926.029808062442;15061.774073388908;15066.849331506764;15076.24618769057;18837.434876953714;19760.11079501397;20569.177232910515;21254.25610103639;21304;7455.888161677579;7466.626668666545;7602.315791578784;7607.467477276648;7742.8838567421535;976.6142373762324;987.916027137687;1132.1055568843153;1167.550493060161;1179.8496465945634;32653.836730816194;33057.66942330594;33102.3379532408;33227.83386083054;33324.66675333216;1176.129664048598;1182.515168780813;1198.1193822540426;1199.7960346741074;1209.1958847366402;17322.740158897628;17604.207810648553;17631.911840440716;17666.381676641256;17715.29138834458;530281;532598;534609;535334;535640;61512.69243653753;62060.379396206365;62157.689211553654;62177.68911155415;62228;1305.7062161013696;1331.740310639416;1389.638693939583;1434.956951291463;1439.4889814115838;30570.847145764128;34550.654493455746;35088.12279693028;35174.29651407008;35183.64816351906;52482;52935.470645293055;52959;53042.73478632582;53064.204036940246;413088;417351.392701254;418014;418084;418415;30282.54576181403;30769.230769230948;32097.518537222426;32370.352592947536;32667;49523.752381237864;49643;49647.751761240965;50659;50731.49268507268;36738.26523469462;36927.261454771295;36965.26069478649;36972.815135924146;37691.43462848114;41620.79189604154;41702;41996.16007679891;42244.36633450439;43675.56324436842;41997.580024200586;42393.44540245653;42569;43061;43160;35906.64093359033;38160.80919595384;38253.80873095617;38583.80708096441;39173.2165356697;29001.32571793078;29130;29148.562771558867;29288.70711292945;29400.26499337534 08:15:39 INFO - PROCESS | 3372 | |2;jquery.html;390.70306567009067;431.01104712947637;432.48318259679684;440.7047278323523;444.0563801920916;17264.309427622895;19785.40643780689;20452.795472045313;20502.6924596131;20503.38489845307;19854.801451985477;20088.196472141135;20098.89950550249;20116;20273.797262027376;5742.224799652056;5777.104548794933;5862.325832529271;5901.881962360751;5907.232059832216;5806.651600903938;5883.676397798119;5890.823275301748;5891.145783861338;5897.056470964647;5653;5815.825525234229;5853.64878107315;5854.385289544601;5860.267466566679;5587.916181257285;5844.211031510756;5859.560532960045;5889.67606781629;5890;5656.2929633795775;5773.105168698817;5785.103308987113;5787.189793428924;5791.507721843648;14927;18122.546936326566;20862.06120724571;23560.175393861304;23748.881255593784;2379.084052639746;3032.33288676493;3037.9392412151856;3075.7696921231463;3084.629844418684;10793.352398856015;10857.185711071623;11168;11401.48693308803;11427.828582571268;1868.6169335286233;1878.1078987480837;1883.3802929480635;1938.3022112039655;1948.1233444949687;84456.57771711164;85123.57438212831;85844.57077714633;86079;87120.99999999936;11525.76948461026;11601.825972610417;11970.00749812547;12046.156769026084;12178.512859485698;17092.316307347817;17094.230759615846;17147.056911869717;17171.656566868594;17187.828121718874;8853.38026338163;8880.911190888137;8977.102289771101;9019.774505637411;9062.546872656472;8556.914430855737;8595.245077815509;8597.398182127316;8774.341924355698;8888.73333799987;5029.698218106925;5094.2358646203365;5138.434772175057;5150.304708864255;5196.324477817935;2078.8752674839557;2113.3026101386504;2126.8404869634837;2138.240924471821;2139.069504765432;981.7741919358588;1026.3790406803926;1042.8435734639866;1048.984265236022;1053.7365658585354;19623.60752784965;19835.50411239702;20222.191112355635;20350.512683484536;20781.792182078287;972.1493693018608;979.6326377608397;1017.8066167428165;1020.1787561013456;1038.3925403638805;10453.895461045444;11447.599334023436;11454.370009649549;11502.597409090642;11520.654380368602;470965;477239;477462;479360;490858;56834.14748778772;59705.40294596998;91074;93801;94879.52560237155;1018.9745256368502;1062.0759938853093;1073.683263437288;1097.5554900265245;1099.219554116586;17377.304907803547;17907.283708651506;18052.819471805113;18314.358997435025;18447;30628.84685576558;42892.35661465018;42965.355519666606;43290.35064473972;44498;52631;55057;56957.43042569521;61421.692891535255;61712.38287617066;8438.198371154731;8968.417052891542;8980.101989800967;9020.278377729897;9047.547622618711;6253.874922501615;10780.784384312114;13364.866351336363;13451.529196478075;13452.39464224132;11623.825642615537;11722.76554468923;11817.468213930566;11836.881631183578;12403.25580465175;11483.196176267582;11567.595134170264;11612.6516204514;11651.359175245443;12148.149629526202;11785.410729463321;11826.881731182923;11939.82090268664;11973.521059157536;12404.379781011094;8696.391252612257;8834.558272086499;8891.422057566237;8948.060453652533;8954.731358059269;10557.577696892038;11684.240524365889;11716.765664686489;12188.756224875275;12259 08:15:39 INFO - PROCESS | 3372 | |3;mootools.html;1170.1984140863503;1457;1504.7818066380376;1585.61945133168;1779.4839496545994;7209.423246140303;7755.108162561307;7956.84086318274;7957;8322.875156872637;7996.240357166074;8012.799680008003;8015.839683206333;8021.438499305051;8024.91975080249;2371.075280640547;2395.7244916834525;2397.3407312988893;2397.4246180916543;2398.388410955204;2343.121329501437;2376.144587948337;2427.9150229741963;2429.829911906167;2430.149447693311;2335.92992210234;2344.519373528431;2362.751911049341;2378.6194208926577;2380.059876348841;2329.848559843622;2348.5537747827857;2350.82368822339;2379.44083140461;2380;2400.951980960371;2418.6372044193513;2455.84037037592;2457.373369790692;2458.6723169488455;8279.50322980623;8296.709615163501;8303.709370172015;8355.874661880076;8387.370947178986;5066.771995260222;5240.764165612557;5303.602229832778;5308;5326;3251.3497300539752;3297.422950983568;3376.881809136693;3385.5937287525408;3484.285721427101;1107.1087774341652;1123.7359220583157;1131.247720266022;1133.2973556395004;1135.40391294571;11317.83023254652;11320.433978301135;11402.543898244143;11421.42892855354;11465.541378344857;4155.97922010388;4455.576720211575;4487.125010622897;4518.683692141584;4545.659075569345;9271.768205794775;9286.210672092948;9291.349605527683;9295.488748118918;9299;5283.128283833202;5283.365996080495;5286.312779338738;5287.101192797234;5298.682079075268;4271.743695378287;4276.444062271885;4332.285172946492;4418.2047231498;4968.6025117990475;3853.9421908671393;3909.863154789569;4018.819153138116;4032.274190645653;4037.9192416151513;1212.351392005273;1217.6955761059735;1218.3238302742063;1226.1539537718945;1234.7530493901256;843.7089204224533;928.4290161550598;929.874466946967;948.4878165790534;953.3136141977765;5527.226188333637;5685.857853553694;5874.236349274567;5913.319968203712;5972.432618901197;860.1914200651493;876.6712482818942;906.2161230535539;927.1377618814568;939.5067589515559;3755.549334079928;4069;4155.501339839238;4201;4205.243056249843;10126.44304563256;10371.792564148825;10481.685549433529;10488.05607495329;10490.05589496949;9654.56554455037;9762.90237097634;9893.45585992763;10389.94805025985;10393.792124157626;7746.728864489716;7751.263629955145;7847.843043139105;7907.841843163104;7949.324307433817;5353.705546194997;5559.555235581063;5765.155150352015;5866.970665146647;6006.819795406145;9192.724218273463;9206.677766278148;9283.907160928304;9323.860142097737;9437.386569872937;8095.150009248944;9037.277017838689;9424.575894084646;9529.714108576754;9551.235901128031;7231.63841807897;7428.4800063995;7437.219091995263;7442.665080071518;7448.366888814511;7841.921580784119;7930.088039875488;7954.602269886367;8255.25702686737;8257.174282571696;7240.312170343809;7250.637468126678;7253.419726421979;7261.382782463338;7496.887546686913;7278.454115941219;7290.467304561801;7424.071991001125;7437.219091995479;7509.286617771303;6416.422521973045;6426.068220108152;6465.062565928009;6474.773382931575;6498.64257465825;4957.429895562056;5116.283720279238;5122.769475373691;5196.064708352382;5233.39815921174;4959.082569724613;5024.42219144803;5050.646454748133;5150.819721309736;5161.225816127611 08:15:39 INFO - PROCESS | 3372 | |4;prototype.html;336.1327774342197;336.4028848793391;347.37299174989136;350.94560343146804;353.639287926315;5319.377589835099;5329.333833270836;5375.3280839895015;5390.91913621295;5403.135498320269;5063.202563090105;5120.539151476366;5197.974010129944;5199.324087868581;5223.843284701456;4195.85314513992;4196.160767846428;4212.389203565481;4217.810198541065;4241.384999175118;4204.705670603059;4242.193983143208;4258.957410425887;4260.616544510994;4278.507971583276;3932.654292366529;4080.367543030835;4098.774567398792;4183.698965568925;4187.560306167854;4190.329547272452;4191.1827193697245;4193.81127849246;4195.832166713343;4201.684873634459;3735.1782607826235;3752.362098443244;3760.7743535387963;3764.3976963685955;3796.7152463565344;5014.84955451337;5134.563562097189;5144.305518754958;5148.6910785353;5154.433012368637;4749.57253847152;4768.213244814601;4793.5925446337105;4806.231003039532;4823.083614113307;5481.397046324901;5518.558515318765;5520.861978450531;5552.305961754781;5567.387587365387;4089.591040895916;4113.9794301028605;4125.360569111793;4132.367714752656;4156.376543518496;5654.886902261973;5684.34630017545;5700.149925037481;5715.31416230055;5720.370759216483;4238.682098842599;4243.151369726067;4273.0385663225525;4276.72201306914;4298.46269216348;4226.873193804191;4228.936565951513;4279.422277992431;4284.228838808982;4335.436393268855;4726.71639701619;4774.474807771142;4786.880327991828;4806.95193048072;4818.397700287464;5508.697021663847;5521.641093328921;5522.039675915073;5571.637843540238;5576.414476479992;1358.809766632672;1416.221078406872;1437.1808069400342;1445.4651778841896;1459.2047334202884;966.8259713251682;980.843065109579;981.4896253947907;1029.6036026129993;1060.8514807926897;5191.844244672666;5209.270702101709;5236.24074509194;5239.869003274948;5311.787528498894;5367.4364191759305;5462.235287059815;5508.338999320107;5512.5589952803675;5513.641613295204;5173.3533308336455;5184.533391994739;5191.32512773337;5192.688438693691;5204.843854684365;2896.826190428581;2910.3742695320607;2912.5922370868097;2918;2924.3420230448405;5463.699496527729;5591.776328946878;5626.634268772516;5628.521575666115;5651.208830763697;5443.265159203536;5511.200875872976;5522.861928451741;5530.834074977757;5547.5007249347755;5571.275734154534;5635.380108188096;5640.379558248589;5722.113072473773;5726.942730572724;5377.8924421510565;5407.83776486706;5674.645022315693;5711.828645140652;5712.857178570569;5658.5473162147755;5679.574031947538;5683.261176047087;5691.630044047124;5707.857303567444;5660.490555849993;5877.647341159544;5897.3807750187325;5903.173555702291;5909.261342332208;4088.2232375848494;4119.608637179464;4154.273002224659;4170.311898536707;4172.269852775813;5703.315602127605;5735.369109398046;5746.396628353963;5748.195252664546;5748.942510575008;5532.419095995024;5594.608377413542;5612.522935550524;5683.715814209356;5688.516476099412;5561.332640083054;5566.359868615161;5567.77728890856;5573.693446860461;5576.60963732551;5315.973420132875;5450.373207081077;5470.152126420411;5521.033819081725;5546.251256080377;5245.973770131278;5425.206018900349;5550.69471179089;5600.431879073866;5608.803691870929;5423.972880135574;5458.6724796512335;5462.91805622908;5466.972665136649;5483.835484935458 08:15:39 INFO - PROCESS | 3372 | |5;yui.html;794.5788731972053;804.5494523067086;814.9470284431511;815.4210510537516;830.9792255193623;14221.21783301918;15053.494650534942;15062.698746025073;15080.77378839317;15239.542813715592;13793.655158621039;13846.584602461917;13868.722625547483;13873.514426995058;13883.236421996811;705.989410158848;719.8380364418016;818.2186012358184;844.3371953016883;847.3009766942266;850.2093053460279;851.0383266908385;851.2466467176531;851.2636569367484;851.4167795060373;879.6217626420637;882.1663527966075;882.2060145868737;882.7748924024397;883.9867401988976;737.5242968285453;749.7488341405635;858.9570521473933;865.1348651348651;878.5124256037897;651.0787236060968;651.2087813306807;651.456034211434;651.5634524868302;652.0968458684756;13421.731565368736;13730.176189428666;13732.794008089886;13752.449902003907;13769.31153442334;13487.123336983064;13724.45102195911;13904.679055489814;14241.643958901006;14260.215688137148;12774.808377874338;12802.551910683174;12944.676383090498;13161.144525605805;13247.403866826016;4198.517170525398;4212.13651201506;4283.082667567041;4294.055307832272;4304.80628371724;64654.67672661653;65541;66028.33971660318;66315.66842165854;67194.32805671978;10817.675469735921;10829.67510974672;10911.727206819893;10930.726731831768;11039.503222355013;21095.78904210969;21105.155793768383;21167.576648467253;21242.300615950688;21488.677669834964;7763.72826951054;8019.719309824245;8261.463004904663;8281.668733250723;8307.6676932922;4506.256467682796;4653.278741795028;4670.089332580183;4806.447258565309;4837.685550439211;3306.123877172503;3408.233147541783;3409.09658940381;3411.4712219606;3413.4538473844564;543.2937181663822;593.0955293177938;598.9580729348991;600.540586451365;601.1643815097019;603.6951339573487;622.8287221014257;645.1258544671902;672.1363048482676;720.121451828768;9478.763030924145;9569.421000589366;9610.327277090677;9748;9817.607295708234;720.8738470767595;724.344468256229;726.0923845193508;743.5427212264418;746.3506749128185;4169;4378.649708023414;4413.205622987829;4434.490033646172;4500.594946454835;88928.55535722409;89122.68776521087;93109.20672379703;96061.5196924011;97923.51038244762;56141.7192914041;64727;84361.57819210865;85199.5740021296;85697.57151214329;74030.62984685042;74955;75035.62482187663;75117;77423.61288193523;8557.272631826365;8585.399022068645;8751.64993400257;8826.382153249468;8841.292696584129;51337.48662513476;51359.74320128375;51715;51745.96508069893;51864.222036668725;63327.683361582895;69991.30008699848;70506.64746676439;71853.64073179601;72498.27501725126;11248.21262511649;11309.208355415041;11497.137714671266;11651.41742912868;12413.255204687748;13440.395182216627;13581.45674173022;13774.724505509634;13932.93033534826;14319.713605728035;10598.523066461874;13006.284654344103;13795.517156899461;13919.721605568035;13943.372548235557;13695.863041369857;14264.786028209794;14323.641908951942;14528.346224420138;14531;12978.415971281127;13298.268595227355;13339.132956357806;13952.093113947562;14363.856361436252;9738;10155.54300056514;10239.590416383262;10339.896601033894;11463.484143213409;11320.320780753182;11606.767864642828;11640.94179529097;11664.94167529157;11874.228175168586 08:15:39 INFO - PROCESS | 3372 | __end_tp_report 08:15:39 INFO - PROCESS | 3372 | __start_cc_report 08:15:39 INFO - PROCESS | 3372 | _x_x_mozilla_cycle_collect,1020 08:15:39 INFO - PROCESS | 3372 | __end_cc_report 08:15:39 INFO - PROCESS | 3372 | __startTimestamp1482336939741__endTimestamp 08:15:39 INFO - PROCESS | 3372 | 08:15:39 INFO - PROCESS | 3372 | ------- Summary: start ------- 08:15:39 INFO - PROCESS | 3372 | Number of tests: 6 08:15:39 INFO - PROCESS | 3372 | 08:15:39 INFO - PROCESS | 3372 | [#0] dojo.html Cycles:165 Average:5580.63 Median:5810.04 stddev:631.39 (10.9%) stddev-sans-first:606.30 08:15:39 INFO - PROCESS | 3372 | Values: 3251.1 3277.5 3281.5 3291.9 3308.3 5461.0 5522.3 5540.8 5546.4 5547.8 5590.9 5633.3 5635.2 5638.9 5682.4 5110.4 5131.0 5158.4 5199.6 5215.1 5038.5 5056.2 5056.9 5184.1 5242.7 5111.7 5175.0 5188.6 5210.2 5214.9 5197.7 5208.7 5214.5 5217.9 5231.8 4990.2 5004.6 5045.1 5093.6 5095.4 5483.0 5483.8 5486.5 5490.3 5574.8 5960.4 6008.1 6014.0 6015.4 6016.5 5896.7 5972.0 6016.7 6058.4 6065.3 5518.0 5558.8 5563.4 5574.1 5619.2 6117.5 6120.8 6121.2 6122.2 6127.0 5810.9 5826.0 5885.6 5891.1 5900.9 5916.6 5936.2 5952.1 6020.2 6053.8 5959.5 5969.7 5977.2 5987.0 6026.8 5874.1 5953.5 5998.1 6005.8 6007.8 4568.4 4577.6 4587.0 4600.9 4638.7 4108.6 4125.4 4133.5 4137.5 4156.0 5794.0 5810.0 5816.5 5818.7 5856.0 5801.7 5836.7 5849.6 5860.9 5868.2 5652.3 5674.8 5677.1 5680.4 5689.5 5020.4 5031.2 5032.7 5037.8 5074.0 6077.4 6172.0 6179.7 6198.4 6212.2 6082.5 6084.2 6086.2 6092.3 6120.2 6312.9 6336.7 6341.1 6346.8 6366.0 5732.9 5763.7 5917.0 6009.5 6010.8 6029.1 6121.7 6135.3 6137.2 6137.3 5920.9 5991.9 5995.6 5996.2 5998.0 5632.6 5732.1 5934.8 5952.2 5957.4 5784.5 5826.1 5832.0 5881.9 5931.9 5962.9 5976.7 5993.7 6006.0 6007.7 5524.6 5626.3 5630.4 5642.5 5806.1 08:15:39 INFO - PROCESS | 3372 | 08:15:39 INFO - PROCESS | 3372 | [#1] ext.html Cycles:180 Average:60609.16 Median:38878.51 stddev:116870.95 (300.6%) stddev-sans-first:117111.92 08:15:39 INFO - PROCESS | 3372 | Values: 588.6 606.7 646.0 663.8 669.9 34428.1 45542.8 46597.8 46598.5 46662.0 46292.0 46872.0 46932.8 46956.8 46973.0 8264.1 8812.1 8936.6 8950.1 8957.5 8192.6 8461.1 8463.7 10490.3 10761.1 10847.3 10906.7 10909.2 10909.6 10918.5 10441.6 10462.8 10481.2 10481.8 10483.6 10300.4 10355.1 10370.2 10370.4 10384.4 44088.3 44337.8 44364.8 44451.6 44472.3 3822.6 3977.4 4344.7 4358.5 4447.9 32993.2 33368.0 33738.7 34140.5 34320.8 4322.8 4606.8 4622.4 4626.7 4747.8 353865.0 355860.0 357824.0 357898.0 358698.0 63399.0 63652.4 63764.0 63793.7 63846.4 39260.2 40321.8 40506.8 42275.6 68578.3 19487.4 19717.5 19724.6 19728.1 19734.1 13513.4 14926.0 15061.8 15066.8 15076.2 18837.4 19760.1 20569.2 21254.3 21304.0 7455.9 7466.6 7602.3 7607.5 7742.9 976.6 987.9 1132.1 1167.6 1179.8 32653.8 33057.7 33102.3 33227.8 33324.7 1176.1 1182.5 1198.1 1199.8 1209.2 17322.7 17604.2 17631.9 17666.4 17715.3 530281.0 532598.0 534609.0 535334.0 535640.0 61512.7 62060.4 62157.7 62177.7 62228.0 1305.7 1331.7 1389.6 1435.0 1439.5 30570.8 34550.7 35088.1 35174.3 35183.6 52482.0 52935.5 52959.0 53042.7 53064.2 413088.0 417351.4 418014.0 418084.0 418415.0 30282.5 30769.2 32097.5 32370.4 32667.0 49523.8 49643.0 49647.8 50659.0 50731.5 36738.3 36927.3 36965.3 36972.8 37691.4 41620.8 41702.0 41996.2 42244.4 43675.6 41997.6 42393.4 42569.0 43061.0 43160.0 35906.6 38160.8 38253.8 38583.8 39173.2 29001.3 29130.0 29148.6 29288.7 29400.3 08:15:39 INFO - PROCESS | 3372 | 08:15:39 INFO - PROCESS | 3372 | [#2] jquery.html Cycles:180 Average:28638.51 Median:13063.98 stddev:78912.57 (604.0%) stddev-sans-first:79105.44 08:15:39 INFO - PROCESS | 3372 | Values: 390.7 431.0 432.5 440.7 444.1 17264.3 19785.4 20452.8 20502.7 20503.4 19854.8 20088.2 20098.9 20116.0 20273.8 5742.2 5777.1 5862.3 5901.9 5907.2 5806.7 5883.7 5890.8 5891.1 5897.1 5653.0 5815.8 5853.6 5854.4 5860.3 5587.9 5844.2 5859.6 5889.7 5890.0 5656.3 5773.1 5785.1 5787.2 5791.5 14927.0 18122.5 20862.1 23560.2 23748.9 2379.1 3032.3 3037.9 3075.8 3084.6 10793.4 10857.2 11168.0 11401.5 11427.8 1868.6 1878.1 1883.4 1938.3 1948.1 84456.6 85123.6 85844.6 86079.0 87121.0 11525.8 11601.8 11970.0 12046.2 12178.5 17092.3 17094.2 17147.1 17171.7 17187.8 8853.4 8880.9 8977.1 9019.8 9062.5 8556.9 8595.2 8597.4 8774.3 8888.7 5029.7 5094.2 5138.4 5150.3 5196.3 2078.9 2113.3 2126.8 2138.2 2139.1 981.8 1026.4 1042.8 1049.0 1053.7 19623.6 19835.5 20222.2 20350.5 20781.8 972.1 979.6 1017.8 1020.2 1038.4 10453.9 11447.6 11454.4 11502.6 11520.7 470965.0 477239.0 477462.0 479360.0 490858.0 56834.1 59705.4 91074.0 93801.0 94879.5 1019.0 1062.1 1073.7 1097.6 1099.2 17377.3 17907.3 18052.8 18314.4 18447.0 30628.8 42892.4 42965.4 43290.4 44498.0 52631.0 55057.0 56957.4 61421.7 61712.4 8438.2 8968.4 8980.1 9020.3 9047.5 6253.9 10780.8 13364.9 13451.5 13452.4 11623.8 11722.8 11817.5 11836.9 12403.3 11483.2 11567.6 11612.7 11651.4 12148.1 11785.4 11826.9 11939.8 11973.5 12404.4 8696.4 8834.6 8891.4 8948.1 8954.7 10557.6 11684.2 11716.8 12188.8 12259.0 08:15:39 INFO - PROCESS | 3372 | 08:15:39 INFO - PROCESS | 3372 | [#3] mootools.html Cycles:180 Average:5507.23 Median:5284.84 stddev:2992.04 (56.6%) stddev-sans-first:2982.67 08:15:39 INFO - PROCESS | 3372 | Values: 1170.2 1457.0 1504.8 1585.6 1779.5 7209.4 7755.1 7956.8 7957.0 8322.9 7996.2 8012.8 8015.8 8021.4 8024.9 2371.1 2395.7 2397.3 2397.4 2398.4 2343.1 2376.1 2427.9 2429.8 2430.1 2335.9 2344.5 2362.8 2378.6 2380.1 2329.8 2348.6 2350.8 2379.4 2380.0 2401.0 2418.6 2455.8 2457.4 2458.7 8279.5 8296.7 8303.7 8355.9 8387.4 5066.8 5240.8 5303.6 5308.0 5326.0 3251.3 3297.4 3376.9 3385.6 3484.3 1107.1 1123.7 1131.2 1133.3 1135.4 11317.8 11320.4 11402.5 11421.4 11465.5 4156.0 4455.6 4487.1 4518.7 4545.7 9271.8 9286.2 9291.3 9295.5 9299.0 5283.1 5283.4 5286.3 5287.1 5298.7 4271.7 4276.4 4332.3 4418.2 4968.6 3853.9 3909.9 4018.8 4032.3 4037.9 1212.4 1217.7 1218.3 1226.2 1234.8 843.7 928.4 929.9 948.5 953.3 5527.2 5685.9 5874.2 5913.3 5972.4 860.2 876.7 906.2 927.1 939.5 3755.5 4069.0 4155.5 4201.0 4205.2 10126.4 10371.8 10481.7 10488.1 10490.1 9654.6 9762.9 9893.5 10389.9 10393.8 7746.7 7751.3 7847.8 7907.8 7949.3 5353.7 5559.6 5765.2 5867.0 6006.8 9192.7 9206.7 9283.9 9323.9 9437.4 8095.2 9037.3 9424.6 9529.7 9551.2 7231.6 7428.5 7437.2 7442.7 7448.4 7841.9 7930.1 7954.6 8255.3 8257.2 7240.3 7250.6 7253.4 7261.4 7496.9 7278.5 7290.5 7424.1 7437.2 7509.3 6416.4 6426.1 6465.1 6474.8 6498.6 4957.4 5116.3 5122.8 5196.1 5233.4 4959.1 5024.4 5050.6 5150.8 5161.2 08:15:39 INFO - PROCESS | 3372 | 08:15:39 INFO - PROCESS | 3372 | [#4] prototype.html Cycles:180 Average:4669.07 Median:5242.92 stddev:1335.22 (25.5%) stddev-sans-first:1298.75 08:15:39 INFO - PROCESS | 3372 | Values: 336.1 336.4 347.4 350.9 353.6 5319.4 5329.3 5375.3 5390.9 5403.1 5063.2 5120.5 5198.0 5199.3 5223.8 4195.9 4196.2 4212.4 4217.8 4241.4 4204.7 4242.2 4259.0 4260.6 4278.5 3932.7 4080.4 4098.8 4183.7 4187.6 4190.3 4191.2 4193.8 4195.8 4201.7 3735.2 3752.4 3760.8 3764.4 3796.7 5014.8 5134.6 5144.3 5148.7 5154.4 4749.6 4768.2 4793.6 4806.2 4823.1 5481.4 5518.6 5520.9 5552.3 5567.4 4089.6 4114.0 4125.4 4132.4 4156.4 5654.9 5684.3 5700.1 5715.3 5720.4 4238.7 4243.2 4273.0 4276.7 4298.5 4226.9 4228.9 4279.4 4284.2 4335.4 4726.7 4774.5 4786.9 4807.0 4818.4 5508.7 5521.6 5522.0 5571.6 5576.4 1358.8 1416.2 1437.2 1445.5 1459.2 966.8 980.8 981.5 1029.6 1060.9 5191.8 5209.3 5236.2 5239.9 5311.8 5367.4 5462.2 5508.3 5512.6 5513.6 5173.4 5184.5 5191.3 5192.7 5204.8 2896.8 2910.4 2912.6 2918.0 2924.3 5463.7 5591.8 5626.6 5628.5 5651.2 5443.3 5511.2 5522.9 5530.8 5547.5 5571.3 5635.4 5640.4 5722.1 5726.9 5377.9 5407.8 5674.6 5711.8 5712.9 5658.5 5679.6 5683.3 5691.6 5707.9 5660.5 5877.6 5897.4 5903.2 5909.3 4088.2 4119.6 4154.3 4170.3 4172.3 5703.3 5735.4 5746.4 5748.2 5748.9 5532.4 5594.6 5612.5 5683.7 5688.5 5561.3 5566.4 5567.8 5573.7 5576.6 5316.0 5450.4 5470.2 5521.0 5546.3 5246.0 5425.2 5550.7 5600.4 5608.8 5424.0 5458.7 5462.9 5467.0 5483.8 08:15:39 INFO - PROCESS | 3372 | 08:15:39 INFO - PROCESS | 3372 | [#5] yui.html Cycles:180 Average:18627.39 Median:51537.37 stddev:25074.99 (48.7%) stddev-sans-first:25109.58 08:15:39 INFO - PROCESS | 3372 | Values: 794.6 804.5 814.9 815.4 831.0 14221.2 15053.5 15062.7 15080.8 15239.5 13793.7 13846.6 13868.7 13873.5 13883.2 706.0 719.8 818.2 844.3 847.3 850.2 851.0 851.2 851.3 851.4 879.6 882.2 882.2 882.8 884.0 737.5 749.7 859.0 865.1 878.5 651.1 651.2 651.5 651.6 652.1 13421.7 13730.2 13732.8 13752.4 13769.3 13487.1 13724.5 13904.7 14241.6 14260.2 12774.8 12802.6 12944.7 13161.1 13247.4 4198.5 4212.1 4283.1 4294.1 4304.8 64654.7 65541.0 66028.3 66315.7 67194.3 10817.7 10829.7 10911.7 10930.7 11039.5 21095.8 21105.2 21167.6 21242.3 21488.7 7763.7 8019.7 8261.5 8281.7 8307.7 4506.3 4653.3 4670.1 4806.4 4837.7 3306.1 3408.2 3409.1 3411.5 3413.5 543.3 593.1 599.0 600.5 601.2 603.7 622.8 645.1 672.1 720.1 9478.8 9569.4 9610.3 9748.0 9817.6 720.9 724.3 726.1 743.5 746.4 4169.0 4378.6 4413.2 4434.5 4500.6 88928.6 89122.7 93109.2 96061.5 97923.5 56141.7 64727.0 84361.6 85199.6 85697.6 74030.6 74955.0 75035.6 75117.0 77423.6 8557.3 8585.4 8751.6 8826.4 8841.3 51337.5 51359.7 51715.0 51746.0 51864.2 63327.7 69991.3 70506.6 71853.6 72498.3 11248.2 11309.2 11497.1 11651.4 12413.3 13440.4 13581.5 13774.7 13932.9 14319.7 10598.5 13006.3 13795.5 13919.7 13943.4 13695.9 14264.8 14323.6 14528.3 14531.0 12978.4 13298.3 13339.1 13952.1 14363.9 9738.0 10155.5 10239.6 10339.9 11463.5 11320.3 11606.8 11640.9 11664.9 11874.2 08:15:39 INFO - PROCESS | 3372 | -------- Summary: end -------- 08:15:39 INFO - PROCESS | 3372 | 08:15:40 INFO - TEST-INFO | 3372: exit 0 08:15:40 INFO - TEST-OK | dromaeo_css | took 1117939ms 08:15:40 INFO - TEST-START | kraken 08:15:40 INFO - operating with platform_type : linux_ 08:15:40 INFO - Initialising browser for kraken test... 08:15:40 INFO - TEST-INFO | started process 3687 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOPLU9m/profile http://localhost:42986/getInfo.html) 08:15:44 INFO - PROCESS | 3687 | __metrics Screen width/height:1600/1200 08:15:44 INFO - PROCESS | 3687 | colorDepth:24 08:15:44 INFO - PROCESS | 3687 | Browser inner width/height: 1024/697 08:15:44 INFO - PROCESS | 3687 | __metrics 08:15:45 INFO - PROCESS | 3687 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:15:45 INFO - PROCESS | 3687 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:15:46 INFO - PROCESS | 3687 | console.error: PushService: 08:15:46 INFO - PROCESS | 3687 | stateChangeProcessEnqueue: Error transitioning state 08:15:46 INFO - PROCESS | 3687 | UnknownError 08:15:46 INFO - TEST-INFO | 3687: exit 0 08:15:46 INFO - Browser initialized. 08:15:46 INFO - Running cycle 1/1 for kraken test... 08:15:46 INFO - TEST-INFO | started process 3783 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOPLU9m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:15:58 INFO - PROCESS | 3783 | RSS: Main: 144252928 08:15:58 INFO - PROCESS | 3783 | 08:16:01 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:42986/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42986/tests/kraken/driver.html?testName=audio-beat-detection) 08:16:01 INFO - PROCESS | 3783 | RSS: Main: 185290752 08:16:01 INFO - PROCESS | 3783 | 08:16:04 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:42986/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42986/tests/kraken/driver.html?testName=audio-dft) 08:16:05 INFO - PROCESS | 3783 | RSS: Main: 175554560 08:16:05 INFO - PROCESS | 3783 | 08:16:07 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:42986/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42986/tests/kraken/driver.html?testName=audio-fft) 08:16:08 INFO - PROCESS | 3783 | RSS: Main: 266235904 08:16:08 INFO - PROCESS | 3783 | 08:16:10 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:42986/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42986/tests/kraken/driver.html?testName=audio-oscillator) 08:16:11 INFO - PROCESS | 3783 | RSS: Main: 172392448 08:16:11 INFO - PROCESS | 3783 | 08:16:13 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:42986/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42986/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:16:13 INFO - PROCESS | 3783 | RSS: Main: 174727168 08:16:13 INFO - PROCESS | 3783 | 08:16:16 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:42986/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42986/tests/kraken/driver.html?testName=imaging-darkroom) 08:16:17 INFO - PROCESS | 3783 | RSS: Main: 213704704 08:16:17 INFO - PROCESS | 3783 | 08:16:20 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:42986/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42986/tests/kraken/driver.html?testName=imaging-desaturate) 08:16:21 INFO - PROCESS | 3783 | RSS: Main: 212570112 08:16:21 INFO - PROCESS | 3783 | 08:16:23 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:42986/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42986/tests/kraken/driver.html?testName=json-parse-financial) 08:16:25 INFO - PROCESS | 3783 | RSS: Main: 211251200 08:16:25 INFO - PROCESS | 3783 | 08:16:26 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:42986/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42986/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:16:27 INFO - PROCESS | 3783 | RSS: Main: 174022656 08:16:27 INFO - PROCESS | 3783 | 08:16:28 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:42986/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42986/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:16:29 INFO - PROCESS | 3783 | RSS: Main: 180117504 08:16:29 INFO - PROCESS | 3783 | 08:16:31 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:42986/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42986/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:16:32 INFO - PROCESS | 3783 | RSS: Main: 189120512 08:16:32 INFO - PROCESS | 3783 | 08:16:34 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:42986/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42986/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:16:35 INFO - PROCESS | 3783 | RSS: Main: 197943296 08:16:35 INFO - PROCESS | 3783 | 08:16:38 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:42986/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42986/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:16:38 INFO - PROCESS | 3783 | RSS: Main: 194109440 08:16:38 INFO - PROCESS | 3783 | 08:16:40 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:42986/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42986/tests/kraken/driver.html?testName=ai-astar) 08:16:40 INFO - PROCESS | 3783 | RSS: Main: 245993472 08:16:40 INFO - PROCESS | 3783 | 08:16:40 INFO - PROCESS | 3783 | __start_tp_report 08:16:40 INFO - PROCESS | 3783 | _x_x_mozilla_page_load 08:16:40 INFO - PROCESS | 3783 | _x_x_mozilla_page_load_details 08:16:40 INFO - PROCESS | 3783 | |i|pagename|runs| 08:16:40 INFO - PROCESS | 3783 | |0;ai-astar;104;110;113;111;112;111;111;114;113;111 08:16:40 INFO - PROCESS | 3783 | |1;audio-beat-detection;144;117;118;154;119;122;119;119;147;117 08:16:40 INFO - PROCESS | 3783 | |2;audio-dft;161;160;160;161;160;159;161;163;160;159 08:16:40 INFO - PROCESS | 3783 | |3;audio-fft;74;74;76;112;75;76;76;74;98;76 08:16:40 INFO - PROCESS | 3783 | |4;audio-oscillator;82;81;121;83;82;81;98;82;82;107 08:16:40 INFO - PROCESS | 3783 | |5;imaging-gaussian-blur;117;117;117;117;117;116;116;117;118;118 08:16:40 INFO - PROCESS | 3783 | |6;imaging-darkroom;146;146;145;145;146;145;146;146;145;146 08:16:40 INFO - PROCESS | 3783 | |7;imaging-desaturate;85;85;85;84;84;84;85;84;84;84 08:16:40 INFO - PROCESS | 3783 | |8;json-parse-financial;50;49;50;49;50;58;50;49;50;50 08:16:40 INFO - PROCESS | 3783 | |9;json-stringify-tinderbox;59;60;59;60;59;60;59;59;59;60 08:16:40 INFO - PROCESS | 3783 | |10;stanford-crypto-aes;75;75;80;75;76;75;76;74;74;75 08:16:40 INFO - PROCESS | 3783 | |11;stanford-crypto-ccm;122;122;138;123;131;129;120;120;161;125 08:16:40 INFO - PROCESS | 3783 | |12;stanford-crypto-pbkdf2;153;153;156;164;152;154;155;153;151;156 08:16:40 INFO - PROCESS | 3783 | |13;stanford-crypto-sha256-iterative;66;62;62;67;61;67;61;61;60;60 08:16:40 INFO - PROCESS | 3783 | __end_tp_report 08:16:40 INFO - PROCESS | 3783 | __start_cc_report 08:16:40 INFO - PROCESS | 3783 | _x_x_mozilla_cycle_collect,1648 08:16:40 INFO - PROCESS | 3783 | __end_cc_report 08:16:40 INFO - PROCESS | 3783 | __startTimestamp1482337000559__endTimestamp 08:16:40 INFO - PROCESS | 3783 | 08:16:40 INFO - PROCESS | 3783 | ------- Summary: start ------- 08:16:40 INFO - PROCESS | 3783 | Number of tests: 14 08:16:40 INFO - PROCESS | 3783 | 08:16:40 INFO - PROCESS | 3783 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.50 stddev:2.75 (2.5%) stddev-sans-first:1.30 08:16:40 INFO - PROCESS | 3783 | Values: 104.0 110.0 113.0 111.0 112.0 111.0 111.0 114.0 113.0 111.0 08:16:40 INFO - PROCESS | 3783 | 08:16:40 INFO - PROCESS | 3783 | [#1] audio-beat-detection Cycles:10 Average:127.60 Median:120.50 stddev:14.58 (12.1%) stddev-sans-first:14.20 08:16:40 INFO - PROCESS | 3783 | Values: 144.0 117.0 118.0 154.0 119.0 122.0 119.0 119.0 147.0 117.0 08:16:40 INFO - PROCESS | 3783 | 08:16:40 INFO - PROCESS | 3783 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:1.17 (0.7%) stddev-sans-first:1.22 08:16:40 INFO - PROCESS | 3783 | Values: 161.0 160.0 160.0 161.0 160.0 159.0 161.0 163.0 160.0 159.0 08:16:40 INFO - PROCESS | 3783 | 08:16:40 INFO - PROCESS | 3783 | [#3] audio-fft Cycles:10 Average:81.10 Median:76.00 stddev:13.05 (17.2%) stddev-sans-first:13.59 08:16:40 INFO - PROCESS | 3783 | Values: 74.0 74.0 76.0 112.0 75.0 76.0 76.0 74.0 98.0 76.0 08:16:40 INFO - PROCESS | 3783 | 08:16:40 INFO - PROCESS | 3783 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:82.00 stddev:14.07 (17.2%) stddev-sans-first:14.63 08:16:40 INFO - PROCESS | 3783 | Values: 82.0 81.0 121.0 83.0 82.0 81.0 98.0 82.0 82.0 107.0 08:16:40 INFO - PROCESS | 3783 | 08:16:40 INFO - PROCESS | 3783 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 08:16:40 INFO - PROCESS | 3783 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 118.0 118.0 08:16:40 INFO - PROCESS | 3783 | 08:16:40 INFO - PROCESS | 3783 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 08:16:40 INFO - PROCESS | 3783 | Values: 146.0 146.0 145.0 145.0 146.0 145.0 146.0 146.0 145.0 146.0 08:16:40 INFO - PROCESS | 3783 | 08:16:40 INFO - PROCESS | 3783 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 08:16:40 INFO - PROCESS | 3783 | Values: 85.0 85.0 85.0 84.0 84.0 84.0 85.0 84.0 84.0 84.0 08:16:40 INFO - PROCESS | 3783 | 08:16:40 INFO - PROCESS | 3783 | [#8] json-parse-financial Cycles:10 Average:50.50 Median:50.00 stddev:2.68 (5.4%) stddev-sans-first:2.83 08:16:40 INFO - PROCESS | 3783 | Values: 50.0 49.0 50.0 49.0 50.0 58.0 50.0 49.0 50.0 50.0 08:16:40 INFO - PROCESS | 3783 | 08:16:40 INFO - PROCESS | 3783 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 08:16:40 INFO - PROCESS | 3783 | Values: 59.0 60.0 59.0 60.0 59.0 60.0 59.0 59.0 59.0 60.0 08:16:40 INFO - PROCESS | 3783 | 08:16:40 INFO - PROCESS | 3783 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:75.00 stddev:1.72 (2.3%) stddev-sans-first:1.81 08:16:40 INFO - PROCESS | 3783 | Values: 75.0 75.0 80.0 75.0 76.0 75.0 76.0 74.0 74.0 75.0 08:16:40 INFO - PROCESS | 3783 | 08:16:40 INFO - PROCESS | 3783 | [#11] stanford-crypto-ccm Cycles:10 Average:129.10 Median:127.00 stddev:12.56 (9.9%) stddev-sans-first:13.06 08:16:40 INFO - PROCESS | 3783 | Values: 122.0 122.0 138.0 123.0 131.0 129.0 120.0 120.0 161.0 125.0 08:16:40 INFO - PROCESS | 3783 | 08:16:40 INFO - PROCESS | 3783 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.70 Median:154.50 stddev:3.65 (2.4%) stddev-sans-first:3.82 08:16:40 INFO - PROCESS | 3783 | Values: 153.0 153.0 156.0 164.0 152.0 154.0 155.0 153.0 151.0 156.0 08:16:40 INFO - PROCESS | 3783 | 08:16:40 INFO - PROCESS | 3783 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:62.00 stddev:2.83 (4.6%) stddev-sans-first:2.74 08:16:40 INFO - PROCESS | 3783 | Values: 66.0 62.0 62.0 67.0 61.0 67.0 61.0 61.0 60.0 60.0 08:16:40 INFO - PROCESS | 3783 | -------- Summary: end -------- 08:16:40 INFO - PROCESS | 3783 | 08:16:41 INFO - TEST-INFO | 3783: exit 0 08:16:41 INFO - TEST-OK | kraken | took 61136ms 08:16:41 INFO - SUITE-END | took 1179s 08:16:41 INFO - Completed test suite (00:19:39) 08:16:41 INFO - javascript benchmark 08:16:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3251.05719341391, 3277.5411442398054, 3281.458559337709, 3291.8683252669894, 3308.2556424804407, 5461.017016936949, 5522.254495643087, 5540.806071787489, 5546.362168350646, 5547.805826796063, 5590.86022849428, 5633.324001119871, 5635.239242702234, 5638.859028524289, 5682.403347648489, 5110.412302585213, 5130.9994551062555, 5158.432572417031, 5199.584033277348, 5215.087359712054, 5038.470960549144, 5056.165732654126, 5056.898862022757, 5184.066867963765, 5242.68543887368, 5111.718855462948, 5175.0, 5188.6367954243215, 5210.16637338026, 5214.895702085956, 5197.688138711689, 5208.661437006583, 5214.478552144774, 5217.869553261161, 5231.8168864089575, 4990.176620857555, 5004.574611158056, 5045.091883460976, 5093.643444958854, 5095.439501654815, 5482.972585137089, 5483.7806487740445, 5486.478784515464, 5490.286262785852, 5574.804881829116, 5960.374160713106, 6008.068749343859, 6014.0, 6015.398460153993, 6016.488598469092, 5896.734646940898, 5972.0, 6016.669083200466, 6058.39416058395, 6065.332813390523, 5518.0, 5558.805441809558, 5563.443655634404, 5574.1081426972305, 5619.157126430986, 6117.510599152057, 6120.816375508742, 6121.204243448412, 6122.204113465221, 6126.969365153146, 5810.854728631818, 5826.0, 5885.646861188342, 5891.116332550066, 5900.940990590039, 5916.556258280646, 5936.168936348915, 5952.136940143655, 6020.157177995085, 6053.788117415869, 5959.493443057302, 5969.671668058299, 5977.163197152402, 5987.042073268256, 6026.849328766816, 5874.060150375919, 5953.493953014043, 5998.130271110752, 6005.759769609254, 6007.849803754941, 4568.360429539867, 4577.61090307321, 4586.954130458719, 4600.930986035212, 4638.721676699409, 4108.609682080198, 4125.422440858282, 4133.524644665902, 4137.482814648169, 4156.0, 5794.0439827428, 5810.041343178328, 5816.458638460811, 5818.709064546756, 5856.00447923854, 5801.738921748447, 5836.737346819404, 5849.561282903799, 5860.853478663067, 5868.2077919480325, 5652.3217213934595, 5674.801381951612, 5677.148427735872, 5680.375158732536, 5689.544836413077, 5020.3724534433195, 5031.245313203049, 5032.672876263105, 5037.773300201499, 5074.0, 6077.4226448487325, 6172.043333283348, 6179.721912513858, 6198.380161983766, 6212.223472065992, 6082.452579267887, 6084.209052823105, 6086.2087928569, 6092.329843717276, 6120.17377654011, 6312.873742525216, 6336.746530138743, 6341.112244285711, 6346.777862774781, 6366.045093236052, 5732.942670573241, 5763.6541807491685, 5917.023691090922, 6009.519238461, 6010.759569617167, 6029.095635654687, 6121.666376154749, 6135.293912123195, 6137.223770008752, 6137.346341658241, 5920.911186332295, 5991.880162396815, 5995.580309378476, 5996.190514280516, 5998.040313549811, 5632.5775566831835, 5732.05421105513, 5934.7922822701, 5952.196453478725, 5957.404259574181, 5784.5083167929515, 5826.096954971986, 5831.979403604268, 5881.882362352814, 5931.940680593311, 5962.940370596239, 5976.671283079472, 5993.670348130895, 6006.039033754579, 6007.669578173068, 5524.613277070566, 5626.2685850839125, 5630.408807075362, 5642.5485961122195, 5806.129080637938], "value": 5538.447931750977, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.5732843688327, 606.7360698096328, 645.9838504037399, 663.8141320430282, 669.8593295407964, 34428.13929651757, 45542.77228613861, 46597.7670111649, 46598.53401465985, 46662.0, 46292.0, 46872.0, 46932.765336173354, 46956.76521617387, 46973.0, 8264.132266112061, 8812.1187881212, 8936.55317234139, 8950.104989501064, 8957.507337096456, 8192.631331590062, 8461.111583283759, 8463.703770368038, 10490.31812932157, 10761.08530774885, 10847.294925829836, 10906.727331816688, 10909.23635345526, 10909.618163364285, 10918.50866710996, 10441.634542791004, 10462.843057354146, 10481.213908956859, 10481.842772358421, 10483.58065677372, 10300.381977081399, 10355.068043876012, 10370.222233332455, 10370.37777733331, 10384.376937383706, 44088.338674919905, 44337.77831110824, 44364.77817610891, 44451.55548444507, 44472.33291500598, 3822.5582810458122, 3977.3835055566433, 4344.674149438804, 4358.455193100863, 4447.888802779924, 32993.175170620685, 33368.0, 33738.66261337404, 34140.48789268163, 34320.82839585786, 4322.848700295506, 4606.838760643395, 4622.422197225347, 4626.699264547794, 4747.83382581608, 353865.0, 355860.0, 357824.0, 357898.0, 358698.0, 63399.0, 63652.36347636464, 63764.0, 63793.68103159455, 63846.36153638497, 39260.21479570393, 40321.798391007855, 40506.77212753268, 42275.57724422778, 68578.31421685818, 19487.415377538695, 19717.50706232327, 19724.605507889763, 19728.11223494946, 19734.111964961612, 13513.378394592712, 14926.029808062442, 15061.774073388908, 15066.849331506764, 15076.24618769057, 18837.434876953714, 19760.11079501397, 20569.177232910515, 21254.25610103639, 21304.0, 7455.888161677579, 7466.626668666545, 7602.315791578784, 7607.467477276648, 7742.8838567421535, 976.6142373762324, 987.916027137687, 1132.1055568843153, 1167.550493060161, 1179.8496465945634, 32653.836730816194, 33057.66942330594, 33102.3379532408, 33227.83386083054, 33324.66675333216, 1176.129664048598, 1182.515168780813, 1198.1193822540426, 1199.7960346741074, 1209.1958847366402, 17322.740158897628, 17604.207810648553, 17631.911840440716, 17666.381676641256, 17715.29138834458, 530281.0, 532598.0, 534609.0, 535334.0, 535640.0, 61512.69243653753, 62060.379396206365, 62157.689211553654, 62177.68911155415, 62228.0, 1305.7062161013696, 1331.740310639416, 1389.638693939583, 1434.956951291463, 1439.4889814115838, 30570.847145764128, 34550.654493455746, 35088.12279693028, 35174.29651407008, 35183.64816351906, 52482.0, 52935.470645293055, 52959.0, 53042.73478632582, 53064.204036940246, 413088.0, 417351.392701254, 418014.0, 418084.0, 418415.0, 30282.54576181403, 30769.230769230948, 32097.518537222426, 32370.352592947536, 32667.0, 49523.752381237864, 49643.0, 49647.751761240965, 50659.0, 50731.49268507268, 36738.26523469462, 36927.261454771295, 36965.26069478649, 36972.815135924146, 37691.43462848114, 41620.79189604154, 41702.0, 41996.16007679891, 42244.36633450439, 43675.56324436842, 41997.580024200586, 42393.44540245653, 42569.0, 43061.0, 43160.0, 35906.64093359033, 38160.80919595384, 38253.80873095617, 38583.80708096441, 39173.2165356697, 29001.32571793078, 29130.0, 29148.562771558867, 29288.70711292945, 29400.26499337534], "value": 21154.684991944523, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.70306567009067, 431.01104712947637, 432.48318259679684, 440.7047278323523, 444.0563801920916, 17264.309427622895, 19785.40643780689, 20452.795472045313, 20502.6924596131, 20503.38489845307, 19854.801451985477, 20088.196472141135, 20098.89950550249, 20116.0, 20273.797262027376, 5742.224799652056, 5777.104548794933, 5862.325832529271, 5901.881962360751, 5907.232059832216, 5806.651600903938, 5883.676397798119, 5890.823275301748, 5891.145783861338, 5897.056470964647, 5653.0, 5815.825525234229, 5853.64878107315, 5854.385289544601, 5860.267466566679, 5587.916181257285, 5844.211031510756, 5859.560532960045, 5889.67606781629, 5890.0, 5656.2929633795775, 5773.105168698817, 5785.103308987113, 5787.189793428924, 5791.507721843648, 14927.0, 18122.546936326566, 20862.06120724571, 23560.175393861304, 23748.881255593784, 2379.084052639746, 3032.33288676493, 3037.9392412151856, 3075.7696921231463, 3084.629844418684, 10793.352398856015, 10857.185711071623, 11168.0, 11401.48693308803, 11427.828582571268, 1868.6169335286233, 1878.1078987480837, 1883.3802929480635, 1938.3022112039655, 1948.1233444949687, 84456.57771711164, 85123.57438212831, 85844.57077714633, 86079.0, 87120.99999999936, 11525.76948461026, 11601.825972610417, 11970.00749812547, 12046.156769026084, 12178.512859485698, 17092.316307347817, 17094.230759615846, 17147.056911869717, 17171.656566868594, 17187.828121718874, 8853.38026338163, 8880.911190888137, 8977.102289771101, 9019.774505637411, 9062.546872656472, 8556.914430855737, 8595.245077815509, 8597.398182127316, 8774.341924355698, 8888.73333799987, 5029.698218106925, 5094.2358646203365, 5138.434772175057, 5150.304708864255, 5196.324477817935, 2078.8752674839557, 2113.3026101386504, 2126.8404869634837, 2138.240924471821, 2139.069504765432, 981.7741919358588, 1026.3790406803926, 1042.8435734639866, 1048.984265236022, 1053.7365658585354, 19623.60752784965, 19835.50411239702, 20222.191112355635, 20350.512683484536, 20781.792182078287, 972.1493693018608, 979.6326377608397, 1017.8066167428165, 1020.1787561013456, 1038.3925403638805, 10453.895461045444, 11447.599334023436, 11454.370009649549, 11502.597409090642, 11520.654380368602, 470965.0, 477239.0, 477462.0, 479360.0, 490858.0, 56834.14748778772, 59705.40294596998, 91074.0, 93801.0, 94879.52560237155, 1018.9745256368502, 1062.0759938853093, 1073.683263437288, 1097.5554900265245, 1099.219554116586, 17377.304907803547, 17907.283708651506, 18052.819471805113, 18314.358997435025, 18447.0, 30628.84685576558, 42892.35661465018, 42965.355519666606, 43290.35064473972, 44498.0, 52631.0, 55057.0, 56957.43042569521, 61421.692891535255, 61712.38287617066, 8438.198371154731, 8968.417052891542, 8980.101989800967, 9020.278377729897, 9047.547622618711, 6253.874922501615, 10780.784384312114, 13364.866351336363, 13451.529196478075, 13452.39464224132, 11623.825642615537, 11722.76554468923, 11817.468213930566, 11836.881631183578, 12403.25580465175, 11483.196176267582, 11567.595134170264, 11612.6516204514, 11651.359175245443, 12148.149629526202, 11785.410729463321, 11826.881731182923, 11939.82090268664, 11973.521059157536, 12404.379781011094, 8696.391252612257, 8834.558272086499, 8891.422057566237, 8948.060453652533, 8954.731358059269, 10557.577696892038, 11684.240524365889, 11716.765664686489, 12188.756224875275, 12259.0], "value": 9485.356750495272, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1170.1984140863503, 1457.0, 1504.7818066380376, 1585.61945133168, 1779.4839496545994, 7209.423246140303, 7755.108162561307, 7956.84086318274, 7957.0, 8322.875156872637, 7996.240357166074, 8012.799680008003, 8015.839683206333, 8021.438499305051, 8024.91975080249, 2371.075280640547, 2395.7244916834525, 2397.3407312988893, 2397.4246180916543, 2398.388410955204, 2343.121329501437, 2376.144587948337, 2427.9150229741963, 2429.829911906167, 2430.149447693311, 2335.92992210234, 2344.519373528431, 2362.751911049341, 2378.6194208926577, 2380.059876348841, 2329.848559843622, 2348.5537747827857, 2350.82368822339, 2379.44083140461, 2380.0, 2400.951980960371, 2418.6372044193513, 2455.84037037592, 2457.373369790692, 2458.6723169488455, 8279.50322980623, 8296.709615163501, 8303.709370172015, 8355.874661880076, 8387.370947178986, 5066.771995260222, 5240.764165612557, 5303.602229832778, 5308.0, 5326.0, 3251.3497300539752, 3297.422950983568, 3376.881809136693, 3385.5937287525408, 3484.285721427101, 1107.1087774341652, 1123.7359220583157, 1131.247720266022, 1133.2973556395004, 1135.40391294571, 11317.83023254652, 11320.433978301135, 11402.543898244143, 11421.42892855354, 11465.541378344857, 4155.97922010388, 4455.576720211575, 4487.125010622897, 4518.683692141584, 4545.659075569345, 9271.768205794775, 9286.210672092948, 9291.349605527683, 9295.488748118918, 9299.0, 5283.128283833202, 5283.365996080495, 5286.312779338738, 5287.101192797234, 5298.682079075268, 4271.743695378287, 4276.444062271885, 4332.285172946492, 4418.2047231498, 4968.6025117990475, 3853.9421908671393, 3909.863154789569, 4018.819153138116, 4032.274190645653, 4037.9192416151513, 1212.351392005273, 1217.6955761059735, 1218.3238302742063, 1226.1539537718945, 1234.7530493901256, 843.7089204224533, 928.4290161550598, 929.874466946967, 948.4878165790534, 953.3136141977765, 5527.226188333637, 5685.857853553694, 5874.236349274567, 5913.319968203712, 5972.432618901197, 860.1914200651493, 876.6712482818942, 906.2161230535539, 927.1377618814568, 939.5067589515559, 3755.549334079928, 4069.0, 4155.501339839238, 4201.0, 4205.243056249843, 10126.44304563256, 10371.792564148825, 10481.685549433529, 10488.05607495329, 10490.05589496949, 9654.56554455037, 9762.90237097634, 9893.45585992763, 10389.94805025985, 10393.792124157626, 7746.728864489716, 7751.263629955145, 7847.843043139105, 7907.841843163104, 7949.324307433817, 5353.705546194997, 5559.555235581063, 5765.155150352015, 5866.970665146647, 6006.819795406145, 9192.724218273463, 9206.677766278148, 9283.907160928304, 9323.860142097737, 9437.386569872937, 8095.150009248944, 9037.277017838689, 9424.575894084646, 9529.714108576754, 9551.235901128031, 7231.63841807897, 7428.4800063995, 7437.219091995263, 7442.665080071518, 7448.366888814511, 7841.921580784119, 7930.088039875488, 7954.602269886367, 8255.25702686737, 8257.174282571696, 7240.312170343809, 7250.637468126678, 7253.419726421979, 7261.382782463338, 7496.887546686913, 7278.454115941219, 7290.467304561801, 7424.071991001125, 7437.219091995479, 7509.286617771303, 6416.422521973045, 6426.068220108152, 6465.062565928009, 6474.773382931575, 6498.64257465825, 4957.429895562056, 5116.283720279238, 5122.769475373691, 5196.064708352382, 5233.39815921174, 4959.082569724613, 5024.42219144803, 5050.646454748133, 5150.819721309736, 5161.225816127611], "value": 4476.855566450209, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.1327774342197, 336.4028848793391, 347.37299174989136, 350.94560343146804, 353.639287926315, 5319.377589835099, 5329.333833270836, 5375.3280839895015, 5390.91913621295, 5403.135498320269, 5063.202563090105, 5120.539151476366, 5197.974010129944, 5199.324087868581, 5223.843284701456, 4195.85314513992, 4196.160767846428, 4212.389203565481, 4217.810198541065, 4241.384999175118, 4204.705670603059, 4242.193983143208, 4258.957410425887, 4260.616544510994, 4278.507971583276, 3932.654292366529, 4080.367543030835, 4098.774567398792, 4183.698965568925, 4187.560306167854, 4190.329547272452, 4191.1827193697245, 4193.81127849246, 4195.832166713343, 4201.684873634459, 3735.1782607826235, 3752.362098443244, 3760.7743535387963, 3764.3976963685955, 3796.7152463565344, 5014.84955451337, 5134.563562097189, 5144.305518754958, 5148.6910785353, 5154.433012368637, 4749.57253847152, 4768.213244814601, 4793.5925446337105, 4806.231003039532, 4823.083614113307, 5481.397046324901, 5518.558515318765, 5520.861978450531, 5552.305961754781, 5567.387587365387, 4089.591040895916, 4113.9794301028605, 4125.360569111793, 4132.367714752656, 4156.376543518496, 5654.886902261973, 5684.34630017545, 5700.149925037481, 5715.31416230055, 5720.370759216483, 4238.682098842599, 4243.151369726067, 4273.0385663225525, 4276.72201306914, 4298.46269216348, 4226.873193804191, 4228.936565951513, 4279.422277992431, 4284.228838808982, 4335.436393268855, 4726.71639701619, 4774.474807771142, 4786.880327991828, 4806.95193048072, 4818.397700287464, 5508.697021663847, 5521.641093328921, 5522.039675915073, 5571.637843540238, 5576.414476479992, 1358.809766632672, 1416.221078406872, 1437.1808069400342, 1445.4651778841896, 1459.2047334202884, 966.8259713251682, 980.843065109579, 981.4896253947907, 1029.6036026129993, 1060.8514807926897, 5191.844244672666, 5209.270702101709, 5236.24074509194, 5239.869003274948, 5311.787528498894, 5367.4364191759305, 5462.235287059815, 5508.338999320107, 5512.5589952803675, 5513.641613295204, 5173.3533308336455, 5184.533391994739, 5191.32512773337, 5192.688438693691, 5204.843854684365, 2896.826190428581, 2910.3742695320607, 2912.5922370868097, 2918.0, 2924.3420230448405, 5463.699496527729, 5591.776328946878, 5626.634268772516, 5628.521575666115, 5651.208830763697, 5443.265159203536, 5511.200875872976, 5522.861928451741, 5530.834074977757, 5547.5007249347755, 5571.275734154534, 5635.380108188096, 5640.379558248589, 5722.113072473773, 5726.942730572724, 5377.8924421510565, 5407.83776486706, 5674.645022315693, 5711.828645140652, 5712.857178570569, 5658.5473162147755, 5679.574031947538, 5683.261176047087, 5691.630044047124, 5707.857303567444, 5660.490555849993, 5877.647341159544, 5897.3807750187325, 5903.173555702291, 5909.261342332208, 4088.2232375848494, 4119.608637179464, 4154.273002224659, 4170.311898536707, 4172.269852775813, 5703.315602127605, 5735.369109398046, 5746.396628353963, 5748.195252664546, 5748.942510575008, 5532.419095995024, 5594.608377413542, 5612.522935550524, 5683.715814209356, 5688.516476099412, 5561.332640083054, 5566.359868615161, 5567.77728890856, 5573.693446860461, 5576.60963732551, 5315.973420132875, 5450.373207081077, 5470.152126420411, 5521.033819081725, 5546.251256080377, 5245.973770131278, 5425.206018900349, 5550.69471179089, 5600.431879073866, 5608.803691870929, 5423.972880135574, 5458.6724796512335, 5462.91805622908, 5466.972665136649, 5483.835484935458], "value": 4248.8054929263335, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [794.5788731972053, 804.5494523067086, 814.9470284431511, 815.4210510537516, 830.9792255193623, 14221.21783301918, 15053.494650534942, 15062.698746025073, 15080.77378839317, 15239.542813715592, 13793.655158621039, 13846.584602461917, 13868.722625547483, 13873.514426995058, 13883.236421996811, 705.989410158848, 719.8380364418016, 818.2186012358184, 844.3371953016883, 847.3009766942266, 850.2093053460279, 851.0383266908385, 851.2466467176531, 851.2636569367484, 851.4167795060373, 879.6217626420637, 882.1663527966075, 882.2060145868737, 882.7748924024397, 883.9867401988976, 737.5242968285453, 749.7488341405635, 858.9570521473933, 865.1348651348651, 878.5124256037897, 651.0787236060968, 651.2087813306807, 651.456034211434, 651.5634524868302, 652.0968458684756, 13421.731565368736, 13730.176189428666, 13732.794008089886, 13752.449902003907, 13769.31153442334, 13487.123336983064, 13724.45102195911, 13904.679055489814, 14241.643958901006, 14260.215688137148, 12774.808377874338, 12802.551910683174, 12944.676383090498, 13161.144525605805, 13247.403866826016, 4198.517170525398, 4212.13651201506, 4283.082667567041, 4294.055307832272, 4304.80628371724, 64654.67672661653, 65541.0, 66028.33971660318, 66315.66842165854, 67194.32805671978, 10817.675469735921, 10829.67510974672, 10911.727206819893, 10930.726731831768, 11039.503222355013, 21095.78904210969, 21105.155793768383, 21167.576648467253, 21242.300615950688, 21488.677669834964, 7763.72826951054, 8019.719309824245, 8261.463004904663, 8281.668733250723, 8307.6676932922, 4506.256467682796, 4653.278741795028, 4670.089332580183, 4806.447258565309, 4837.685550439211, 3306.123877172503, 3408.233147541783, 3409.09658940381, 3411.4712219606, 3413.4538473844564, 543.2937181663822, 593.0955293177938, 598.9580729348991, 600.540586451365, 601.1643815097019, 603.6951339573487, 622.8287221014257, 645.1258544671902, 672.1363048482676, 720.121451828768, 9478.763030924145, 9569.421000589366, 9610.327277090677, 9748.0, 9817.607295708234, 720.8738470767595, 724.344468256229, 726.0923845193508, 743.5427212264418, 746.3506749128185, 4169.0, 4378.649708023414, 4413.205622987829, 4434.490033646172, 4500.594946454835, 88928.55535722409, 89122.68776521087, 93109.20672379703, 96061.5196924011, 97923.51038244762, 56141.7192914041, 64727.0, 84361.57819210865, 85199.5740021296, 85697.57151214329, 74030.62984685042, 74955.0, 75035.62482187663, 75117.0, 77423.61288193523, 8557.272631826365, 8585.399022068645, 8751.64993400257, 8826.382153249468, 8841.292696584129, 51337.48662513476, 51359.74320128375, 51715.0, 51745.96508069893, 51864.222036668725, 63327.683361582895, 69991.30008699848, 70506.64746676439, 71853.64073179601, 72498.27501725126, 11248.21262511649, 11309.208355415041, 11497.137714671266, 11651.41742912868, 12413.255204687748, 13440.395182216627, 13581.45674173022, 13774.724505509634, 13932.93033534826, 14319.713605728035, 10598.523066461874, 13006.284654344103, 13795.517156899461, 13919.721605568035, 13943.372548235557, 13695.863041369857, 14264.786028209794, 14323.641908951942, 14528.346224420138, 14531.0, 12978.415971281127, 13298.268595227355, 13339.132956357806, 13952.093113947562, 14363.856361436252, 9738.0, 10155.54300056514, 10239.590416383262, 10339.896601033894, 11463.484143213409, 11320.320780753182, 11606.767864642828, 11640.94179529097, 11664.94167529157, 11874.228175168586], "value": 7275.748765504898, "unit": "score"}], "name": "dromaeo_css", "value": 7319.851387801194, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 110.0, 113.0, 111.0, 112.0, 111.0, 111.0, 114.0, 113.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 117.0, 118.0, 154.0, 119.0, 122.0, 119.0, 119.0, 147.0, 117.0], "value": 127.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 161.0, 160.0, 159.0, 161.0, 163.0, 160.0, 159.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 112.0, 75.0, 76.0, 76.0, 74.0, 98.0, 76.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 121.0, 83.0, 82.0, 81.0, 98.0, 82.0, 82.0, 107.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 118.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 84.0, 84.0, 84.0, 85.0, 84.0, 84.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 50.0, 49.0, 50.0, 58.0, 50.0, 49.0, 50.0, 50.0], "value": 50.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 60.0, 59.0, 60.0, 59.0, 59.0, 59.0, 60.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 80.0, 75.0, 76.0, 75.0, 76.0, 74.0, 74.0, 75.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 122.0, 138.0, 123.0, 131.0, 129.0, 120.0, 120.0, 161.0, 125.0], "value": 129.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 153.0, 156.0, 164.0, 152.0, 154.0, 155.0, 153.0, 151.0, 156.0], "value": 154.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 62.0, 62.0, 67.0, 61.0, 67.0, 61.0, 61.0, 60.0, 60.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1448.9, "alertThreshold": 2.0}]} 08:16:41 INFO - Return code: 0 08:16:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:16:41 INFO - # TBPL SUCCESS # 08:16:41 INFO - Running post-action listener: _resource_record_post_action 08:16:41 INFO - [mozharness: 2016-12-21 16:16:41.856851Z] Finished run-tests step (success) 08:16:41 INFO - Running post-run listener: _resource_record_post_run 08:16:41 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 8617984; Write bytes: 376754176; Read time: 3208; Write time: 342040 08:16:41 INFO - TinderboxPrint: CPU usage
13.0% 08:16:41 INFO - TinderboxPrint: I/O read bytes / time
8,617,984 / 3,208 08:16:41 INFO - TinderboxPrint: I/O write bytes / time
376,754,176 / 342,040 08:16:41 INFO - TinderboxPrint: CPU idle
8,304.7 (87.0%) 08:16:41 INFO - TinderboxPrint: CPU user
1,190.4 (12.5%) 08:16:41 INFO - TinderboxPrint: Swap in / out
0 / 0 08:16:41 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 80023552; Read time: 0; Write time: 59644 08:16:41 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 6488064; Write bytes: 252788736; Read time: 2668; Write time: 207580 08:16:42 INFO - Running post-run listener: _upload_blobber_files 08:16:42 INFO - Blob upload gear active. 08:16:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:16:42 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:16:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:16:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:16:42 INFO - (blobuploader) - INFO - Open directory for files ... 08:16:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:16:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:16:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:16:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:16:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:16:43 INFO - (blobuploader) - INFO - Done attempting. 08:16:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:16:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:16:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:16:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:16:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:16:45 INFO - (blobuploader) - INFO - Done attempting. 08:16:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:16:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:16:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:16:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:16:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:16:48 INFO - (blobuploader) - INFO - Done attempting. 08:16:48 INFO - (blobuploader) - INFO - Iteration through files over. 08:16:48 INFO - Return code: 0 08:16:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:16:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:16:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd2711c606fe3a70dea88b82ac120a112d130f7132ab85006fb9b6a068d2d19e6e58eaa423e7cee6bfb7525f5fa23a6cb1357bcaeec238aa1088ef16628974b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/055b58aa405e22d69e1baf42ebd86e880ffdff5d459d051d3ac41e3df38745d675af5fa5796c4867f26e89e4ffaad1da946073d29c8af89ccf015faf1cdc150a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3630de4d0857b80432b20477dfb0a5dd8cb3baaf6b297a98468912a7f22af7c8729db42cd58859faa93589a1e519642c0e1624b9ecec5614ceb924f49dfff93c"} 08:16:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:16:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:16:48 INFO - Contents: 08:16:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd2711c606fe3a70dea88b82ac120a112d130f7132ab85006fb9b6a068d2d19e6e58eaa423e7cee6bfb7525f5fa23a6cb1357bcaeec238aa1088ef16628974b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/055b58aa405e22d69e1baf42ebd86e880ffdff5d459d051d3ac41e3df38745d675af5fa5796c4867f26e89e4ffaad1da946073d29c8af89ccf015faf1cdc150a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3630de4d0857b80432b20477dfb0a5dd8cb3baaf6b297a98468912a7f22af7c8729db42cd58859faa93589a1e519642c0e1624b9ecec5614ceb924f49dfff93c"} 08:16:48 INFO - Running post-run listener: copy_logs_to_upload_dir 08:16:48 INFO - Copying logs to upload dir... 08:16:48 INFO - mkdir: /builds/slave/test/build/upload/logs 08:16:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.617456 ========= master_lag: 0.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-12-21 08:16:49.092756) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 08:16:49.095975) ========= 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=17051fcd5208b27b50bedfeb000001dd-1482335624.985035-1704448650 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd2711c606fe3a70dea88b82ac120a112d130f7132ab85006fb9b6a068d2d19e6e58eaa423e7cee6bfb7525f5fa23a6cb1357bcaeec238aa1088ef16628974b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/055b58aa405e22d69e1baf42ebd86e880ffdff5d459d051d3ac41e3df38745d675af5fa5796c4867f26e89e4ffaad1da946073d29c8af89ccf015faf1cdc150a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3630de4d0857b80432b20477dfb0a5dd8cb3baaf6b297a98468912a7f22af7c8729db42cd58859faa93589a1e519642c0e1624b9ecec5614ceb924f49dfff93c"} build_url:https://queue.taskcluster.net/v1/task/alJ5DbOnSoWeZ5A4hTVqaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011274 build_url: 'https://queue.taskcluster.net/v1/task/alJ5DbOnSoWeZ5A4hTVqaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd2711c606fe3a70dea88b82ac120a112d130f7132ab85006fb9b6a068d2d19e6e58eaa423e7cee6bfb7525f5fa23a6cb1357bcaeec238aa1088ef16628974b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/055b58aa405e22d69e1baf42ebd86e880ffdff5d459d051d3ac41e3df38745d675af5fa5796c4867f26e89e4ffaad1da946073d29c8af89ccf015faf1cdc150a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3630de4d0857b80432b20477dfb0a5dd8cb3baaf6b297a98468912a7f22af7c8729db42cd58859faa93589a1e519642c0e1624b9ecec5614ceb924f49dfff93c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 08:16:49.121247) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 08:16:49.121581) ========= 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=17051fcd5208b27b50bedfeb000001dd-1482335624.985035-1704448650 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004405 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 08:16:49.206479) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 08:16:49.206797) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 08:16:49.207090) ========= ========= Total master_lag: 0.32 =========