builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1484959515.0 results: success (0) buildid: 20170120144225 builduid: c1215c97759d498b8e1479f8270be8af revision: ccec56819e76733f28ae7f046e4602824ddbed10 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-20 16:45:15.001952) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-20 16:45:15.002458) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-20 16:45:15.002754) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-20 16:45:15.017482) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 16:45:15.017822) ========= 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=20e666a3d4cfbb71505a330e000001b4-1484959514.572678-2134908636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-20 16:45:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2017-01-20 16:45:15 (46.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.087238 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 16:45:15.118892) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 16:45:15.119223) ========= 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=20e666a3d4cfbb71505a330e000001b4-1484959514.572678-2134908636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013472 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 16:45:15.168763) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-20 16:45:15.169122) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ccec56819e76733f28ae7f046e4602824ddbed10 --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 ccec56819e76733f28ae7f046e4602824ddbed10 --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=20e666a3d4cfbb71505a330e000001b4-1484959514.572678-2134908636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-20 16:45:15,376 truncating revision to first 12 chars 2017-01-20 16:45:15,376 Setting DEBUG logging. 2017-01-20 16:45:15,376 attempt 1/10 2017-01-20 16:45:15,376 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ccec56819e76?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-20 16:45:16,790 unpacking tar archive at: mozilla-aurora-ccec56819e76/testing/mozharness/ program finished with exit code 0 elapsedTime=1.701661 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-20 16:45:16.884555) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-20 16:45:16.885044) ========= script_repo_revision: ccec56819e76733f28ae7f046e4602824ddbed10 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-20 16:45:16.885459) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-20 16:45:16.885752) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-20 16:45:16.894985) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-20 16:45:16.895267) ========= /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=20e666a3d4cfbb71505a330e000001b4-1484959514.572678-2134908636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:45:17 INFO - MultiFileLogger online at 20170120 16:45:17 in /builds/slave/test 16:45:17 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 16:45:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:45:17 INFO - {'append_to_log': False, 16:45:17 INFO - 'base_work_dir': '/builds/slave/test', 16:45:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:45:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:45:17 INFO - 'branch': 'Mozilla-Aurora', 16:45:17 INFO - 'buildbot_json_path': 'buildprops.json', 16:45:17 INFO - 'config_files': ('talos/linux_config.py',), 16:45:17 INFO - 'default_actions': ('clobber', 16:45:17 INFO - 'read-buildbot-config', 16:45:17 INFO - 'download-and-extract', 16:45:17 INFO - 'populate-webroot', 16:45:17 INFO - 'create-virtualenv', 16:45:17 INFO - 'install', 16:45:17 INFO - 'run-tests'), 16:45:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:45:17 INFO - 'download_minidump_stackwalk': True, 16:45:17 INFO - 'download_symbols': 'ondemand', 16:45:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:45:17 INFO - 'tooltool.py': '/tools/tooltool.py', 16:45:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:45:17 INFO - '/tools/misc-python/virtualenv.py')}, 16:45:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:45:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:45:17 INFO - 'installer_path': 'installer.exe', 16:45:17 INFO - 'log_level': 'info', 16:45:17 INFO - 'log_name': 'talos', 16:45:17 INFO - 'log_to_console': True, 16:45:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:45:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:45:17 INFO - 'opt_config_files': (), 16:45:17 INFO - 'pip_index': False, 16:45:17 INFO - 'sps_profile': False, 16:45:17 INFO - 'sps_profile_interval': 0, 16:45:17 INFO - 'suite': 'dromaeojs', 16:45:17 INFO - 'system_bits': '32', 16:45:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:45:17 INFO - 'title': 'talos-linux64-ix-015', 16:45:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:45:17 INFO - 'use_talos_json': True, 16:45:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:45:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:45:17 INFO - 'work_dir': 'build'} 16:45:17 INFO - [mozharness: 2017-01-21 00:45:17.204339Z] Running clobber step. 16:45:17 INFO - Running pre-action listener: _resource_record_pre_action 16:45:17 INFO - Running main action method: clobber 16:45:17 INFO - rmtree: /builds/slave/test/build 16:45:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:45:18 INFO - Running post-action listener: _resource_record_post_action 16:45:18 INFO - [mozharness: 2017-01-21 00:45:18.237675Z] Finished clobber step (success) 16:45:18 INFO - [mozharness: 2017-01-21 00:45:18.237772Z] Running read-buildbot-config step. 16:45:18 INFO - Running pre-action listener: _resource_record_pre_action 16:45:18 INFO - Running main action method: read_buildbot_config 16:45:18 INFO - Using buildbot properties: 16:45:18 INFO - { 16:45:18 INFO - "project": "", 16:45:18 INFO - "product": "firefox", 16:45:18 INFO - "script_repo_revision": "production", 16:45:18 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 16:45:18 INFO - "repository": "", 16:45:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 16:45:18 INFO - "buildid": "20170120144225", 16:45:18 INFO - "pgo_build": "True", 16:45:18 INFO - "basedir": "/builds/slave/test", 16:45:18 INFO - "buildnumber": 747, 16:45:18 INFO - "slavename": "talos-linux64-ix-015", 16:45:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:45:18 INFO - "platform": "ubuntu64_hw", 16:45:18 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 16:45:18 INFO - "branch": "mozilla-aurora", 16:45:18 INFO - "repo_path": "releases/mozilla-aurora", 16:45:18 INFO - "revision": "ccec56819e76733f28ae7f046e4602824ddbed10", 16:45:18 INFO - "stage_platform": "linux64-pgo", 16:45:18 INFO - "builduid": "c1215c97759d498b8e1479f8270be8af", 16:45:18 INFO - "slavebuilddir": "test" 16:45:18 INFO - } 16:45:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/Sm25fwRATh24pTgFKOjQWQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 16:45:18 INFO - Running post-action listener: _resource_record_post_action 16:45:18 INFO - [mozharness: 2017-01-21 00:45:18.240155Z] Finished read-buildbot-config step (success) 16:45:18 INFO - [mozharness: 2017-01-21 00:45:18.240242Z] Running download-and-extract step. 16:45:18 INFO - Running pre-action listener: _resource_record_pre_action 16:45:18 INFO - Running main action method: download_and_extract 16:45:18 INFO - mkdir: /builds/slave/test/build/tests 16:45: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')]} 16:45:18 INFO - trying https://queue.taskcluster.net/v1/task/Sm25fwRATh24pTgFKOjQWQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 16:45:18 INFO - Downloading https://queue.taskcluster.net/v1/task/Sm25fwRATh24pTgFKOjQWQ/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 16:45:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Sm25fwRATh24pTgFKOjQWQ/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 16:45:18 INFO - Downloaded 1361 bytes. 16:45:18 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 16:45:18 INFO - Using the following test package requirements: 16:45:18 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 16:45:18 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 16:45:18 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 16:45:18 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 16:45:18 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 16:45:18 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 16:45:18 INFO - u'jsshell-linux-x86_64.zip'], 16:45:18 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 16:45:18 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 16:45:18 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 16:45:18 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 16:45:18 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 16:45:18 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 16:45:18 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 16:45:18 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 16:45:18 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 16:45:18 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 16:45:18 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 16:45:18 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:45:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Sm25fwRATh24pTgFKOjQWQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 16:45:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Sm25fwRATh24pTgFKOjQWQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:45:18 INFO - Fetch https://queue.taskcluster.net/v1/task/Sm25fwRATh24pTgFKOjQWQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 16:45:19 INFO - Http code: 200 16:45:19 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 16:45:19 INFO - x-amz-cf-id: 7BxxPKAGSB7ncbtDJze00eqm6Ua8VW_LW6BK5M6jELHErKlhNflv7w== 16:45:19 INFO - x-amz-version-id: XjwleljT3KUm0eCww7ysNKIHBugyDQyE 16:45:19 INFO - Expected file size: 21948007 16:45:19 INFO - Obtained file size: 21948007 16:45:23 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 16:45:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Sm25fwRATh24pTgFKOjQWQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 16:45:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Sm25fwRATh24pTgFKOjQWQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:45:23 INFO - Fetch https://queue.taskcluster.net/v1/task/Sm25fwRATh24pTgFKOjQWQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 16:45:24 INFO - Http code: 200 16:45:24 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 16:45:24 INFO - x-amz-cf-id: SbWdrmMwJjZbbQz87de5O7IruYdLbzYF8ohkxmQ4mCB04VXvW0y79A== 16:45:24 INFO - x-amz-version-id: XjwleljT3KUm0eCww7ysNKIHBugyDQyE 16:45:24 INFO - Expected file size: 21948007 16:45:24 INFO - Obtained file size: 21948007 16:45:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Sm25fwRATh24pTgFKOjQWQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 16:45:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Sm25fwRATh24pTgFKOjQWQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:45:28 INFO - Fetch https://queue.taskcluster.net/v1/task/Sm25fwRATh24pTgFKOjQWQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 16:45:29 INFO - Http code: 200 16:45:29 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 16:45:29 INFO - x-amz-cf-id: VJRtChFkNMC8dVuJgoZIVEL2OVerbbQC2TOnqOeorslRQ-W82z004Q== 16:45:29 INFO - x-amz-version-id: 2FIkjJxgmtACCgc1oJCtpWa9Y5IJaz2u 16:45:29 INFO - Expected file size: 14402992 16:45:29 INFO - Obtained file size: 14402992 16:45:29 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')]} 16:45:29 INFO - trying https://queue.taskcluster.net/v1/task/Sm25fwRATh24pTgFKOjQWQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 16:45:29 INFO - Downloading https://queue.taskcluster.net/v1/task/Sm25fwRATh24pTgFKOjQWQ/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 16:45:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Sm25fwRATh24pTgFKOjQWQ/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 16:45:31 INFO - Downloaded 64207335 bytes. 16:45:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Sm25fwRATh24pTgFKOjQWQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 16:45:31 INFO - mkdir: /builds/slave/test/properties 16:45:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:45:31 INFO - Writing to file /builds/slave/test/properties/build_url 16:45:31 INFO - Contents: 16:45:31 INFO - build_url:https://queue.taskcluster.net/v1/task/Sm25fwRATh24pTgFKOjQWQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 16:45:31 INFO - Running post-action listener: _resource_record_post_action 16:45:31 INFO - Running post-action listener: set_extra_try_arguments 16:45:31 INFO - [mozharness: 2017-01-21 00:45:31.676269Z] Finished download-and-extract step (success) 16:45:31 INFO - [mozharness: 2017-01-21 00:45:31.676497Z] Running populate-webroot step. 16:45:31 INFO - Running pre-action listener: _resource_record_pre_action 16:45:31 INFO - Running main action method: populate_webroot 16:45:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:45:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:45:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:45:31 INFO - '--tppagecycles', 16:45:31 INFO - '7'], 16:45:31 INFO - 'tests': ['tsvgm']}}, 16:45:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:45:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:45:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:45:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:45:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:45:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:45:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:31 INFO - 'talos_options': ['--disable-e10s'], 16:45:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:45:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:45:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:31 INFO - 'talos_options': ['--disable-e10s'], 16:45:31 INFO - 'tests': ['damp', 'tps']}, 16:45:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:31 INFO - 'tests': ['damp', 'tps']}, 16:45:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:45:31 INFO - 'tests': ['dromaeo_dom']}, 16:45:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:45:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:45:31 INFO - 'tests': ['basic_compositor_video']}, 16:45:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:45:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:45:31 INFO - 'tests': ['a11yr', 16:45:31 INFO - 'ts_paint', 16:45:31 INFO - 'tpaint', 16:45:31 INFO - 'sessionrestore', 16:45:31 INFO - 'sessionrestore_no_auto_restore', 16:45:31 INFO - 'tabpaint']}, 16:45:31 INFO - 'other-e10s': {'tests': ['a11yr', 16:45:31 INFO - 'ts_paint', 16:45:31 INFO - 'tpaint', 16:45:31 INFO - 'sessionrestore', 16:45:31 INFO - 'sessionrestore_no_auto_restore', 16:45:31 INFO - 'tabpaint']}, 16:45:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:45:31 INFO - 'ts_paint', 16:45:31 INFO - 'tpaint', 16:45:31 INFO - 'sessionrestore', 16:45:31 INFO - 'sessionrestore_no_auto_restore', 16:45:31 INFO - 'tabpaint']}, 16:45:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:45:31 INFO - 'ts_paint', 16:45:31 INFO - 'tpaint', 16:45:31 INFO - 'sessionrestore', 16:45:31 INFO - 'sessionrestore_no_auto_restore', 16:45:31 INFO - 'tabpaint']}, 16:45:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:45:31 INFO - 'tests': ['a11yr', 16:45:31 INFO - 'ts_paint', 16:45:31 INFO - 'tpaint', 16:45:31 INFO - 'sessionrestore', 16:45:31 INFO - 'sessionrestore_no_auto_restore', 16:45:31 INFO - 'tabpaint']}, 16:45:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:45:31 INFO - 'tests': ['a11yr', 16:45:31 INFO - 'ts_paint', 16:45:31 INFO - 'tpaint', 16:45:31 INFO - 'sessionrestore', 16:45:31 INFO - 'sessionrestore_no_auto_restore', 16:45:31 INFO - 'tabpaint']}, 16:45:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:45:31 INFO - 'tests': ['tsvgx', 16:45:31 INFO - 'tsvgr_opacity', 16:45:31 INFO - 'tart', 16:45:31 INFO - 'tscrollx', 16:45:31 INFO - 'cart']}, 16:45:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:45:31 INFO - 'tsvgr_opacity', 16:45:31 INFO - 'tart', 16:45:31 INFO - 'tscrollx', 16:45:31 INFO - 'cart']}, 16:45:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:31 INFO - 'talos_options': ['--disable-e10s'], 16:45:31 INFO - 'tests': ['tp5o']}, 16:45:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:31 INFO - 'tests': ['tp5o']}, 16:45:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:31 INFO - 'talos_options': ['--disable-e10s', 16:45:31 INFO - '--xperf_path', 16:45:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:45:31 INFO - 'tests': ['tp5n']}, 16:45:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:31 INFO - 'talos_options': ['--xperf_path', 16:45:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:45:31 INFO - 'tests': ['tp5n']}}, 16:45:31 INFO - 'talos.zip': {'path': '', 16:45:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:45:31 INFO - Running post-action listener: _resource_record_post_action 16:45:31 INFO - [mozharness: 2017-01-21 00:45:31.695160Z] Finished populate-webroot step (success) 16:45:31 INFO - [mozharness: 2017-01-21 00:45:31.695247Z] Running create-virtualenv step. 16:45:31 INFO - Running pre-action listener: _resource_record_pre_action 16:45:31 INFO - Running main action method: create_virtualenv 16:45:31 INFO - Creating virtualenv /builds/slave/test/build/venv 16:45:31 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 16:45:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:45:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:45:31 INFO - Using real prefix '/usr' 16:45:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:45:32 INFO - Installing distribute.............................................................................................................................................................................................done. 16:45:34 INFO - Installing pip.................done. 16:45:34 INFO - Return code: 0 16:45:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:45:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:45:34 INFO - Reading from file tmpfile_stdout 16:45:34 INFO - Output received: 16:45:34 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) 16:45:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:45: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')]} 16:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45: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')]} 16:45:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f64aa685f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1386ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1383f60>, '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 0x1384d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13851d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1484959514.572678-2134908636', '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 16:45: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', 'pip>=1.5'] in /builds/slave/test/build 16:45: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 pip>=1.5 16:45:34 INFO - Using env: {'DISPLAY': ':0', 16:45:34 INFO - 'HOME': '/home/cltbld', 16:45:34 INFO - 'LANG': 'en_US.UTF-8', 16:45:34 INFO - 'LANGUAGE': 'en_US:en', 16:45:34 INFO - 'LOGNAME': 'cltbld', 16:45:34 INFO - 'MAIL': '/var/mail/cltbld', 16:45:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:34 INFO - 'MOZ_NO_REMOTE': '1', 16:45:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:34 INFO - 'NO_EM_RESTART': '1', 16:45:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:34 INFO - 'PWD': '/builds/slave/test', 16:45:34 INFO - 'SHELL': '/bin/bash', 16:45:34 INFO - 'SHLVL': '1', 16:45:34 INFO - 'TERM': 'linux', 16:45:34 INFO - 'TMOUT': '86400', 16:45:34 INFO - 'USER': 'cltbld', 16:45:34 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1484959514.572678-2134908636', 16:45:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:34 INFO - '_': '/tools/buildbot/bin/python'} 16:45:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:34 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 16:45:34 INFO - Cleaning up... 16:45:34 INFO - Return code: 0 16:45:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:45: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')]} 16:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45: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')]} 16:45:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45: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', '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 0x7f64aa685f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1386ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1383f60>, '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 0x1384d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13851d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1484959514.572678-2134908636', '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 16:45: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', 'psutil>=3.1.1'] in /builds/slave/test/build 16:45: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 psutil>=3.1.1 16:45:34 INFO - Using env: {'DISPLAY': ':0', 16:45:34 INFO - 'HOME': '/home/cltbld', 16:45:34 INFO - 'LANG': 'en_US.UTF-8', 16:45:34 INFO - 'LANGUAGE': 'en_US:en', 16:45:34 INFO - 'LOGNAME': 'cltbld', 16:45:34 INFO - 'MAIL': '/var/mail/cltbld', 16:45:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:34 INFO - 'MOZ_NO_REMOTE': '1', 16:45:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:34 INFO - 'NO_EM_RESTART': '1', 16:45:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:34 INFO - 'PWD': '/builds/slave/test', 16:45:34 INFO - 'SHELL': '/bin/bash', 16:45:34 INFO - 'SHLVL': '1', 16:45:34 INFO - 'TERM': 'linux', 16:45:34 INFO - 'TMOUT': '86400', 16:45:34 INFO - 'USER': 'cltbld', 16:45:34 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1484959514.572678-2134908636', 16:45:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:34 INFO - '_': '/tools/buildbot/bin/python'} 16:45:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:34 INFO - Downloading/unpacking psutil>=3.1.1 16:45: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 16:45: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 16:45: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 16:45: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 16:45: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 16:45: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 16:45:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:45:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:45:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:45:37 INFO - Installing collected packages: psutil 16:45:37 INFO - Running setup.py install for psutil 16:45:37 INFO - building 'psutil._psutil_linux' extension 16:45:37 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 16:45:37 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 16:45:37 INFO - building 'psutil._psutil_posix' extension 16:45:37 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 16:45:37 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 16:45:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:45:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:45:37 INFO - Successfully installed psutil 16:45:37 INFO - Cleaning up... 16:45:37 INFO - Return code: 0 16:45:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:45: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')]} 16:45:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45: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')]} 16:45:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f64aa685f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1386ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1383f60>, '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 0x1384d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13851d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1484959514.572678-2134908636', '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 16:45:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:45:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:45:37 INFO - Using env: {'DISPLAY': ':0', 16:45:37 INFO - 'HOME': '/home/cltbld', 16:45:37 INFO - 'LANG': 'en_US.UTF-8', 16:45:37 INFO - 'LANGUAGE': 'en_US:en', 16:45:37 INFO - 'LOGNAME': 'cltbld', 16:45:37 INFO - 'MAIL': '/var/mail/cltbld', 16:45:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:37 INFO - 'MOZ_NO_REMOTE': '1', 16:45:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:37 INFO - 'NO_EM_RESTART': '1', 16:45:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:37 INFO - 'PWD': '/builds/slave/test', 16:45:37 INFO - 'SHELL': '/bin/bash', 16:45:37 INFO - 'SHLVL': '1', 16:45:37 INFO - 'TERM': 'linux', 16:45:37 INFO - 'TMOUT': '86400', 16:45:37 INFO - 'USER': 'cltbld', 16:45:37 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1484959514.572678-2134908636', 16:45:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:37 INFO - '_': '/tools/buildbot/bin/python'} 16:45:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:45:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:45:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:45:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:45:39 INFO - Installing collected packages: mozsystemmonitor 16:45:39 INFO - Running setup.py install for mozsystemmonitor 16:45:40 INFO - Successfully installed mozsystemmonitor 16:45:40 INFO - Cleaning up... 16:45:40 INFO - Return code: 0 16:45:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:45:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f64aa685f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1386ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1383f60>, '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 0x1384d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13851d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1484959514.572678-2134908636', '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 16:45:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:45:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:45:40 INFO - Using env: {'DISPLAY': ':0', 16:45:40 INFO - 'HOME': '/home/cltbld', 16:45:40 INFO - 'LANG': 'en_US.UTF-8', 16:45:40 INFO - 'LANGUAGE': 'en_US:en', 16:45:40 INFO - 'LOGNAME': 'cltbld', 16:45:40 INFO - 'MAIL': '/var/mail/cltbld', 16:45:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:40 INFO - 'MOZ_NO_REMOTE': '1', 16:45:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:40 INFO - 'NO_EM_RESTART': '1', 16:45:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:40 INFO - 'PWD': '/builds/slave/test', 16:45:40 INFO - 'SHELL': '/bin/bash', 16:45:40 INFO - 'SHLVL': '1', 16:45:40 INFO - 'TERM': 'linux', 16:45:40 INFO - 'TMOUT': '86400', 16:45:40 INFO - 'USER': 'cltbld', 16:45:40 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1484959514.572678-2134908636', 16:45:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:40 INFO - '_': '/tools/buildbot/bin/python'} 16:45:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:40 INFO - Downloading/unpacking jsonschema==2.5.1 16:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:45:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:45: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 16:45: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 16:45: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 16:45: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 16:45: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 16:45: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 16:45:42 INFO - Downloading functools32-3.2.3-2.tar.gz 16:45:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:45:42 INFO - warning: no files found matching '*.txt' 16:45:42 INFO - no previously-included directories found matching 'build' 16:45:42 INFO - no previously-included directories found matching 'dist' 16:45:42 INFO - no previously-included directories found matching '.git*' 16:45:42 INFO - Installing collected packages: jsonschema, functools32 16:45:42 INFO - Running setup.py install for functools32 16:45:42 INFO - warning: no files found matching '*.txt' 16:45:42 INFO - no previously-included directories found matching 'build' 16:45:42 INFO - no previously-included directories found matching 'dist' 16:45:42 INFO - no previously-included directories found matching '.git*' 16:45:42 INFO - Successfully installed jsonschema functools32 16:45:42 INFO - Cleaning up... 16:45:42 INFO - Return code: 0 16:45:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f64aa685f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1386ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1383f60>, '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 0x1384d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13851d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1484959514.572678-2134908636', '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 16:45:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:45:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:45:42 INFO - Using env: {'DISPLAY': ':0', 16:45:42 INFO - 'HOME': '/home/cltbld', 16:45:42 INFO - 'LANG': 'en_US.UTF-8', 16:45:42 INFO - 'LANGUAGE': 'en_US:en', 16:45:42 INFO - 'LOGNAME': 'cltbld', 16:45:42 INFO - 'MAIL': '/var/mail/cltbld', 16:45:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:42 INFO - 'MOZ_NO_REMOTE': '1', 16:45:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:42 INFO - 'NO_EM_RESTART': '1', 16:45:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:42 INFO - 'PWD': '/builds/slave/test', 16:45:42 INFO - 'SHELL': '/bin/bash', 16:45:42 INFO - 'SHLVL': '1', 16:45:42 INFO - 'TERM': 'linux', 16:45:42 INFO - 'TMOUT': '86400', 16:45:42 INFO - 'USER': 'cltbld', 16:45:42 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1484959514.572678-2134908636', 16:45:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:42 INFO - '_': '/tools/buildbot/bin/python'} 16:45:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:45:43 INFO - Cleaning up... 16:45:43 INFO - Return code: 0 16:45:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:45:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:43 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 0x7f64aa685f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1386ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1383f60>, '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 0x1384d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13851d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1484959514.572678-2134908636', '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 16:45:43 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 16:45:43 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 16:45:43 INFO - Using env: {'DISPLAY': ':0', 16:45:43 INFO - 'HOME': '/home/cltbld', 16:45:43 INFO - 'LANG': 'en_US.UTF-8', 16:45:43 INFO - 'LANGUAGE': 'en_US:en', 16:45:43 INFO - 'LOGNAME': 'cltbld', 16:45:43 INFO - 'MAIL': '/var/mail/cltbld', 16:45:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:43 INFO - 'MOZ_NO_REMOTE': '1', 16:45:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:43 INFO - 'NO_EM_RESTART': '1', 16:45:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:43 INFO - 'PWD': '/builds/slave/test', 16:45:43 INFO - 'SHELL': '/bin/bash', 16:45:43 INFO - 'SHLVL': '1', 16:45:43 INFO - 'TERM': 'linux', 16:45:43 INFO - 'TMOUT': '86400', 16:45:43 INFO - 'USER': 'cltbld', 16:45:43 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1484959514.572678-2134908636', 16:45:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:43 INFO - '_': '/tools/buildbot/bin/python'} 16:45:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:43 INFO - Downloading/unpacking blobuploader==1.2.4 16:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:45 INFO - Downloading blobuploader-1.2.4.tar.gz 16:45:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:45:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:45:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:46 INFO - Downloading docopt-0.6.1.tar.gz 16:45:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:45:46 INFO - Installing collected packages: blobuploader, requests, docopt 16:45:46 INFO - Running setup.py install for blobuploader 16:45:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:45:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:45:46 INFO - Running setup.py install for requests 16:45:46 INFO - Running setup.py install for docopt 16:45:46 INFO - Successfully installed blobuploader requests docopt 16:45:46 INFO - Cleaning up... 16:45:46 INFO - Return code: 0 16:45:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:45:46 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')]} 16:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:46 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')]} 16:45:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:46 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 0x7f64aa685f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1386ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1383f60>, '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 0x1384d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13851d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1484959514.572678-2134908636', '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 16:45:46 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 16:45:46 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 16:45:46 INFO - Using env: {'DISPLAY': ':0', 16:45:46 INFO - 'HOME': '/home/cltbld', 16:45:46 INFO - 'LANG': 'en_US.UTF-8', 16:45:46 INFO - 'LANGUAGE': 'en_US:en', 16:45:46 INFO - 'LOGNAME': 'cltbld', 16:45:46 INFO - 'MAIL': '/var/mail/cltbld', 16:45:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:46 INFO - 'MOZ_NO_REMOTE': '1', 16:45:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:46 INFO - 'NO_EM_RESTART': '1', 16:45:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:46 INFO - 'PWD': '/builds/slave/test', 16:45:46 INFO - 'SHELL': '/bin/bash', 16:45:46 INFO - 'SHLVL': '1', 16:45:46 INFO - 'TERM': 'linux', 16:45:46 INFO - 'TMOUT': '86400', 16:45:46 INFO - 'USER': 'cltbld', 16:45:46 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1484959514.572678-2134908636', 16:45:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:46 INFO - '_': '/tools/buildbot/bin/python'} 16:45:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:45:46 INFO - Running setup.py (path:/tmp/pip-Prw6vn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:45:47 INFO - Running setup.py (path:/tmp/pip-y1Rq_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:45:47 INFO - Running setup.py (path:/tmp/pip-72pZK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:45:47 INFO - Running setup.py (path:/tmp/pip-__iZO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:45:47 INFO - Running setup.py (path:/tmp/pip-nm0qqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:45:47 INFO - Running setup.py (path:/tmp/pip-BWsqFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:45:47 INFO - Running setup.py (path:/tmp/pip-gNygcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:45:47 INFO - Running setup.py (path:/tmp/pip-1ft_2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:45:47 INFO - Running setup.py (path:/tmp/pip-f1NrmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:45:47 INFO - Running setup.py (path:/tmp/pip-lWbsWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:45:47 INFO - Running setup.py (path:/tmp/pip-_MXhrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:45:47 INFO - Running setup.py (path:/tmp/pip-nJGDKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:45:47 INFO - Running setup.py (path:/tmp/pip-47NPGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:45:47 INFO - Running setup.py (path:/tmp/pip-4Iuofv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:45:47 INFO - Running setup.py (path:/tmp/pip-ygi3iS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:45:48 INFO - Running setup.py (path:/tmp/pip-uZBMik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:45:48 INFO - Running setup.py (path:/tmp/pip-DCxQae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:45:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:45:48 INFO - Running setup.py install for manifestparser 16:45:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:45:48 INFO - Running setup.py install for mozcrash 16:45:48 INFO - Running setup.py install for mozdebug 16:45:48 INFO - Running setup.py install for mozdevice 16:45:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:45:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:45:48 INFO - Running setup.py install for mozfile 16:45:48 INFO - Running setup.py install for mozhttpd 16:45:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:45:48 INFO - Running setup.py install for mozinfo 16:45:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:45:48 INFO - Running setup.py install for mozInstall 16:45:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:45:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:45:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:45:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:45:48 INFO - Running setup.py install for mozleak 16:45:49 INFO - Running setup.py install for mozlog 16:45:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:45:49 INFO - Running setup.py install for moznetwork 16:45:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:45:49 INFO - Running setup.py install for mozprocess 16:45:49 INFO - Running setup.py install for mozprofile 16:45:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:45:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:45:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:45:49 INFO - Running setup.py install for mozrunner 16:45:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:45:49 INFO - Running setup.py install for mozscreenshot 16:45:49 INFO - Running setup.py install for moztest 16:45:49 INFO - Running setup.py install for mozversion 16:45:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:45:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:45:49 INFO - Cleaning up... 16:45:49 INFO - Return code: 0 16:45:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:45:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:49 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 0x7f64aa685f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1386ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1383f60>, '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 0x1384d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13851d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1484959514.572678-2134908636', '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 16:45:49 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 16:45:49 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 16:45:49 INFO - Using env: {'DISPLAY': ':0', 16:45:49 INFO - 'HOME': '/home/cltbld', 16:45:49 INFO - 'LANG': 'en_US.UTF-8', 16:45:49 INFO - 'LANGUAGE': 'en_US:en', 16:45:49 INFO - 'LOGNAME': 'cltbld', 16:45:49 INFO - 'MAIL': '/var/mail/cltbld', 16:45:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:49 INFO - 'MOZ_NO_REMOTE': '1', 16:45:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:50 INFO - 'NO_EM_RESTART': '1', 16:45:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:50 INFO - 'PWD': '/builds/slave/test', 16:45:50 INFO - 'SHELL': '/bin/bash', 16:45:50 INFO - 'SHLVL': '1', 16:45:50 INFO - 'TERM': 'linux', 16:45:50 INFO - 'TMOUT': '86400', 16:45:50 INFO - 'USER': 'cltbld', 16:45:50 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1484959514.572678-2134908636', 16:45:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:50 INFO - '_': '/tools/buildbot/bin/python'} 16:45:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:45:50 INFO - Running setup.py (path:/tmp/pip-SjsA8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:45:50 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)) 16:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:45:50 INFO - Running setup.py (path:/tmp/pip-tnLhMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:45:50 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)) 16:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:45:50 INFO - Running setup.py (path:/tmp/pip-Hojlvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:45:50 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)) 16:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:45:50 INFO - Running setup.py (path:/tmp/pip-q838TM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:45:50 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)) 16:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:45:50 INFO - Running setup.py (path:/tmp/pip-xTTgQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:45:50 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)) 16:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:45:50 INFO - Running setup.py (path:/tmp/pip-Dm9RB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:45:50 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)) 16:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:45:50 INFO - Running setup.py (path:/tmp/pip-WKfCWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:45:50 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)) 16:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:45:50 INFO - Running setup.py (path:/tmp/pip-TA31LJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:45:50 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)) 16:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:45:50 INFO - Running setup.py (path:/tmp/pip-PJQYj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:45:50 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)) 16:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:45:50 INFO - Running setup.py (path:/tmp/pip-taLQST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:45:50 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)) 16:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:45:50 INFO - Running setup.py (path:/tmp/pip-2YUnEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:45:51 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)) 16:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:45:51 INFO - Running setup.py (path:/tmp/pip-i4GIsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:45:51 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)) 16:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:45:51 INFO - Running setup.py (path:/tmp/pip-8WL6i6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:45:51 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)) 16:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:45:51 INFO - Running setup.py (path:/tmp/pip-W3BLJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:45:51 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)) 16:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:45:51 INFO - Running setup.py (path:/tmp/pip-EEAnQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:45:51 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)) 16:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:45:51 INFO - Running setup.py (path:/tmp/pip-0HgC1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:45:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 16:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:45:51 INFO - Running setup.py (path:/tmp/pip-PjRJoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:45:51 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)) 16:45:51 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)) 16:45:51 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)) 16:45:51 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)) 16:45:51 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)) 16:45:51 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)) 16:45:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:45:51 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 16:45:51 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 16:45:51 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 16:45:51 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 16:45:51 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 16:45:51 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 16:45:53 INFO - Downloading blessings-1.6.tar.gz 16:45:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:45:53 INFO - Installing collected packages: blessings 16:45:53 INFO - Running setup.py install for blessings 16:45:53 INFO - Successfully installed blessings 16:45:53 INFO - Cleaning up... 16:45:53 INFO - Return code: 0 16:45:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:45:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:45:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:45:53 INFO - Reading from file tmpfile_stdout 16:45:53 INFO - Current package versions: 16:45:53 INFO - argparse == 1.2.1 16:45:53 INFO - blessings == 1.6 16:45:53 INFO - blobuploader == 1.2.4 16:45:53 INFO - docopt == 0.6.1 16:45:53 INFO - functools32 == 3.2.3-2 16:45:53 INFO - jsonschema == 2.5.1 16:45:53 INFO - manifestparser == 1.1 16:45:53 INFO - mozInstall == 1.12 16:45:53 INFO - mozcrash == 1.0 16:45:53 INFO - mozdebug == 0.1 16:45:53 INFO - mozdevice == 0.48 16:45:53 INFO - mozfile == 1.2 16:45:53 INFO - mozhttpd == 0.7 16:45:53 INFO - mozinfo == 0.9 16:45:53 INFO - mozleak == 0.1 16:45:53 INFO - mozlog == 3.4 16:45:53 INFO - moznetwork == 0.27 16:45:53 INFO - mozprocess == 0.23 16:45:53 INFO - mozprofile == 0.28 16:45:53 INFO - mozrunner == 6.13 16:45:53 INFO - mozscreenshot == 0.1 16:45:53 INFO - mozsystemmonitor == 0.3 16:45:53 INFO - moztest == 0.8 16:45:53 INFO - mozversion == 1.4 16:45:53 INFO - psutil == 3.1.1 16:45:53 INFO - requests == 1.2.3 16:45:53 INFO - wsgiref == 0.1.2 16:45:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:45:53 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')]} 16:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:53 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')]} 16:45:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:53 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 0x7f64aa685f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1386ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1383f60>, '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 0x1384d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13851d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1484959514.572678-2134908636', '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 16:45:53 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 16:45:53 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 16:45:53 INFO - Using env: {'DISPLAY': ':0', 16:45:53 INFO - 'HOME': '/home/cltbld', 16:45:53 INFO - 'LANG': 'en_US.UTF-8', 16:45:53 INFO - 'LANGUAGE': 'en_US:en', 16:45:53 INFO - 'LOGNAME': 'cltbld', 16:45:53 INFO - 'MAIL': '/var/mail/cltbld', 16:45:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:53 INFO - 'MOZ_NO_REMOTE': '1', 16:45:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:53 INFO - 'NO_EM_RESTART': '1', 16:45:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:53 INFO - 'PWD': '/builds/slave/test', 16:45:53 INFO - 'SHELL': '/bin/bash', 16:45:53 INFO - 'SHLVL': '1', 16:45:53 INFO - 'TERM': 'linux', 16:45:53 INFO - 'TMOUT': '86400', 16:45:53 INFO - 'USER': 'cltbld', 16:45:53 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1484959514.572678-2134908636', 16:45:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:53 INFO - '_': '/tools/buildbot/bin/python'} 16:45:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:54 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)) 16:45:54 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)) 16:45:54 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)) 16:45:54 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)) 16:45:54 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)) 16:45:54 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)) 16:45:54 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)) 16:45:54 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)) 16:45:54 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)) 16:45:54 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)) 16:45:54 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)) 16:45:54 INFO - Cleaning up... 16:45:54 INFO - Return code: 0 16:45:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:45:54 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')]} 16:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:54 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')]} 16:45:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:54 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 0x7f64aa685f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1386ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1383f60>, '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 0x1384d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13851d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1484959514.572678-2134908636', '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 16:45:54 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 16:45:54 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 16:45:54 INFO - Using env: {'DISPLAY': ':0', 16:45:54 INFO - 'HOME': '/home/cltbld', 16:45:54 INFO - 'LANG': 'en_US.UTF-8', 16:45:54 INFO - 'LANGUAGE': 'en_US:en', 16:45:54 INFO - 'LOGNAME': 'cltbld', 16:45:54 INFO - 'MAIL': '/var/mail/cltbld', 16:45:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:54 INFO - 'MOZ_NO_REMOTE': '1', 16:45:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:54 INFO - 'NO_EM_RESTART': '1', 16:45:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:54 INFO - 'PWD': '/builds/slave/test', 16:45:54 INFO - 'SHELL': '/bin/bash', 16:45:54 INFO - 'SHLVL': '1', 16:45:54 INFO - 'TERM': 'linux', 16:45:54 INFO - 'TMOUT': '86400', 16:45:54 INFO - 'USER': 'cltbld', 16:45:54 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1484959514.572678-2134908636', 16:45:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:54 INFO - '_': '/tools/buildbot/bin/python'} 16:45:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:45:54 INFO - Cleaning up... 16:45:54 INFO - Return code: 0 16:45:54 INFO - Running post-action listener: _resource_record_post_action 16:45:54 INFO - Running post-action listener: _start_resource_monitoring 16:45:54 INFO - Starting resource monitoring. 16:45:54 INFO - [mozharness: 2017-01-21 00:45:54.429236Z] Finished create-virtualenv step (success) 16:45:54 INFO - [mozharness: 2017-01-21 00:45:54.429692Z] Running install step. 16:45:54 INFO - Running pre-action listener: _resource_record_pre_action 16:45:54 INFO - Running main action method: install 16:45:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:45:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:45:54 INFO - Reading from file tmpfile_stdout 16:45:54 INFO - Detecting whether we're running mozinstall >=1.0... 16:45:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:45:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:45:54 INFO - Reading from file tmpfile_stdout 16:45:54 INFO - Output received: 16:45:54 INFO - Usage: mozinstall [options] installer 16:45:54 INFO - Options: 16:45:54 INFO - -h, --help show this help message and exit 16:45:54 INFO - -d DEST, --destination=DEST 16:45:54 INFO - Directory to install application into. [default: 16:45:54 INFO - "/builds/slave/test"] 16:45:54 INFO - --app=APP Application being installed. [default: firefox] 16:45:54 INFO - mkdir: /builds/slave/test/build/application 16:45:54 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'] 16:45:54 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 16:46:10 INFO - Reading from file tmpfile_stdout 16:46:10 INFO - Output received: 16:46:10 INFO - /builds/slave/test/build/application/firefox/firefox 16:46:10 INFO - Running post-action listener: _resource_record_post_action 16:46:10 INFO - [mozharness: 2017-01-21 00:46:10.680218Z] Finished install step (success) 16:46:10 INFO - [mozharness: 2017-01-21 00:46:10.680460Z] Running run-tests step. 16:46:10 INFO - Running pre-action listener: _resource_record_pre_action 16:46:10 INFO - Running main action method: run_tests 16:46:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:46:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:46:10 INFO - Python 2.7.3 16:46:10 INFO - Return code: 0 16:46:10 INFO - grabbing minidump binary from tooltool 16:46:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:46:10 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 0x1383f60>, '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 0x1384d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13851d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:46:10 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 16:46:10 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 16:46:10 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 16:46:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:46:10 INFO - Return code: 0 16:46:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:46:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:46:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:46:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:46:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:46:10 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/Sm25fwRATh24pTgFKOjQWQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 16:46:10 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/Sm25fwRATh24pTgFKOjQWQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 16:46:10 INFO - Using env: {'DISPLAY': ':0', 16:46:10 INFO - 'HOME': '/home/cltbld', 16:46:10 INFO - 'LANG': 'en_US.UTF-8', 16:46:10 INFO - 'LANGUAGE': 'en_US:en', 16:46:10 INFO - 'LOGNAME': 'cltbld', 16:46:10 INFO - 'MAIL': '/var/mail/cltbld', 16:46:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:46:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:46:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:10 INFO - 'MOZ_NO_REMOTE': '1', 16:46:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:46:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:10 INFO - 'NO_EM_RESTART': '1', 16:46:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:46:10 INFO - 'PWD': '/builds/slave/test', 16:46:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:46:10 INFO - 'SHELL': '/bin/bash', 16:46:10 INFO - 'SHLVL': '1', 16:46:10 INFO - 'TERM': 'linux', 16:46:10 INFO - 'TMOUT': '86400', 16:46:10 INFO - 'USER': 'cltbld', 16:46:10 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1484959514.572678-2134908636', 16:46:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:10 INFO - '_': '/tools/buildbot/bin/python'} 16:46:10 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/Sm25fwRATh24pTgFKOjQWQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 16:46:10 INFO - mozversion application_buildid: 20170120144225 16:46:10 INFO - mozversion application_changeset: ccec56819e76733f28ae7f046e4602824ddbed10 16:46:10 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:46:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:46:10 INFO - mozversion application_name: Firefox 16:46:10 INFO - mozversion application_remotingname: firefox-dev 16:46:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:46:10 INFO - mozversion application_vendor: Mozilla 16:46:10 INFO - mozversion application_version: 52.0a2 16:46:10 INFO - mozversion platform_buildid: 20170120144225 16:46:10 INFO - mozversion platform_changeset: ccec56819e76733f28ae7f046e4602824ddbed10 16:46:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:46:10 INFO - mozversion platform_version: 52.0a2 16:46:10 INFO - using testdate: 1484959570 16:46:10 INFO - actual date: 1484959570 16:46:10 INFO - starting webserver on 'localhost:55971' 16:46:10 INFO - SUITE-START | Running 2 tests 16:46:10 INFO - TEST-START | dromaeo_css 16:46:10 INFO - operating with platform_type : linux_ 16:46:10 INFO - Initialising browser for dromaeo_css test... 16:46:10 INFO - TEST-INFO | started process 19811 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnjSWsD/profile http://localhost:55971/getInfo.html) 16:46:14 INFO - PROCESS | 19811 | __metrics Screen width/height:1600/1200 16:46:14 INFO - PROCESS | 19811 | colorDepth:24 16:46:14 INFO - PROCESS | 19811 | Browser inner width/height: 1024/697 16:46:14 INFO - PROCESS | 19811 | __metrics 16:46:15 INFO - PROCESS | 19811 | 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" 16:46:15 INFO - PROCESS | 19811 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:46:15 INFO - PROCESS | 19811 | console.error: PushService: 16:46:15 INFO - PROCESS | 19811 | stateChangeProcessEnqueue: Error transitioning state 16:46:15 INFO - PROCESS | 19811 | UnknownError 16:46:16 INFO - TEST-INFO | 19811: exit 0 16:46:16 INFO - Browser initialized. 16:46:16 INFO - Running cycle 1/1 for dromaeo_css test... 16:46:16 INFO - TEST-INFO | started process 19904 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnjSWsD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:46:28 INFO - PROCESS | 19904 | RSS: Main: 143724544 16:46:28 INFO - PROCESS | 19904 | 16:49:30 INFO - PROCESS | 19904 | Cycle 1(1): loaded http://localhost:55971/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55971/tests/dromaeo/cssquery-ext.html) 16:49:31 INFO - PROCESS | 19904 | RSS: Main: 247914496 16:49:31 INFO - PROCESS | 19904 | 16:52:33 INFO - PROCESS | 19904 | Cycle 1(1): loaded http://localhost:55971/tests/dromaeo/cssquery-ext.html (next: http://localhost:55971/tests/dromaeo/cssquery-jquery.html) 16:52:34 INFO - PROCESS | 19904 | RSS: Main: 226897920 16:52:34 INFO - PROCESS | 19904 | 16:55:36 INFO - PROCESS | 19904 | Cycle 1(1): loaded http://localhost:55971/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55971/tests/dromaeo/cssquery-mootools.html) 16:55:37 INFO - PROCESS | 19904 | RSS: Main: 221761536 16:55:37 INFO - PROCESS | 19904 | 16:58:38 INFO - PROCESS | 19904 | Cycle 1(1): loaded http://localhost:55971/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55971/tests/dromaeo/cssquery-prototype.html) 16:58:39 INFO - PROCESS | 19904 | RSS: Main: 223739904 16:58:39 INFO - PROCESS | 19904 | 17:01:42 INFO - PROCESS | 19904 | Cycle 1(1): loaded http://localhost:55971/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55971/tests/dromaeo/cssquery-yui.html) 17:01:42 INFO - PROCESS | 19904 | RSS: Main: 174530560 17:01:42 INFO - PROCESS | 19904 | 17:04:45 INFO - PROCESS | 19904 | Cycle 1(1): loaded http://localhost:55971/tests/dromaeo/cssquery-yui.html (next: http://localhost:55971/tests/dromaeo/cssquery-dojo.html) 17:04:45 INFO - PROCESS | 19904 | RSS: Main: 262213632 17:04:45 INFO - PROCESS | 19904 | 17:04:45 INFO - PROCESS | 19904 | __start_tp_report 17:04:45 INFO - PROCESS | 19904 | _x_x_mozilla_page_load 17:04:45 INFO - PROCESS | 19904 | _x_x_mozilla_page_load_details 17:04:45 INFO - PROCESS | 19904 | |i|pagename|runs| 17:04:45 INFO - PROCESS | 19904 | |0;dojo.html;3266.3630592034556;3296.2418643711962;3313.7183339416147;3315.0552092653597;3328.933421331575;5589.077802162644;5670.4896559309655;5671.319441666996;5674.177244299574;5695.629784064033;5622.437756224375;5683.602147849642;5701.173329867167;5718.342390625079;5721.799737009205;5136.049830781308;5155.613329000321;5161.251618515313;5198.896022079556;5237.502437268472;5023.8492845214705;5028.949710502885;5256.6057545684225;5267.236250743659;5284.8150314739;5063.6202284828605;5087.10975579274;5107.897842043157;5120.15517439622;5125.487451254882;5167.819126330579;5177.559907407856;5239.973800130975;5246.973765131188;5280.815171469018;4927.975360123212;5064.721440320781;5143.177091665316;5191.480851914816;5210.6613070150315;5437.537809286216;5506.449355064502;5535.916961245584;5555.944440555583;5560.86097847553;5978.372270911535;5993.760249590011;6122.448979591858;6122.47958923492;6127.540434467388;5874.559408044371;6164.84587885302;6167.044108163197;6171.567990240685;6194.752209911598;5539.50144486994;5576.525995290364;5635.887282254332;5668.319801623749;5714.3999880012;6195.380461953769;6208.813735587849;6214.40963108504;6223.96888015557;6226.034964580497;5788.623739456922;5908.054711246266;5912.793052243151;5913.113033045078;5918.615290006136;5913.763449461973;6000.879982400327;6060.363661815534;6065.120557519223;6115.331611965906;6080.391960803884;6084.452399283997;6084.817455476343;6085.66528840918;6113.57204995646;6032.034874420072;6093.786717464867;6104.816855494342;6114.938850611526;6123.203983482119;4577.267637178102;4608.239640459354;4630.351750754897;4656.767161641972;4663.347131401607;4168.041350489404;4169.499660040815;4174.373843923436;4177.811998460076;4197.622214000755;5705.5720820938595;5758.424157584292;5760.510356619734;5760.567957403212;5764.048931926185;5869.266341707286;5925.762969481172;5934.13954976526;5969.432903874125;6067.24159480065;5714.399988001283;5718.542516598662;5734.369219385864;5736.799212027559;5749.281339832521;5099.541041306226;5107.080725469451;5109.821156259513;5109.897802043938;5128.564072053842;6105.45050945417;6114.5414093942245;6143.818944274718;6196.566240363221;6252.124702541648;5962.37395073511;6015.097735339559;6017.578769486094;6046.848828779316;6052.273727152769;6245.96877015612;6253.906191407042;6276.121343012073;6295.748170073329;6302.590331628429;5694.373618901835;5703.08750599902;5965.343812180743;5965.642061476152;5999.1601175836295;5998.190244316961;6036.7585296589405;6044.455998960115;6093.177421048279;6142.938570614237;5910.349861515316;5968.373320801254;5970.552208584287;5975.492083172979;5981.192539007178;5659.122835960433;5958.821235362946;5966.105084237399;5971.58198926071;5973.522118230444;5732.5413966881715;5798.913016304675;5860.443257890493;5862.94137058624;5931.555133365101;5977.970110149596;5994.400559943971;5998.1002849572915;6000.909986350121;6011.849703757441;5657.886842263214;5702.572307076903;5717.628354156966;5824.592278540462;5832.416758324133 17:04:45 INFO - PROCESS | 19904 | |1;ext.html;578.3349148479251;620.1349117980418;640.5420124610903;653.0628548033573;669.6986356139738;33027.66972330276;35787.4631880522;35821.283574328496;44484.77757611207;46036.079278414414;45245.0950980981;45610.77194614022;45694;45746;45782.542174578244;8701.869471957925;8861.424007439497;8870.157335053193;8871.600777965006;8873.068327825582;8348.290395316406;8564.700235491759;8744.825103497958;10300.793984120313;10563.841542376871;10725.624603138891;10786.298890572127;10793.5682572697;10793.946030269837;10796.460176991159;10408.583656653725;10581.735456613607;10603.787924241511;10604.78790424195;10637.255392122555;10503.212259080523;10554.155667546578;10577.365358078463;10580;10581.470926453723;42317.15365692669;42572.36141457881;42713;42737;42776.144477110596;3439.570053743282;3489.6510348965153;3490.0576844252164;3496.4580490024086;3508.7193024557973;32307.35385292281;32483.350332993206;32561;32844.343113137606;33934.660653393395;4379.255526560492;4450.198964186445;4487.461504619434;4517.164324599959;4554.63562914966;388870;392502;394679;527481.3625931884;530965;64518.67740661267;65011;65031.67484162549;65076;65094.349056509775;39570.80214598966;42533.36199957003;42946.78526607347;68404;68955;18279.543011424554;18467.07664616764;18468;18493.81506184948;18496.722549161772;13172.209667419986;14207.78688319676;14372;14378.35297411619;14382;18133.727994080098;19448.637483117378;20987.685184722242;21235;21241.893790530947;7136.821579460555;7139.750108746169;7204.9639751800905;7391.630418479054;7472.476926615193;894.4186278918625;978.1001478639527;1018.5728055966873;1082.7293176705823;1092.808758467281;32823.83588082092;33081.66918330834;33140.66859331424;33254.66745332564;33591.32817343639;1050.7110544600296;1063.3938654966748;1077.7736675298117;1120.165476719849;1171.1509155861932;16775.15473297936;17786.199621017084;17798.733019004725;17800.821991779918;17891.910540447214;166900;167062;167150;168078.15960920116;168269;59744;59836.401635983086;60281.69859150676;60366.39633603608;60483;1242.2298175131477;1290.0389210038581;1302.5441095616459;1310.0960337367187;1339.8727120923302;31636.683633163375;33866;34115.31769364649;34310.48534272038;34674.82662586772;55500.72249638726;57798.4220157793;58020.4197958015;64251.678741605996;64305.356946431806;493707;499056;499445;499478;676634;44377;44385.892987490566;44570.331445029;44585.55414445814;44630.3305450425;49312.26031609457;50084;50126.74936625294;50191.498085018684;50698;42805.35791963185;42831.35752963646;43097.35353969756;43464;44398.556014440735;42041.369379459946;42293.51972680941;42361.57638423576;43431;43559.34660980025;41759.16481670289;41922.1615567693;42859;43273.13453730971;43334.78332608317;35668.28663426665;37173;37847;38180.23639527249;38525.229495410495;28526.286842829097;28530.57204141981;28678.71321286844;28726.569101463076;28928.42143157167 17:04:45 INFO - PROCESS | 19904 | |2;jquery.html;402.7724335750303;414.25020712510377;425.2197218104778;434.4048653344917;445.0920122949184;15243.542693719191;18959;20789.896050519765;21121.788782112173;21285.467863303405;19133.617327653472;20465.59068818623;20540.486487837774;20576.074076666548;20665.380038598865;5646.661200327993;5749.540036797067;5875.236219291486;5877.441643043904;5877.70611469427;5805.941940580604;6027.668478233695;6034.758609655609;6036.305824830135;6036.63780173191;5844.035734103868;5918.852028699295;5990.430909063653;5998.8500287492725;6002.249718785152;5873.559483038768;5897.3218079920925;5906.586538942276;5909.852253693692;5912.9113063304085;5277.736113194325;5278.6041046921255;5286.101362768339;5317.069512835238;5366.329208848894;23623;23696.88151559231;23891.880540597358;23909.04363825445;24023.639645405332;2396.928092157238;2474.7401522840023;2540.16174662361;2727.9590806137926;2879.3521457672064;14425.495107671286;15174.772378414333;15664.451744189013;15708.685826283525;16010.679786404324;1864.4499872537633;1969.8227159555565;2049.5695903860205;2049.98975005124;2088.56140210556;87120.56439717824;87201.56399218026;87792.56103719505;88467.55766221193;89407;10488.475576221159;11004.944975275072;11362.886371136348;11481.253718508271;11958.880411195776;15289.082655040733;15328.310226039855;16314.265858036417;16338.509844704678;16889.746653800205;8590.484570925764;8740.300775937909;8806.86789698155;8901.421407608485;8966.775830604287;8403.831923361498;8428.157184281645;8475.067742548315;8613;8646.221840034426;5025.271335656383;5125.923111153335;5173.068847607392;5175.663581867242;5263.131583288715;2083.2708552006675;2095.8428117890912;2106.6734656128324;2132.4349047502424;2157.169489746459;852.7228650688551;906.7098528470958;944.1596978688972;995.3381001633977;999.5402115027024;18549.25802967893;19841.900790495954;20062.197512099643;20089.598208035757;20574.698345565368;906.8866391701038;919.6643225222879;958.2621381536178;980.7940332530106;994.7165057958447;11023;11241.887581124083;11466.73865874753;11548.538058477734;11590.884091159149;504720;511021;512060;512500;517466;90294.54852725695;96434;97867.59595818205;98110;101504;1030.99484502577;1050.3592808386877;1066.1470823341297;1089.1178145702006;1091.9617813376653;17866.464006079837;17993.640127197643;18314.175862085973;18529.722054168928;18586.535336616693;41036.38445423261;42794.57205427906;43485.34771978486;44270.557294427934;44433.55566444423;59798.402015979285;59874.10188847258;60020.39979600148;60805.43959202989;62462.37537624747;8568.485890846569;8656.82686346257;8688;8860.335474839283;8876.733697989072;9417;12916;13251.469941202244;13408.731825363244;13432.529861454803;10729.088027517748;11282.266652667551;11421.657350279505;11502.597409090642;11916.642500724993;11018.283811552545;11156;11211.719707007063;11274.210805243554;11542.769144617228;11539.538418463168;11645.534178632759;11840.171188016757;11877.76244475123;12098.939505302416;9118.726438206864;9122.270218382646;9133.725988220363;9399.201067909304;9567.665131720356;8908.86636700437;11455.198136130392;11547.226386806597;11715;11739.23694959825 17:04:45 INFO - PROCESS | 19904 | |3;mootools.html;1349.905506614536;1508.5398953319236;1543.9536813895584;1705.2070787084003;1846.972295415569;7801.804954876131;8552;8879.689210877621;8896.688615898445;9062.184403403693;8840.248578870787;8919.197272245498;8974.910250897505;8977.596008179631;8983;2485.9875700621515;2510.9748902510923;2513.070164039308;2514.4342522932375;2523.2430270918744;2423.660687503742;2504.0484615845953;2505.6993160820725;2509.623556466526;2515.333436639292;2480.516299321633;2491.389609545655;2505.6993160820725;2506.2105436787447;2507.2979565721625;2334.7198336199594;2351.329870986769;2393.521295740841;2394.73657897632;2400.087966572709;2385.8926348314194;2390.8565486070715;2408.434018005767;2413.9396515087087;2422.5760491913843;8633.093525179891;8833.867491987625;8862.335324850663;9037.683681071197;9052.683156089506;5448.45515448456;5665.206871038058;5676;5678.716064196774;5683.090705487143;3506.1234691327168;3649.81750912456;3699.6855267302312;3708.6291370862696;3739.5886452490204;1179.817128345108;1187.7386974865515;1198.874118217592;1219.408586835384;1228.8341073954991;12630.30533320667;12719.10966232364;12761;12761.23432594038;12797.424115914806;4772.093302272557;4836.347093142451;4858.732769697701;4871.902561948741;4970.8757281068265;10014.198864090855;10020.348677336096;10021.148202402732;10023.2482563808;10027.699169024942;5597.328320601554;5606.943930560724;5611.130274807411;5612.579056570774;5617.8033768817895;4471;4605.194091034055;4735.715857048588;5138.229265610188;5213.530782229542;4029.315016447211;4064.4919385076864;4169.207850508394;4180.561041090703;4180.874573762792;1221.383201483263;1241.273854794937;1241.4103300932165;1244.8630650628425;1278.9232646041266;980.5930538826307;988.1156365053237;997.7495867603915;1010.2221289606962;1019.3730855523947;6050.183225264533;6112.2970858351855;6279.96860015697;6319.873602527924;6323.620582765049;480.24121887418494;485.10498130948343;488.2066641707226;497.5174081141287;502.32939026400163;4250.766207858535;4309.84915527955;4345.652347812167;4379.671524635665;4498.3927169832305;10762.192835537366;11331.830022549668;11335.716607084889;11337.829932551018;11346.035586975035;9864.950675246579;10179.236557258235;10359.741006474747;11255.774884502263;11269.38018408979;8383.077861435358;8434.57827108642;8638.09300023501;8640.740777776677;8649.870251946226;5964.493018093511;6102.747720124118;6103.389661033861;6175.5677102602385;6229.781957631461;9901.801963960825;9983.950080249553;9990.900090998997;10006.599736010477;10017.74955626086;9831;9881.950590247003;9912.306138570231;9955.751106222402;10066.245031622511;7949.8410031800195;8129.715459958873;8171.795705107182;8177.632006559838;8187.959060204661;8778.956105219433;8788.560571971504;8852.114788521096;8869.423487473294;8881.777955551162;7806.687732490636;7948.046234451903;7981.201879812204;8009.799755006172;8042.075161356285;7803.687852486064;7908.3673306136525;7922.4850384724805;7947.642356094106;7990.8002299940645;7109.502334836512;7123.430125590044;7205;7205.135383753983;7237.240089790706;5462.453754624665;5485.50630443262;5490.149026900836;5668.489835914787;5780.046292361713;5289.2330612061805;5301.496357845998;5360.597955153457;5370.2213179089595;5412.215228791724 17:04:45 INFO - PROCESS | 19904 | |4;prototype.html;340.4501729706523;343.8263676843194;348.42857713350094;354.1217779905833;359.41415492746825;5337.626366154371;5372.167314066316;5378.300820893288;5418.674879507223;5421.972890135544;5031.1698569736045;5128.974355128219;5177.6634518756255;5291.698111321578;5345.518903298703;4250.342366477076;4271.487421509423;4276.743395396278;4278.208531421681;4286.528481867008;4261.360795880627;4283.87148385549;4287.292596721537;4308.504521979966;4312.611864932155;3981.920361592781;4002.919941601166;4234.491860976687;4241.5122260939925;4257.531671516146;4225.429567008476;4228;4232.714334259481;4240.939765058735;4263.168682106991;3815.828287727059;3828.7894165820867;3829.3681542545446;3832.8466861325514;3845.730798844082;5002.19964805633;5155.123628983082;5172.482751724835;5230;5249.947500524984;4818.204996175627;4824.493428190025;4847.781849816767;4856.441509226449;4879.2925025871045;5551.8889622207735;5569.774649577086;5570.442955704438;5576.525995290405;5577.637453565505;3847.921662669853;4034.7377420467574;4042.2319759245647;4152.83388664453;4167.291560434703;5724.9427505724825;5745.741441635137;5753.309602847643;5767.394423585505;5778.335491418498;4161.604647558477;4176.2900306947895;4190.958090419118;4219.915601687949;4250.958515163805;4100.569440208795;4114.177164567099;4169.187008533307;4301.720388174758;4310.633596144363;4721.15019296523;4722.693024953367;4730.361401210793;4735.502772208937;4743.762811859393;5602.075657516464;5612.719364031782;5617.241672374177;5626.915596266059;5637.746301416446;1346.2931960720505;1394.902356835012;1418.631155899453;1427.600271923863;1436.1598464898152;933.0669330669331;954.6658669465631;972.9805403892024;1004.1866088468364;1014.1430491234895;5184.248283998874;5188.558972487381;5234.241035049897;5302.886393857333;5306.336707911511;5521.834344969577;5543.168524721244;5556.77772889088;5560.555155587544;5581.916271255853;5088.365133550964;5195.168633094972;5198.246254293106;5215.47845215483;5236.502532259429;2895.739383455499;2908.985455072711;2922.503174460347;2926.6976195593184;2930.1356099950567;5605.523530499871;5669.31968163823;5676.779492409152;5693.629914055656;5697.9772180876025;5828.154917536934;5855;5864.237649105589;5865.970670146622;5881.3530511643685;5906.940930590639;5927.673977931169;5938.168656388109;5963.9563076461445;5965.940340596539;5520.309961254843;5709.628874123168;5728.341240757366;5749.8275051748515;5758.596898217084;5678.77284908599;5685.5217643413835;5694.37710252576;5708.343540492897;5711.171880077282;5650.434956504317;5877.735501902339;5902.701405690741;5908.970455147697;5918.408159184047;4153.7507749535125;4195.748255104581;4199.538050814347;4203.97898010508;4213.839620284786;5727.198192253005;5785.623934444247;5802.912956305574;5805.216295800182;5824.5631577631;5375.301210842722;5616.971915140398;5670.121131224667;5695.174199740932;5701.800436984686;5616.354119276336;5623.606347555632;5626.85932851682;5638.464345887134;5643.830685079454;5314.202869569595;5478.972605136949;5543.8891222174525;5561.833145005657;5576.86057848557;5530.6128570999645;5610.49505544503;5631.605787594829;5658.632188907708;5659.660420374791;5401.351837779492;5436.755346009518;5449.891002179855;5475.288212532345;5490.862728431821 17:04:45 INFO - PROCESS | 19904 | |5;yui.html;754.5812074298761;774.9031371078615;818.926296633303;841.436237720727;860.5482121886013;13997.440102395893;14974.251287435625;15211.239438028082;16314.265858036388;16466.341346346162;12692.175008624434;13821.170729756222;14115.717685646307;14226.502072427467;14245.92877035616;851.7019043334845;871.8517851965181;873.3580818098692;873.7902903303193;874.422880898607;857.7555396711938;862.1335557764438;862.3058437957442;862.4911302331623;862.8015556422026;909.8134882349136;912.8402529557334;913.2420091324218;913.6254135804321;914.1407077347305;898.5956319656149;903.8960519540271;904.6245807989676;905.9637614495479;906.4515967839494;664.9268580456146;665.7569986954775;666.0608541955819;666.1905784471842;667.4426853577269;13615.931920340434;13672.042956993015;13832.100913440694;13927.651808704763;14049.367778449994;12771.297578633172;13231.735365292736;13321.067525273234;13450.327483625779;13457;11319.943400283028;11350.262232954914;11434.656960291204;11636.360000199986;11703.590374336858;3730;3747.194353214045;3795.772253664789;3813.7521061130938;3864.555576108727;45387;46688.533114669095;57211.427885721445;58627.41372586262;64819.351806481805;11712.88287117135;12044.457999390048;12079.154459187772;12148.939255303667;12190.878091219152;19456.805431945784;19922.800771992093;20038.799612003986;21887.67168492474;21940.45148871259;8427.578621068922;8428.747137585882;8457.873131902903;8764.56177191138;9163.404378715495;4940.777665005084;4950.752462376867;4966.8261610844165;5011.173156429149;5014.749262536859;3601.3697602919383;3685.226102518501;3718.3492888744363;3719.9814000929823;3728.254349130131;644.3758166052983;653.6339649796034;654.8821212181758;655.9901601475982;668.6656671664168;646.8285904235381;649.7985624456434;658.2890478283442;706.703184662443;710.9822254443577;8650.354854337369;8785.428947118417;8821.22523115922;8859.689910853089;8862.468251904906;578.5516224925632;687.894157877185;695.766918082448;705.6683358821346;712.0991945189339;4069.104796944667;4081.346984482528;4108.822324168195;4142.316517774533;4220.092680073799;90780;93615;93728.53135734277;94247;97299.51350243344;49602.75198624056;50250.246246306335;51206.74396627993;81604.59197703973;83706;75710.24289757032;75916.62041689757;76788;77661.22338776653;79533.20466795258;7939.960300198462;7963.960180199062;8017.118117007008;8127.715529956659;8421.915780842113;50018.74990625024;51047.234291484914;51435.742821285654;51843.493217078765;52633;62749;66385.66807166126;67404.6629766848;69010;69267.30732692608;11565.826512602149;11618.419079045845;11642.068634509049;11746.177767556532;11851.703707407383;12132.636020919386;12359.196652217577;12378.566750163702;12395.318257495564;12748.872511274769;11042.944785276022;11453.19827612059;11616.419179040846;11829.526818927146;11889.643310700692;11987.940060299643;12165.08761842883;12169.878301216875;12245.632631021084;12776.936115319364;11475.598354057567;11549.191556591293;11799.469023893773;11857.525698971944;11921.105917056082;9306;9313.115254050854;9490.715278541655;9550.18823399991;9686.854697179408;9387.906120938704;9388;9419.62321507132;9479.526023698649;9614.855777163208 17:04:45 INFO - PROCESS | 19904 | __end_tp_report 17:04:45 INFO - PROCESS | 19904 | __start_cc_report 17:04:45 INFO - PROCESS | 19904 | _x_x_mozilla_cycle_collect,1047 17:04:45 INFO - PROCESS | 19904 | __end_cc_report 17:04:45 INFO - PROCESS | 19904 | __startTimestamp1484960685598__endTimestamp 17:04:45 INFO - PROCESS | 19904 | 17:04:45 INFO - PROCESS | 19904 | ------- Summary: start ------- 17:04:45 INFO - PROCESS | 19904 | Number of tests: 6 17:04:45 INFO - PROCESS | 19904 | 17:04:45 INFO - PROCESS | 19904 | [#0] dojo.html Cycles:165 Average:5614.04 Median:5788.62 stddev:631.49 (10.9%) stddev-sans-first:605.98 17:04:45 INFO - PROCESS | 19904 | Values: 3266.4 3296.2 3313.7 3315.1 3328.9 5589.1 5670.5 5671.3 5674.2 5695.6 5622.4 5683.6 5701.2 5718.3 5721.8 5136.0 5155.6 5161.3 5198.9 5237.5 5023.8 5028.9 5256.6 5267.2 5284.8 5063.6 5087.1 5107.9 5120.2 5125.5 5167.8 5177.6 5240.0 5247.0 5280.8 4928.0 5064.7 5143.2 5191.5 5210.7 5437.5 5506.4 5535.9 5555.9 5560.9 5978.4 5993.8 6122.4 6122.5 6127.5 5874.6 6164.8 6167.0 6171.6 6194.8 5539.5 5576.5 5635.9 5668.3 5714.4 6195.4 6208.8 6214.4 6224.0 6226.0 5788.6 5908.1 5912.8 5913.1 5918.6 5913.8 6000.9 6060.4 6065.1 6115.3 6080.4 6084.5 6084.8 6085.7 6113.6 6032.0 6093.8 6104.8 6114.9 6123.2 4577.3 4608.2 4630.4 4656.8 4663.3 4168.0 4169.5 4174.4 4177.8 4197.6 5705.6 5758.4 5760.5 5760.6 5764.0 5869.3 5925.8 5934.1 5969.4 6067.2 5714.4 5718.5 5734.4 5736.8 5749.3 5099.5 5107.1 5109.8 5109.9 5128.6 6105.5 6114.5 6143.8 6196.6 6252.1 5962.4 6015.1 6017.6 6046.8 6052.3 6246.0 6253.9 6276.1 6295.7 6302.6 5694.4 5703.1 5965.3 5965.6 5999.2 5998.2 6036.8 6044.5 6093.2 6142.9 5910.3 5968.4 5970.6 5975.5 5981.2 5659.1 5958.8 5966.1 5971.6 5973.5 5732.5 5798.9 5860.4 5862.9 5931.6 5978.0 5994.4 5998.1 6000.9 6011.8 5657.9 5702.6 5717.6 5824.6 5832.4 17:04:45 INFO - PROCESS | 19904 | 17:04:45 INFO - PROCESS | 19904 | [#1] ext.html Cycles:180 Average:56714.24 Median:217124.90 stddev:111321.15 (51.3%) stddev-sans-first:111553.65 17:04:45 INFO - PROCESS | 19904 | Values: 578.3 620.1 640.5 653.1 669.7 33027.7 35787.5 35821.3 44484.8 46036.1 45245.1 45610.8 45694.0 45746.0 45782.5 8701.9 8861.4 8870.2 8871.6 8873.1 8348.3 8564.7 8744.8 10300.8 10563.8 10725.6 10786.3 10793.6 10793.9 10796.5 10408.6 10581.7 10603.8 10604.8 10637.3 10503.2 10554.2 10577.4 10580.0 10581.5 42317.2 42572.4 42713.0 42737.0 42776.1 3439.6 3489.7 3490.1 3496.5 3508.7 32307.4 32483.4 32561.0 32844.3 33934.7 4379.3 4450.2 4487.5 4517.2 4554.6 388870.0 392502.0 394679.0 527481.4 530965.0 64518.7 65011.0 65031.7 65076.0 65094.3 39570.8 42533.4 42946.8 68404.0 68955.0 18279.5 18467.1 18468.0 18493.8 18496.7 13172.2 14207.8 14372.0 14378.4 14382.0 18133.7 19448.6 20987.7 21235.0 21241.9 7136.8 7139.8 7205.0 7391.6 7472.5 894.4 978.1 1018.6 1082.7 1092.8 32823.8 33081.7 33140.7 33254.7 33591.3 1050.7 1063.4 1077.8 1120.2 1171.2 16775.2 17786.2 17798.7 17800.8 17891.9 166900.0 167062.0 167150.0 168078.2 168269.0 59744.0 59836.4 60281.7 60366.4 60483.0 1242.2 1290.0 1302.5 1310.1 1339.9 31636.7 33866.0 34115.3 34310.5 34674.8 55500.7 57798.4 58020.4 64251.7 64305.4 493707.0 499056.0 499445.0 499478.0 676634.0 44377.0 44385.9 44570.3 44585.6 44630.3 49312.3 50084.0 50126.7 50191.5 50698.0 42805.4 42831.4 43097.4 43464.0 44398.6 42041.4 42293.5 42361.6 43431.0 43559.3 41759.2 41922.2 42859.0 43273.1 43334.8 35668.3 37173.0 37847.0 38180.2 38525.2 28526.3 28530.6 28678.7 28726.6 28928.4 17:04:45 INFO - PROCESS | 19904 | 17:04:45 INFO - PROCESS | 19904 | [#2] jquery.html Cycles:180 Average:30372.46 Median:20725.32 stddev:84432.87 (407.4%) stddev-sans-first:84639.74 17:04:45 INFO - PROCESS | 19904 | Values: 402.8 414.3 425.2 434.4 445.1 15243.5 18959.0 20789.9 21121.8 21285.5 19133.6 20465.6 20540.5 20576.1 20665.4 5646.7 5749.5 5875.2 5877.4 5877.7 5805.9 6027.7 6034.8 6036.3 6036.6 5844.0 5918.9 5990.4 5998.9 6002.2 5873.6 5897.3 5906.6 5909.9 5912.9 5277.7 5278.6 5286.1 5317.1 5366.3 23623.0 23696.9 23891.9 23909.0 24023.6 2396.9 2474.7 2540.2 2728.0 2879.4 14425.5 15174.8 15664.5 15708.7 16010.7 1864.4 1969.8 2049.6 2050.0 2088.6 87120.6 87201.6 87792.6 88467.6 89407.0 10488.5 11004.9 11362.9 11481.3 11958.9 15289.1 15328.3 16314.3 16338.5 16889.7 8590.5 8740.3 8806.9 8901.4 8966.8 8403.8 8428.2 8475.1 8613.0 8646.2 5025.3 5125.9 5173.1 5175.7 5263.1 2083.3 2095.8 2106.7 2132.4 2157.2 852.7 906.7 944.2 995.3 999.5 18549.3 19841.9 20062.2 20089.6 20574.7 906.9 919.7 958.3 980.8 994.7 11023.0 11241.9 11466.7 11548.5 11590.9 504720.0 511021.0 512060.0 512500.0 517466.0 90294.5 96434.0 97867.6 98110.0 101504.0 1031.0 1050.4 1066.1 1089.1 1092.0 17866.5 17993.6 18314.2 18529.7 18586.5 41036.4 42794.6 43485.3 44270.6 44433.6 59798.4 59874.1 60020.4 60805.4 62462.4 8568.5 8656.8 8688.0 8860.3 8876.7 9417.0 12916.0 13251.5 13408.7 13432.5 10729.1 11282.3 11421.7 11502.6 11916.6 11018.3 11156.0 11211.7 11274.2 11542.8 11539.5 11645.5 11840.2 11877.8 12098.9 9118.7 9122.3 9133.7 9399.2 9567.7 8908.9 11455.2 11547.2 11715.0 11739.2 17:04:45 INFO - PROCESS | 19904 | 17:04:45 INFO - PROCESS | 19904 | [#3] mootools.html Cycles:180 Average:5934.19 Median:2736.60 stddev:3309.78 (120.9%) stddev-sans-first:3301.13 17:04:45 INFO - PROCESS | 19904 | Values: 1349.9 1508.5 1544.0 1705.2 1847.0 7801.8 8552.0 8879.7 8896.7 9062.2 8840.2 8919.2 8974.9 8977.6 8983.0 2486.0 2511.0 2513.1 2514.4 2523.2 2423.7 2504.0 2505.7 2509.6 2515.3 2480.5 2491.4 2505.7 2506.2 2507.3 2334.7 2351.3 2393.5 2394.7 2400.1 2385.9 2390.9 2408.4 2413.9 2422.6 8633.1 8833.9 8862.3 9037.7 9052.7 5448.5 5665.2 5676.0 5678.7 5683.1 3506.1 3649.8 3699.7 3708.6 3739.6 1179.8 1187.7 1198.9 1219.4 1228.8 12630.3 12719.1 12761.0 12761.2 12797.4 4772.1 4836.3 4858.7 4871.9 4970.9 10014.2 10020.3 10021.1 10023.2 10027.7 5597.3 5606.9 5611.1 5612.6 5617.8 4471.0 4605.2 4735.7 5138.2 5213.5 4029.3 4064.5 4169.2 4180.6 4180.9 1221.4 1241.3 1241.4 1244.9 1278.9 980.6 988.1 997.7 1010.2 1019.4 6050.2 6112.3 6280.0 6319.9 6323.6 480.2 485.1 488.2 497.5 502.3 4250.8 4309.8 4345.7 4379.7 4498.4 10762.2 11331.8 11335.7 11337.8 11346.0 9865.0 10179.2 10359.7 11255.8 11269.4 8383.1 8434.6 8638.1 8640.7 8649.9 5964.5 6102.7 6103.4 6175.6 6229.8 9901.8 9984.0 9990.9 10006.6 10017.7 9831.0 9882.0 9912.3 9955.8 10066.2 7949.8 8129.7 8171.8 8177.6 8188.0 8779.0 8788.6 8852.1 8869.4 8881.8 7806.7 7948.0 7981.2 8009.8 8042.1 7803.7 7908.4 7922.5 7947.6 7990.8 7109.5 7123.4 7205.0 7205.1 7237.2 5462.5 5485.5 5490.1 5668.5 5780.0 5289.2 5301.5 5360.6 5370.2 5412.2 17:04:45 INFO - PROCESS | 19904 | 17:04:45 INFO - PROCESS | 19904 | [#4] prototype.html Cycles:180 Average:4711.43 Median:5310.27 stddev:1365.26 (25.7%) stddev-sans-first:1329.08 17:04:45 INFO - PROCESS | 19904 | Values: 340.5 343.8 348.4 354.1 359.4 5337.6 5372.2 5378.3 5418.7 5422.0 5031.2 5129.0 5177.7 5291.7 5345.5 4250.3 4271.5 4276.7 4278.2 4286.5 4261.4 4283.9 4287.3 4308.5 4312.6 3981.9 4002.9 4234.5 4241.5 4257.5 4225.4 4228.0 4232.7 4240.9 4263.2 3815.8 3828.8 3829.4 3832.8 3845.7 5002.2 5155.1 5172.5 5230.0 5249.9 4818.2 4824.5 4847.8 4856.4 4879.3 5551.9 5569.8 5570.4 5576.5 5577.6 3847.9 4034.7 4042.2 4152.8 4167.3 5724.9 5745.7 5753.3 5767.4 5778.3 4161.6 4176.3 4191.0 4219.9 4251.0 4100.6 4114.2 4169.2 4301.7 4310.6 4721.2 4722.7 4730.4 4735.5 4743.8 5602.1 5612.7 5617.2 5626.9 5637.7 1346.3 1394.9 1418.6 1427.6 1436.2 933.1 954.7 973.0 1004.2 1014.1 5184.2 5188.6 5234.2 5302.9 5306.3 5521.8 5543.2 5556.8 5560.6 5581.9 5088.4 5195.2 5198.2 5215.5 5236.5 2895.7 2909.0 2922.5 2926.7 2930.1 5605.5 5669.3 5676.8 5693.6 5698.0 5828.2 5855.0 5864.2 5866.0 5881.4 5906.9 5927.7 5938.2 5964.0 5965.9 5520.3 5709.6 5728.3 5749.8 5758.6 5678.8 5685.5 5694.4 5708.3 5711.2 5650.4 5877.7 5902.7 5909.0 5918.4 4153.8 4195.7 4199.5 4204.0 4213.8 5727.2 5785.6 5802.9 5805.2 5824.6 5375.3 5617.0 5670.1 5695.2 5701.8 5616.4 5623.6 5626.9 5638.5 5643.8 5314.2 5479.0 5543.9 5561.8 5576.9 5530.6 5610.5 5631.6 5658.6 5659.7 5401.4 5436.8 5449.9 5475.3 5490.9 17:04:45 INFO - PROCESS | 19904 | 17:04:45 INFO - PROCESS | 19904 | [#5] yui.html Cycles:180 Average:17650.25 Median:28894.99 stddev:24025.19 (83.1%) stddev-sans-first:24059.09 17:04:45 INFO - PROCESS | 19904 | Values: 754.6 774.9 818.9 841.4 860.5 13997.4 14974.3 15211.2 16314.3 16466.3 12692.2 13821.2 14115.7 14226.5 14245.9 851.7 871.9 873.4 873.8 874.4 857.8 862.1 862.3 862.5 862.8 909.8 912.8 913.2 913.6 914.1 898.6 903.9 904.6 906.0 906.5 664.9 665.8 666.1 666.2 667.4 13615.9 13672.0 13832.1 13927.7 14049.4 12771.3 13231.7 13321.1 13450.3 13457.0 11319.9 11350.3 11434.7 11636.4 11703.6 3730.0 3747.2 3795.8 3813.8 3864.6 45387.0 46688.5 57211.4 58627.4 64819.4 11712.9 12044.5 12079.2 12148.9 12190.9 19456.8 19922.8 20038.8 21887.7 21940.5 8427.6 8428.7 8457.9 8764.6 9163.4 4940.8 4950.8 4966.8 5011.2 5014.7 3601.4 3685.2 3718.3 3720.0 3728.3 644.4 653.6 654.9 656.0 668.7 646.8 649.8 658.3 706.7 711.0 8650.4 8785.4 8821.2 8859.7 8862.5 578.6 687.9 695.8 705.7 712.1 4069.1 4081.3 4108.8 4142.3 4220.1 90780.0 93615.0 93728.5 94247.0 97299.5 49602.8 50250.2 51206.7 81604.6 83706.0 75710.2 75916.6 76788.0 77661.2 79533.2 7940.0 7964.0 8017.1 8127.7 8421.9 50018.7 51047.2 51435.7 51843.5 52633.0 62749.0 66385.7 67404.7 69010.0 69267.3 11565.8 11618.4 11642.1 11746.2 11851.7 12132.6 12359.2 12378.6 12395.3 12748.9 11042.9 11453.2 11616.4 11829.5 11889.6 11987.9 12165.1 12169.9 12245.6 12776.9 11475.6 11549.2 11799.5 11857.5 11921.1 9306.0 9313.1 9490.7 9550.2 9686.9 9387.9 9388.0 9419.6 9479.5 9614.9 17:04:45 INFO - PROCESS | 19904 | -------- Summary: end -------- 17:04:45 INFO - PROCESS | 19904 | 17:04:46 INFO - TEST-INFO | 19904: exit 0 17:04:46 INFO - TEST-OK | dromaeo_css | took 1115328ms 17:04:46 INFO - TEST-START | kraken 17:04:46 INFO - operating with platform_type : linux_ 17:04:46 INFO - Initialising browser for kraken test... 17:04:46 INFO - TEST-INFO | started process 20220 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps4y6T4/profile http://localhost:55971/getInfo.html) 17:04:50 INFO - PROCESS | 20220 | __metrics Screen width/height:1600/1200 17:04:50 INFO - PROCESS | 20220 | colorDepth:24 17:04:50 INFO - PROCESS | 20220 | Browser inner width/height: 1024/697 17:04:50 INFO - PROCESS | 20220 | __metrics 17:04:50 INFO - PROCESS | 20220 | 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" 17:04:50 INFO - PROCESS | 20220 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:04:51 INFO - PROCESS | 20220 | console.error: PushService: 17:04:51 INFO - PROCESS | 20220 | stateChangeProcessEnqueue: Error transitioning state 17:04:51 INFO - PROCESS | 20220 | UnknownError 17:04:51 INFO - TEST-INFO | 20220: exit 0 17:04:51 INFO - Browser initialized. 17:04:51 INFO - Running cycle 1/1 for kraken test... 17:04:51 INFO - TEST-INFO | started process 20314 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps4y6T4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:05:03 INFO - PROCESS | 20314 | RSS: Main: 143929344 17:05:03 INFO - PROCESS | 20314 | 17:05:05 INFO - PROCESS | 20314 | Cycle 1(1): loaded http://localhost:55971/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55971/tests/kraken/driver.html?testName=audio-beat-detection) 17:05:06 INFO - PROCESS | 20314 | RSS: Main: 185229312 17:05:06 INFO - PROCESS | 20314 | 17:05:09 INFO - PROCESS | 20314 | Cycle 1(1): loaded http://localhost:55971/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55971/tests/kraken/driver.html?testName=audio-dft) 17:05:09 INFO - PROCESS | 20314 | RSS: Main: 175276032 17:05:09 INFO - PROCESS | 20314 | 17:05:12 INFO - PROCESS | 20314 | Cycle 1(1): loaded http://localhost:55971/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55971/tests/kraken/driver.html?testName=audio-fft) 17:05:13 INFO - PROCESS | 20314 | RSS: Main: 267104256 17:05:13 INFO - PROCESS | 20314 | 17:05:15 INFO - PROCESS | 20314 | Cycle 1(1): loaded http://localhost:55971/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55971/tests/kraken/driver.html?testName=audio-oscillator) 17:05:15 INFO - PROCESS | 20314 | RSS: Main: 172670976 17:05:15 INFO - PROCESS | 20314 | 17:05:18 INFO - PROCESS | 20314 | Cycle 1(1): loaded http://localhost:55971/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55971/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:05:18 INFO - PROCESS | 20314 | RSS: Main: 175681536 17:05:18 INFO - PROCESS | 20314 | 17:05:21 INFO - PROCESS | 20314 | Cycle 1(1): loaded http://localhost:55971/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55971/tests/kraken/driver.html?testName=imaging-darkroom) 17:05:22 INFO - PROCESS | 20314 | RSS: Main: 213786624 17:05:22 INFO - PROCESS | 20314 | 17:05:25 INFO - PROCESS | 20314 | Cycle 1(1): loaded http://localhost:55971/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55971/tests/kraken/driver.html?testName=imaging-desaturate) 17:05:26 INFO - PROCESS | 20314 | RSS: Main: 212398080 17:05:26 INFO - PROCESS | 20314 | 17:05:28 INFO - PROCESS | 20314 | Cycle 1(1): loaded http://localhost:55971/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55971/tests/kraken/driver.html?testName=json-parse-financial) 17:05:29 INFO - PROCESS | 20314 | RSS: Main: 211333120 17:05:29 INFO - PROCESS | 20314 | 17:05:30 INFO - PROCESS | 20314 | Cycle 1(1): loaded http://localhost:55971/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55971/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:05:31 INFO - PROCESS | 20314 | RSS: Main: 172810240 17:05:31 INFO - PROCESS | 20314 | 17:05:33 INFO - PROCESS | 20314 | Cycle 1(1): loaded http://localhost:55971/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55971/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:05:33 INFO - PROCESS | 20314 | RSS: Main: 181354496 17:05:33 INFO - PROCESS | 20314 | 17:05:35 INFO - PROCESS | 20314 | Cycle 1(1): loaded http://localhost:55971/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55971/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:05:36 INFO - PROCESS | 20314 | RSS: Main: 189739008 17:05:36 INFO - PROCESS | 20314 | 17:05:38 INFO - PROCESS | 20314 | Cycle 1(1): loaded http://localhost:55971/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55971/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:05:39 INFO - PROCESS | 20314 | RSS: Main: 198148096 17:05:39 INFO - PROCESS | 20314 | 17:05:42 INFO - PROCESS | 20314 | Cycle 1(1): loaded http://localhost:55971/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55971/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:05:42 INFO - PROCESS | 20314 | RSS: Main: 194449408 17:05:42 INFO - PROCESS | 20314 | 17:05:44 INFO - PROCESS | 20314 | Cycle 1(1): loaded http://localhost:55971/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55971/tests/kraken/driver.html?testName=ai-astar) 17:05:44 INFO - PROCESS | 20314 | RSS: Main: 246358016 17:05:44 INFO - PROCESS | 20314 | 17:05:44 INFO - PROCESS | 20314 | __start_tp_report 17:05:44 INFO - PROCESS | 20314 | _x_x_mozilla_page_load 17:05:44 INFO - PROCESS | 20314 | _x_x_mozilla_page_load_details 17:05:44 INFO - PROCESS | 20314 | |i|pagename|runs| 17:05:44 INFO - PROCESS | 20314 | |0;ai-astar;103;111;111;111;112;111;111;112;110;112 17:05:44 INFO - PROCESS | 20314 | |1;audio-beat-detection;148;120;118;151;120;117;120;118;146;119 17:05:44 INFO - PROCESS | 20314 | |2;audio-dft;163;160;160;162;161;168;160;161;160;160 17:05:44 INFO - PROCESS | 20314 | |3;audio-fft;74;75;76;109;74;76;77;76;99;76 17:05:44 INFO - PROCESS | 20314 | |4;audio-oscillator;81;81;109;82;81;81;99;82;83;109 17:05:44 INFO - PROCESS | 20314 | |5;imaging-gaussian-blur;117;117;118;116;117;117;116;117;117;117 17:05:44 INFO - PROCESS | 20314 | |6;imaging-darkroom;146;146;146;146;145;147;145;145;172;146 17:05:44 INFO - PROCESS | 20314 | |7;imaging-desaturate;86;84;84;84;84;84;84;84;85;84 17:05:44 INFO - PROCESS | 20314 | |8;json-parse-financial;49;50;49;50;49;50;51;50;49;49 17:05:44 INFO - PROCESS | 20314 | |9;json-stringify-tinderbox;59;60;60;59;60;60;59;60;60;61 17:05:44 INFO - PROCESS | 20314 | |10;stanford-crypto-aes;74;74;74;74;77;73;75;83;74;82 17:05:44 INFO - PROCESS | 20314 | |11;stanford-crypto-ccm;125;122;122;134;118;120;131;133;161;126 17:05:44 INFO - PROCESS | 20314 | |12;stanford-crypto-pbkdf2;157;149;151;151;152;151;159;150;150;152 17:05:44 INFO - PROCESS | 20314 | |13;stanford-crypto-sha256-iterative;74;64;62;62;65;62;62;62;61;60 17:05:44 INFO - PROCESS | 20314 | __end_tp_report 17:05:44 INFO - PROCESS | 20314 | __start_cc_report 17:05:44 INFO - PROCESS | 20314 | _x_x_mozilla_cycle_collect,1607 17:05:44 INFO - PROCESS | 20314 | __end_cc_report 17:05:44 INFO - PROCESS | 20314 | __startTimestamp1484960744653__endTimestamp 17:05:44 INFO - PROCESS | 20314 | 17:05:44 INFO - PROCESS | 20314 | ------- Summary: start ------- 17:05:44 INFO - PROCESS | 20314 | Number of tests: 14 17:05:44 INFO - PROCESS | 20314 | 17:05:44 INFO - PROCESS | 20314 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:2.67 (2.4%) stddev-sans-first:0.67 17:05:44 INFO - PROCESS | 20314 | Values: 103.0 111.0 111.0 111.0 112.0 111.0 111.0 112.0 110.0 112.0 17:05:44 INFO - PROCESS | 20314 | 17:05:44 INFO - PROCESS | 20314 | [#1] audio-beat-detection Cycles:10 Average:127.70 Median:120.00 stddev:14.32 (11.9%) stddev-sans-first:13.17 17:05:44 INFO - PROCESS | 20314 | Values: 148.0 120.0 118.0 151.0 120.0 117.0 120.0 118.0 146.0 119.0 17:05:44 INFO - PROCESS | 20314 | 17:05:44 INFO - PROCESS | 20314 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.00 stddev:2.51 (1.6%) stddev-sans-first:2.60 17:05:44 INFO - PROCESS | 20314 | Values: 163.0 160.0 160.0 162.0 161.0 168.0 160.0 161.0 160.0 160.0 17:05:44 INFO - PROCESS | 20314 | 17:05:44 INFO - PROCESS | 20314 | [#3] audio-fft Cycles:10 Average:81.20 Median:76.00 stddev:12.28 (16.2%) stddev-sans-first:12.75 17:05:44 INFO - PROCESS | 20314 | Values: 74.0 75.0 76.0 109.0 74.0 76.0 77.0 76.0 99.0 76.0 17:05:44 INFO - PROCESS | 20314 | 17:05:44 INFO - PROCESS | 20314 | [#4] audio-oscillator Cycles:10 Average:88.80 Median:81.50 stddev:11.97 (14.7%) stddev-sans-first:12.36 17:05:44 INFO - PROCESS | 20314 | Values: 81.0 81.0 109.0 82.0 81.0 81.0 99.0 82.0 83.0 109.0 17:05:44 INFO - PROCESS | 20314 | 17:05:44 INFO - PROCESS | 20314 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 17:05:44 INFO - PROCESS | 20314 | Values: 117.0 117.0 118.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 17:05:44 INFO - PROCESS | 20314 | 17:05:44 INFO - PROCESS | 20314 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:146.00 stddev:8.32 (5.7%) stddev-sans-first:8.77 17:05:44 INFO - PROCESS | 20314 | Values: 146.0 146.0 146.0 146.0 145.0 147.0 145.0 145.0 172.0 146.0 17:05:44 INFO - PROCESS | 20314 | 17:05:44 INFO - PROCESS | 20314 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:0.67 (0.8%) stddev-sans-first:0.33 17:05:44 INFO - PROCESS | 20314 | Values: 86.0 84.0 84.0 84.0 84.0 84.0 84.0 84.0 85.0 84.0 17:05:44 INFO - PROCESS | 20314 | 17:05:44 INFO - PROCESS | 20314 | [#8] json-parse-financial Cycles:10 Average:49.60 Median:50.00 stddev:0.70 (1.4%) stddev-sans-first:0.71 17:05:44 INFO - PROCESS | 20314 | Values: 49.0 50.0 49.0 50.0 49.0 50.0 51.0 50.0 49.0 49.0 17:05:44 INFO - PROCESS | 20314 | 17:05:44 INFO - PROCESS | 20314 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:0.63 (1.1%) stddev-sans-first:0.60 17:05:44 INFO - PROCESS | 20314 | Values: 59.0 60.0 60.0 59.0 60.0 60.0 59.0 60.0 60.0 61.0 17:05:44 INFO - PROCESS | 20314 | 17:05:44 INFO - PROCESS | 20314 | [#10] stanford-crypto-aes Cycles:10 Average:76.00 Median:74.50 stddev:3.59 (4.8%) stddev-sans-first:3.73 17:05:44 INFO - PROCESS | 20314 | Values: 74.0 74.0 74.0 74.0 77.0 73.0 75.0 83.0 74.0 82.0 17:05:44 INFO - PROCESS | 20314 | 17:05:44 INFO - PROCESS | 20314 | [#11] stanford-crypto-ccm Cycles:10 Average:129.20 Median:128.50 stddev:12.44 (9.7%) stddev-sans-first:13.11 17:05:44 INFO - PROCESS | 20314 | Values: 125.0 122.0 122.0 134.0 118.0 120.0 131.0 133.0 161.0 126.0 17:05:44 INFO - PROCESS | 20314 | 17:05:44 INFO - PROCESS | 20314 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.20 Median:151.50 stddev:3.22 (2.1%) stddev-sans-first:2.92 17:05:44 INFO - PROCESS | 20314 | Values: 157.0 149.0 151.0 151.0 152.0 151.0 159.0 150.0 150.0 152.0 17:05:44 INFO - PROCESS | 20314 | 17:05:44 INFO - PROCESS | 20314 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:62.00 stddev:3.98 (6.4%) stddev-sans-first:1.48 17:05:44 INFO - PROCESS | 20314 | Values: 74.0 64.0 62.0 62.0 65.0 62.0 62.0 62.0 61.0 60.0 17:05:44 INFO - PROCESS | 20314 | -------- Summary: end -------- 17:05:44 INFO - PROCESS | 20314 | 17:05:45 INFO - TEST-INFO | 20314: exit 0 17:05:45 INFO - TEST-OK | kraken | took 59391ms 17:05:45 INFO - SUITE-END | took 1174s 17:05:45 INFO - Completed test suite (00:19:34) 17:05:45 INFO - javascript benchmark 17:05:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3266.3630592034556, 3296.2418643711962, 3313.7183339416147, 3315.0552092653597, 3328.933421331575, 5589.077802162644, 5670.4896559309655, 5671.319441666996, 5674.177244299574, 5695.629784064033, 5622.437756224375, 5683.602147849642, 5701.173329867167, 5718.342390625079, 5721.799737009205, 5136.049830781308, 5155.613329000321, 5161.251618515313, 5198.896022079556, 5237.502437268472, 5023.8492845214705, 5028.949710502885, 5256.6057545684225, 5267.236250743659, 5284.8150314739, 5063.6202284828605, 5087.10975579274, 5107.897842043157, 5120.15517439622, 5125.487451254882, 5167.819126330579, 5177.559907407856, 5239.973800130975, 5246.973765131188, 5280.815171469018, 4927.975360123212, 5064.721440320781, 5143.177091665316, 5191.480851914816, 5210.6613070150315, 5437.537809286216, 5506.449355064502, 5535.916961245584, 5555.944440555583, 5560.86097847553, 5978.372270911535, 5993.760249590011, 6122.448979591858, 6122.47958923492, 6127.540434467388, 5874.559408044371, 6164.84587885302, 6167.044108163197, 6171.567990240685, 6194.752209911598, 5539.50144486994, 5576.525995290364, 5635.887282254332, 5668.319801623749, 5714.3999880012, 6195.380461953769, 6208.813735587849, 6214.40963108504, 6223.96888015557, 6226.034964580497, 5788.623739456922, 5908.054711246266, 5912.793052243151, 5913.113033045078, 5918.615290006136, 5913.763449461973, 6000.879982400327, 6060.363661815534, 6065.120557519223, 6115.331611965906, 6080.391960803884, 6084.452399283997, 6084.817455476343, 6085.66528840918, 6113.57204995646, 6032.034874420072, 6093.786717464867, 6104.816855494342, 6114.938850611526, 6123.203983482119, 4577.267637178102, 4608.239640459354, 4630.351750754897, 4656.767161641972, 4663.347131401607, 4168.041350489404, 4169.499660040815, 4174.373843923436, 4177.811998460076, 4197.622214000755, 5705.5720820938595, 5758.424157584292, 5760.510356619734, 5760.567957403212, 5764.048931926185, 5869.266341707286, 5925.762969481172, 5934.13954976526, 5969.432903874125, 6067.24159480065, 5714.399988001283, 5718.542516598662, 5734.369219385864, 5736.799212027559, 5749.281339832521, 5099.541041306226, 5107.080725469451, 5109.821156259513, 5109.897802043938, 5128.564072053842, 6105.45050945417, 6114.5414093942245, 6143.818944274718, 6196.566240363221, 6252.124702541648, 5962.37395073511, 6015.097735339559, 6017.578769486094, 6046.848828779316, 6052.273727152769, 6245.96877015612, 6253.906191407042, 6276.121343012073, 6295.748170073329, 6302.590331628429, 5694.373618901835, 5703.08750599902, 5965.343812180743, 5965.642061476152, 5999.1601175836295, 5998.190244316961, 6036.7585296589405, 6044.455998960115, 6093.177421048279, 6142.938570614237, 5910.349861515316, 5968.373320801254, 5970.552208584287, 5975.492083172979, 5981.192539007178, 5659.122835960433, 5958.821235362946, 5966.105084237399, 5971.58198926071, 5973.522118230444, 5732.5413966881715, 5798.913016304675, 5860.443257890493, 5862.94137058624, 5931.555133365101, 5977.970110149596, 5994.400559943971, 5998.1002849572915, 6000.909986350121, 6011.849703757441, 5657.886842263214, 5702.572307076903, 5717.628354156966, 5824.592278540462, 5832.416758324133], "value": 5572.169922451362, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.3349148479251, 620.1349117980418, 640.5420124610903, 653.0628548033573, 669.6986356139738, 33027.66972330276, 35787.4631880522, 35821.283574328496, 44484.77757611207, 46036.079278414414, 45245.0950980981, 45610.77194614022, 45694.0, 45746.0, 45782.542174578244, 8701.869471957925, 8861.424007439497, 8870.157335053193, 8871.600777965006, 8873.068327825582, 8348.290395316406, 8564.700235491759, 8744.825103497958, 10300.793984120313, 10563.841542376871, 10725.624603138891, 10786.298890572127, 10793.5682572697, 10793.946030269837, 10796.460176991159, 10408.583656653725, 10581.735456613607, 10603.787924241511, 10604.78790424195, 10637.255392122555, 10503.212259080523, 10554.155667546578, 10577.365358078463, 10580.0, 10581.470926453723, 42317.15365692669, 42572.36141457881, 42713.0, 42737.0, 42776.144477110596, 3439.570053743282, 3489.6510348965153, 3490.0576844252164, 3496.4580490024086, 3508.7193024557973, 32307.35385292281, 32483.350332993206, 32561.0, 32844.343113137606, 33934.660653393395, 4379.255526560492, 4450.198964186445, 4487.461504619434, 4517.164324599959, 4554.63562914966, 388870.0, 392502.0, 394679.0, 527481.3625931884, 530965.0, 64518.67740661267, 65011.0, 65031.67484162549, 65076.0, 65094.349056509775, 39570.80214598966, 42533.36199957003, 42946.78526607347, 68404.0, 68955.0, 18279.543011424554, 18467.07664616764, 18468.0, 18493.81506184948, 18496.722549161772, 13172.209667419986, 14207.78688319676, 14372.0, 14378.35297411619, 14382.0, 18133.727994080098, 19448.637483117378, 20987.685184722242, 21235.0, 21241.893790530947, 7136.821579460555, 7139.750108746169, 7204.9639751800905, 7391.630418479054, 7472.476926615193, 894.4186278918625, 978.1001478639527, 1018.5728055966873, 1082.7293176705823, 1092.808758467281, 32823.83588082092, 33081.66918330834, 33140.66859331424, 33254.66745332564, 33591.32817343639, 1050.7110544600296, 1063.3938654966748, 1077.7736675298117, 1120.165476719849, 1171.1509155861932, 16775.15473297936, 17786.199621017084, 17798.733019004725, 17800.821991779918, 17891.910540447214, 166900.0, 167062.0, 167150.0, 168078.15960920116, 168269.0, 59744.0, 59836.401635983086, 60281.69859150676, 60366.39633603608, 60483.0, 1242.2298175131477, 1290.0389210038581, 1302.5441095616459, 1310.0960337367187, 1339.8727120923302, 31636.683633163375, 33866.0, 34115.31769364649, 34310.48534272038, 34674.82662586772, 55500.72249638726, 57798.4220157793, 58020.4197958015, 64251.678741605996, 64305.356946431806, 493707.0, 499056.0, 499445.0, 499478.0, 676634.0, 44377.0, 44385.892987490566, 44570.331445029, 44585.55414445814, 44630.3305450425, 49312.26031609457, 50084.0, 50126.74936625294, 50191.498085018684, 50698.0, 42805.35791963185, 42831.35752963646, 43097.35353969756, 43464.0, 44398.556014440735, 42041.369379459946, 42293.51972680941, 42361.57638423576, 43431.0, 43559.34660980025, 41759.16481670289, 41922.1615567693, 42859.0, 43273.13453730971, 43334.78332608317, 35668.28663426665, 37173.0, 37847.0, 38180.23639527249, 38525.229495410495, 28526.286842829097, 28530.57204141981, 28678.71321286844, 28726.569101463076, 28928.42143157167], "value": 20721.058642415068, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.7724335750303, 414.25020712510377, 425.2197218104778, 434.4048653344917, 445.0920122949184, 15243.542693719191, 18959.0, 20789.896050519765, 21121.788782112173, 21285.467863303405, 19133.617327653472, 20465.59068818623, 20540.486487837774, 20576.074076666548, 20665.380038598865, 5646.661200327993, 5749.540036797067, 5875.236219291486, 5877.441643043904, 5877.70611469427, 5805.941940580604, 6027.668478233695, 6034.758609655609, 6036.305824830135, 6036.63780173191, 5844.035734103868, 5918.852028699295, 5990.430909063653, 5998.8500287492725, 6002.249718785152, 5873.559483038768, 5897.3218079920925, 5906.586538942276, 5909.852253693692, 5912.9113063304085, 5277.736113194325, 5278.6041046921255, 5286.101362768339, 5317.069512835238, 5366.329208848894, 23623.0, 23696.88151559231, 23891.880540597358, 23909.04363825445, 24023.639645405332, 2396.928092157238, 2474.7401522840023, 2540.16174662361, 2727.9590806137926, 2879.3521457672064, 14425.495107671286, 15174.772378414333, 15664.451744189013, 15708.685826283525, 16010.679786404324, 1864.4499872537633, 1969.8227159555565, 2049.5695903860205, 2049.98975005124, 2088.56140210556, 87120.56439717824, 87201.56399218026, 87792.56103719505, 88467.55766221193, 89407.0, 10488.475576221159, 11004.944975275072, 11362.886371136348, 11481.253718508271, 11958.880411195776, 15289.082655040733, 15328.310226039855, 16314.265858036417, 16338.509844704678, 16889.746653800205, 8590.484570925764, 8740.300775937909, 8806.86789698155, 8901.421407608485, 8966.775830604287, 8403.831923361498, 8428.157184281645, 8475.067742548315, 8613.0, 8646.221840034426, 5025.271335656383, 5125.923111153335, 5173.068847607392, 5175.663581867242, 5263.131583288715, 2083.2708552006675, 2095.8428117890912, 2106.6734656128324, 2132.4349047502424, 2157.169489746459, 852.7228650688551, 906.7098528470958, 944.1596978688972, 995.3381001633977, 999.5402115027024, 18549.25802967893, 19841.900790495954, 20062.197512099643, 20089.598208035757, 20574.698345565368, 906.8866391701038, 919.6643225222879, 958.2621381536178, 980.7940332530106, 994.7165057958447, 11023.0, 11241.887581124083, 11466.73865874753, 11548.538058477734, 11590.884091159149, 504720.0, 511021.0, 512060.0, 512500.0, 517466.0, 90294.54852725695, 96434.0, 97867.59595818205, 98110.0, 101504.0, 1030.99484502577, 1050.3592808386877, 1066.1470823341297, 1089.1178145702006, 1091.9617813376653, 17866.464006079837, 17993.640127197643, 18314.175862085973, 18529.722054168928, 18586.535336616693, 41036.38445423261, 42794.57205427906, 43485.34771978486, 44270.557294427934, 44433.55566444423, 59798.402015979285, 59874.10188847258, 60020.39979600148, 60805.43959202989, 62462.37537624747, 8568.485890846569, 8656.82686346257, 8688.0, 8860.335474839283, 8876.733697989072, 9417.0, 12916.0, 13251.469941202244, 13408.731825363244, 13432.529861454803, 10729.088027517748, 11282.266652667551, 11421.657350279505, 11502.597409090642, 11916.642500724993, 11018.283811552545, 11156.0, 11211.719707007063, 11274.210805243554, 11542.769144617228, 11539.538418463168, 11645.534178632759, 11840.171188016757, 11877.76244475123, 12098.939505302416, 9118.726438206864, 9122.270218382646, 9133.725988220363, 9399.201067909304, 9567.665131720356, 8908.86636700437, 11455.198136130392, 11547.226386806597, 11715.0, 11739.23694959825], "value": 9603.204318835973, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1349.905506614536, 1508.5398953319236, 1543.9536813895584, 1705.2070787084003, 1846.972295415569, 7801.804954876131, 8552.0, 8879.689210877621, 8896.688615898445, 9062.184403403693, 8840.248578870787, 8919.197272245498, 8974.910250897505, 8977.596008179631, 8983.0, 2485.9875700621515, 2510.9748902510923, 2513.070164039308, 2514.4342522932375, 2523.2430270918744, 2423.660687503742, 2504.0484615845953, 2505.6993160820725, 2509.623556466526, 2515.333436639292, 2480.516299321633, 2491.389609545655, 2505.6993160820725, 2506.2105436787447, 2507.2979565721625, 2334.7198336199594, 2351.329870986769, 2393.521295740841, 2394.73657897632, 2400.087966572709, 2385.8926348314194, 2390.8565486070715, 2408.434018005767, 2413.9396515087087, 2422.5760491913843, 8633.093525179891, 8833.867491987625, 8862.335324850663, 9037.683681071197, 9052.683156089506, 5448.45515448456, 5665.206871038058, 5676.0, 5678.716064196774, 5683.090705487143, 3506.1234691327168, 3649.81750912456, 3699.6855267302312, 3708.6291370862696, 3739.5886452490204, 1179.817128345108, 1187.7386974865515, 1198.874118217592, 1219.408586835384, 1228.8341073954991, 12630.30533320667, 12719.10966232364, 12761.0, 12761.23432594038, 12797.424115914806, 4772.093302272557, 4836.347093142451, 4858.732769697701, 4871.902561948741, 4970.8757281068265, 10014.198864090855, 10020.348677336096, 10021.148202402732, 10023.2482563808, 10027.699169024942, 5597.328320601554, 5606.943930560724, 5611.130274807411, 5612.579056570774, 5617.8033768817895, 4471.0, 4605.194091034055, 4735.715857048588, 5138.229265610188, 5213.530782229542, 4029.315016447211, 4064.4919385076864, 4169.207850508394, 4180.561041090703, 4180.874573762792, 1221.383201483263, 1241.273854794937, 1241.4103300932165, 1244.8630650628425, 1278.9232646041266, 980.5930538826307, 988.1156365053237, 997.7495867603915, 1010.2221289606962, 1019.3730855523947, 6050.183225264533, 6112.2970858351855, 6279.96860015697, 6319.873602527924, 6323.620582765049, 480.24121887418494, 485.10498130948343, 488.2066641707226, 497.5174081141287, 502.32939026400163, 4250.766207858535, 4309.84915527955, 4345.652347812167, 4379.671524635665, 4498.3927169832305, 10762.192835537366, 11331.830022549668, 11335.716607084889, 11337.829932551018, 11346.035586975035, 9864.950675246579, 10179.236557258235, 10359.741006474747, 11255.774884502263, 11269.38018408979, 8383.077861435358, 8434.57827108642, 8638.09300023501, 8640.740777776677, 8649.870251946226, 5964.493018093511, 6102.747720124118, 6103.389661033861, 6175.5677102602385, 6229.781957631461, 9901.801963960825, 9983.950080249553, 9990.900090998997, 10006.599736010477, 10017.74955626086, 9831.0, 9881.950590247003, 9912.306138570231, 9955.751106222402, 10066.245031622511, 7949.8410031800195, 8129.715459958873, 8171.795705107182, 8177.632006559838, 8187.959060204661, 8778.956105219433, 8788.560571971504, 8852.114788521096, 8869.423487473294, 8881.777955551162, 7806.687732490636, 7948.046234451903, 7981.201879812204, 8009.799755006172, 8042.075161356285, 7803.687852486064, 7908.3673306136525, 7922.4850384724805, 7947.642356094106, 7990.8002299940645, 7109.502334836512, 7123.430125590044, 7205.0, 7205.135383753983, 7237.240089790706, 5462.453754624665, 5485.50630443262, 5490.149026900836, 5668.489835914787, 5780.046292361713, 5289.2330612061805, 5301.496357845998, 5360.597955153457, 5370.2213179089595, 5412.215228791724], "value": 4706.98694175937, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.4501729706523, 343.8263676843194, 348.42857713350094, 354.1217779905833, 359.41415492746825, 5337.626366154371, 5372.167314066316, 5378.300820893288, 5418.674879507223, 5421.972890135544, 5031.1698569736045, 5128.974355128219, 5177.6634518756255, 5291.698111321578, 5345.518903298703, 4250.342366477076, 4271.487421509423, 4276.743395396278, 4278.208531421681, 4286.528481867008, 4261.360795880627, 4283.87148385549, 4287.292596721537, 4308.504521979966, 4312.611864932155, 3981.920361592781, 4002.919941601166, 4234.491860976687, 4241.5122260939925, 4257.531671516146, 4225.429567008476, 4228.0, 4232.714334259481, 4240.939765058735, 4263.168682106991, 3815.828287727059, 3828.7894165820867, 3829.3681542545446, 3832.8466861325514, 3845.730798844082, 5002.19964805633, 5155.123628983082, 5172.482751724835, 5230.0, 5249.947500524984, 4818.204996175627, 4824.493428190025, 4847.781849816767, 4856.441509226449, 4879.2925025871045, 5551.8889622207735, 5569.774649577086, 5570.442955704438, 5576.525995290405, 5577.637453565505, 3847.921662669853, 4034.7377420467574, 4042.2319759245647, 4152.83388664453, 4167.291560434703, 5724.9427505724825, 5745.741441635137, 5753.309602847643, 5767.394423585505, 5778.335491418498, 4161.604647558477, 4176.2900306947895, 4190.958090419118, 4219.915601687949, 4250.958515163805, 4100.569440208795, 4114.177164567099, 4169.187008533307, 4301.720388174758, 4310.633596144363, 4721.15019296523, 4722.693024953367, 4730.361401210793, 4735.502772208937, 4743.762811859393, 5602.075657516464, 5612.719364031782, 5617.241672374177, 5626.915596266059, 5637.746301416446, 1346.2931960720505, 1394.902356835012, 1418.631155899453, 1427.600271923863, 1436.1598464898152, 933.0669330669331, 954.6658669465631, 972.9805403892024, 1004.1866088468364, 1014.1430491234895, 5184.248283998874, 5188.558972487381, 5234.241035049897, 5302.886393857333, 5306.336707911511, 5521.834344969577, 5543.168524721244, 5556.77772889088, 5560.555155587544, 5581.916271255853, 5088.365133550964, 5195.168633094972, 5198.246254293106, 5215.47845215483, 5236.502532259429, 2895.739383455499, 2908.985455072711, 2922.503174460347, 2926.6976195593184, 2930.1356099950567, 5605.523530499871, 5669.31968163823, 5676.779492409152, 5693.629914055656, 5697.9772180876025, 5828.154917536934, 5855.0, 5864.237649105589, 5865.970670146622, 5881.3530511643685, 5906.940930590639, 5927.673977931169, 5938.168656388109, 5963.9563076461445, 5965.940340596539, 5520.309961254843, 5709.628874123168, 5728.341240757366, 5749.8275051748515, 5758.596898217084, 5678.77284908599, 5685.5217643413835, 5694.37710252576, 5708.343540492897, 5711.171880077282, 5650.434956504317, 5877.735501902339, 5902.701405690741, 5908.970455147697, 5918.408159184047, 4153.7507749535125, 4195.748255104581, 4199.538050814347, 4203.97898010508, 4213.839620284786, 5727.198192253005, 5785.623934444247, 5802.912956305574, 5805.216295800182, 5824.5631577631, 5375.301210842722, 5616.971915140398, 5670.121131224667, 5695.174199740932, 5701.800436984686, 5616.354119276336, 5623.606347555632, 5626.85932851682, 5638.464345887134, 5643.830685079454, 5314.202869569595, 5478.972605136949, 5543.8891222174525, 5561.833145005657, 5576.86057848557, 5530.6128570999645, 5610.49505544503, 5631.605787594829, 5658.632188907708, 5659.660420374791, 5401.351837779492, 5436.755346009518, 5449.891002179855, 5475.288212532345, 5490.862728431821], "value": 4279.3300589719065, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [754.5812074298761, 774.9031371078615, 818.926296633303, 841.436237720727, 860.5482121886013, 13997.440102395893, 14974.251287435625, 15211.239438028082, 16314.265858036388, 16466.341346346162, 12692.175008624434, 13821.170729756222, 14115.717685646307, 14226.502072427467, 14245.92877035616, 851.7019043334845, 871.8517851965181, 873.3580818098692, 873.7902903303193, 874.422880898607, 857.7555396711938, 862.1335557764438, 862.3058437957442, 862.4911302331623, 862.8015556422026, 909.8134882349136, 912.8402529557334, 913.2420091324218, 913.6254135804321, 914.1407077347305, 898.5956319656149, 903.8960519540271, 904.6245807989676, 905.9637614495479, 906.4515967839494, 664.9268580456146, 665.7569986954775, 666.0608541955819, 666.1905784471842, 667.4426853577269, 13615.931920340434, 13672.042956993015, 13832.100913440694, 13927.651808704763, 14049.367778449994, 12771.297578633172, 13231.735365292736, 13321.067525273234, 13450.327483625779, 13457.0, 11319.943400283028, 11350.262232954914, 11434.656960291204, 11636.360000199986, 11703.590374336858, 3730.0, 3747.194353214045, 3795.772253664789, 3813.7521061130938, 3864.555576108727, 45387.0, 46688.533114669095, 57211.427885721445, 58627.41372586262, 64819.351806481805, 11712.88287117135, 12044.457999390048, 12079.154459187772, 12148.939255303667, 12190.878091219152, 19456.805431945784, 19922.800771992093, 20038.799612003986, 21887.67168492474, 21940.45148871259, 8427.578621068922, 8428.747137585882, 8457.873131902903, 8764.56177191138, 9163.404378715495, 4940.777665005084, 4950.752462376867, 4966.8261610844165, 5011.173156429149, 5014.749262536859, 3601.3697602919383, 3685.226102518501, 3718.3492888744363, 3719.9814000929823, 3728.254349130131, 644.3758166052983, 653.6339649796034, 654.8821212181758, 655.9901601475982, 668.6656671664168, 646.8285904235381, 649.7985624456434, 658.2890478283442, 706.703184662443, 710.9822254443577, 8650.354854337369, 8785.428947118417, 8821.22523115922, 8859.689910853089, 8862.468251904906, 578.5516224925632, 687.894157877185, 695.766918082448, 705.6683358821346, 712.0991945189339, 4069.104796944667, 4081.346984482528, 4108.822324168195, 4142.316517774533, 4220.092680073799, 90780.0, 93615.0, 93728.53135734277, 94247.0, 97299.51350243344, 49602.75198624056, 50250.246246306335, 51206.74396627993, 81604.59197703973, 83706.0, 75710.24289757032, 75916.62041689757, 76788.0, 77661.22338776653, 79533.20466795258, 7939.960300198462, 7963.960180199062, 8017.118117007008, 8127.715529956659, 8421.915780842113, 50018.74990625024, 51047.234291484914, 51435.742821285654, 51843.493217078765, 52633.0, 62749.0, 66385.66807166126, 67404.6629766848, 69010.0, 69267.30732692608, 11565.826512602149, 11618.419079045845, 11642.068634509049, 11746.177767556532, 11851.703707407383, 12132.636020919386, 12359.196652217577, 12378.566750163702, 12395.318257495564, 12748.872511274769, 11042.944785276022, 11453.19827612059, 11616.419179040846, 11829.526818927146, 11889.643310700692, 11987.940060299643, 12165.08761842883, 12169.878301216875, 12245.632631021084, 12776.936115319364, 11475.598354057567, 11549.191556591293, 11799.469023893773, 11857.525698971944, 11921.105917056082, 9306.0, 9313.115254050854, 9490.715278541655, 9550.18823399991, 9686.854697179408, 9387.906120938704, 9388.0, 9419.62321507132, 9479.526023698649, 9614.855777163208], "value": 7063.544987810247, "unit": "score"}], "name": "dromaeo_css", "value": 7350.8879535476, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 111.0, 111.0, 112.0, 111.0, 111.0, 112.0, 110.0, 112.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 120.0, 118.0, 151.0, 120.0, 117.0, 120.0, 118.0, 146.0, 119.0], "value": 127.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 160.0, 162.0, 161.0, 168.0, 160.0, 161.0, 160.0, 160.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 109.0, 74.0, 76.0, 77.0, 76.0, 99.0, 76.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 109.0, 82.0, 81.0, 81.0, 99.0, 82.0, 83.0, 109.0], "value": 88.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 147.0, 145.0, 145.0, 172.0, 146.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 85.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 50.0, 49.0, 50.0, 49.0, 50.0, 51.0, 50.0, 49.0, 49.0], "value": 49.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 59.0, 60.0, 60.0, 59.0, 60.0, 60.0, 61.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 74.0, 77.0, 73.0, 75.0, 83.0, 74.0, 82.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 122.0, 122.0, 134.0, 118.0, 120.0, 131.0, 133.0, 161.0, 126.0], "value": 129.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 149.0, 151.0, 151.0, 152.0, 151.0, 159.0, 150.0, 150.0, 152.0], "value": 152.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 64.0, 62.0, 62.0, 65.0, 62.0, 62.0, 62.0, 61.0, 60.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1449.4, "alertThreshold": 2.0}]} 17:05:45 INFO - Return code: 0 17:05:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:05:45 INFO - # TBPL SUCCESS # 17:05:45 INFO - Running post-action listener: _resource_record_post_action 17:05:45 INFO - [mozharness: 2017-01-21 01:05:45.972241Z] Finished run-tests step (success) 17:05:45 INFO - Running post-run listener: _resource_record_post_run 17:05:46 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 364810240; Read time: 188; Write time: 233880 17:05:46 INFO - TinderboxPrint: CPU usage
12.9% 17:05:46 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 188 17:05:46 INFO - TinderboxPrint: I/O write bytes / time
364,810,240 / 233,880 17:05:46 INFO - TinderboxPrint: CPU idle
8,274.7 (87.0%) 17:05:46 INFO - TinderboxPrint: CPU user
1,187.7 (12.5%) 17:05:46 INFO - TinderboxPrint: Swap in / out
0 / 0 17:05:46 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 115040256; Read time: 0; Write time: 100760 17:05:46 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 249769984; Read time: 172; Write time: 133120 17:05:46 INFO - Running post-run listener: _upload_blobber_files 17:05:46 INFO - Blob upload gear active. 17:05:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:05:46 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 17:05:46 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'] 17:05:46 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 17:05:47 INFO - (blobuploader) - INFO - Open directory for files ... 17:05:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:05:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:05:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:05:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:05:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:05:50 INFO - (blobuploader) - INFO - Done attempting. 17:05:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:05:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:05:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:05:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:05:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:05:50 INFO - (blobuploader) - INFO - Done attempting. 17:05:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:05:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:05:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:05:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:05:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:05:52 INFO - (blobuploader) - INFO - Done attempting. 17:05:52 INFO - (blobuploader) - INFO - Iteration through files over. 17:05:52 INFO - Return code: 0 17:05:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:05:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:05:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c8af2e1750d34481b589d3065b5f42be17f2ed4b3d992da4c2db8df3a9cdceddb1eb3a1a4d62357b8e72214df059543cfaf9264e2132dfce46f18a8ef807e7d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dd30b805c56259379f5512e13be0d74ca6859c130c25ee2b1602f96fa17c952ef991793cd36f66c65f38a1c9d2496d416aa061bb9dc12b44b38d5086a21cdc58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a45d12c69b6a8d7d47ae2fa44eec958d30049c867767b08cad0f9fef130124d15bb2b7fff4aca07ad0dae87a7739b3939ca429bdd5ac2f59da2343938687f6e0"} 17:05:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:05:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:05:52 INFO - Contents: 17:05:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c8af2e1750d34481b589d3065b5f42be17f2ed4b3d992da4c2db8df3a9cdceddb1eb3a1a4d62357b8e72214df059543cfaf9264e2132dfce46f18a8ef807e7d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dd30b805c56259379f5512e13be0d74ca6859c130c25ee2b1602f96fa17c952ef991793cd36f66c65f38a1c9d2496d416aa061bb9dc12b44b38d5086a21cdc58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a45d12c69b6a8d7d47ae2fa44eec958d30049c867767b08cad0f9fef130124d15bb2b7fff4aca07ad0dae87a7739b3939ca429bdd5ac2f59da2343938687f6e0"} 17:05:52 INFO - Running post-run listener: copy_logs_to_upload_dir 17:05:52 INFO - Copying logs to upload dir... 17:05:52 INFO - mkdir: /builds/slave/test/build/upload/logs 17:05:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.399566 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-20 17:05:52.312544) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-20 17:05:52.316432) ========= 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=20e666a3d4cfbb71505a330e000001b4-1484959514.572678-2134908636 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/c8af2e1750d34481b589d3065b5f42be17f2ed4b3d992da4c2db8df3a9cdceddb1eb3a1a4d62357b8e72214df059543cfaf9264e2132dfce46f18a8ef807e7d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dd30b805c56259379f5512e13be0d74ca6859c130c25ee2b1602f96fa17c952ef991793cd36f66c65f38a1c9d2496d416aa061bb9dc12b44b38d5086a21cdc58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a45d12c69b6a8d7d47ae2fa44eec958d30049c867767b08cad0f9fef130124d15bb2b7fff4aca07ad0dae87a7739b3939ca429bdd5ac2f59da2343938687f6e0"} build_url:https://queue.taskcluster.net/v1/task/Sm25fwRATh24pTgFKOjQWQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011375 build_url: 'https://queue.taskcluster.net/v1/task/Sm25fwRATh24pTgFKOjQWQ/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/c8af2e1750d34481b589d3065b5f42be17f2ed4b3d992da4c2db8df3a9cdceddb1eb3a1a4d62357b8e72214df059543cfaf9264e2132dfce46f18a8ef807e7d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dd30b805c56259379f5512e13be0d74ca6859c130c25ee2b1602f96fa17c952ef991793cd36f66c65f38a1c9d2496d416aa061bb9dc12b44b38d5086a21cdc58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a45d12c69b6a8d7d47ae2fa44eec958d30049c867767b08cad0f9fef130124d15bb2b7fff4aca07ad0dae87a7739b3939ca429bdd5ac2f59da2343938687f6e0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-20 17:05:52.341656) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 17:05:52.341977) ========= 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=20e666a3d4cfbb71505a330e000001b4-1484959514.572678-2134908636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004540 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 17:05:52.424921) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-20 17:05:52.425260) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-20 17:05:52.425596) ========= ========= Total master_lag: 0.17 =========