builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1484266476.05 results: success (0) buildid: 20170112144117 builduid: 812ccfb2206b4087ab8515ba0403bcf0 revision: 5be69f2ff0164ed5e53ac7fd70f88b220a1d6ade ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 16:14:36.049552) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 16:14:36.051223) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 16:14:36.051506) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 16:14:36.067341) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 16:14:36.067616) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1484264711.283547-624905592 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-12 16:14:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.7M=0s 2017-01-12 16:14:36 (35.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116156 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 16:14:36.197675) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 16:14:36.198016) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1484264711.283547-624905592 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019211 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 16:14:36.248296) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-12 16:14:36.248743) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5be69f2ff0164ed5e53ac7fd70f88b220a1d6ade --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 5be69f2ff0164ed5e53ac7fd70f88b220a1d6ade --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=8c6b6742ce8f6f39ef4ce27d000001f1-1484264711.283547-624905592 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-12 16:14:36,474 truncating revision to first 12 chars 2017-01-12 16:14:36,474 Setting DEBUG logging. 2017-01-12 16:14:36,474 attempt 1/10 2017-01-12 16:14:36,474 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/5be69f2ff016?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-12 16:14:37,335 unpacking tar archive at: mozilla-aurora-5be69f2ff016/testing/mozharness/ program finished with exit code 0 elapsedTime=1.178235 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-12 16:14:37.443603) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 16:14:37.444373) ========= script_repo_revision: 5be69f2ff0164ed5e53ac7fd70f88b220a1d6ade ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 16:14:37.444813) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 16:14:37.445117) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 16:14:37.456322) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-12 16:14:37.456837) ========= /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=8c6b6742ce8f6f39ef4ce27d000001f1-1484264711.283547-624905592 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:14:37 INFO - MultiFileLogger online at 20170112 16:14:37 in /builds/slave/test 16:14:37 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:14:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:14:37 INFO - {'append_to_log': False, 16:14:37 INFO - 'base_work_dir': '/builds/slave/test', 16:14:37 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:14:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:14:37 INFO - 'branch': 'Mozilla-Aurora', 16:14:37 INFO - 'buildbot_json_path': 'buildprops.json', 16:14:37 INFO - 'config_files': ('talos/linux_config.py',), 16:14:37 INFO - 'default_actions': ('clobber', 16:14:37 INFO - 'read-buildbot-config', 16:14:37 INFO - 'download-and-extract', 16:14:37 INFO - 'populate-webroot', 16:14:37 INFO - 'create-virtualenv', 16:14:37 INFO - 'install', 16:14:37 INFO - 'run-tests'), 16:14:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:14:37 INFO - 'download_minidump_stackwalk': True, 16:14:37 INFO - 'download_symbols': 'ondemand', 16:14:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:14:37 INFO - 'tooltool.py': '/tools/tooltool.py', 16:14:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:14:37 INFO - '/tools/misc-python/virtualenv.py')}, 16:14:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:14:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:14:37 INFO - 'installer_path': 'installer.exe', 16:14:37 INFO - 'log_level': 'info', 16:14:37 INFO - 'log_name': 'talos', 16:14:37 INFO - 'log_to_console': True, 16:14:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:14:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:14:37 INFO - 'opt_config_files': (), 16:14:37 INFO - 'pip_index': False, 16:14:37 INFO - 'sps_profile': False, 16:14:37 INFO - 'sps_profile_interval': 0, 16:14:37 INFO - 'suite': 'dromaeojs', 16:14:37 INFO - 'system_bits': '32', 16:14:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:14:37 INFO - 'title': 'talos-linux64-ix-041', 16:14:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:14:37 INFO - 'use_talos_json': True, 16:14:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:14:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:14:37 INFO - 'work_dir': 'build'} 16:14:37 INFO - [mozharness: 2017-01-13 00:14:37.788251Z] Running clobber step. 16:14:37 INFO - Running pre-action listener: _resource_record_pre_action 16:14:37 INFO - Running main action method: clobber 16:14:37 INFO - rmtree: /builds/slave/test/build 16:14:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:14:38 INFO - Running post-action listener: _resource_record_post_action 16:14:38 INFO - [mozharness: 2017-01-13 00:14:38.255043Z] Finished clobber step (success) 16:14:38 INFO - [mozharness: 2017-01-13 00:14:38.255143Z] Running read-buildbot-config step. 16:14:38 INFO - Running pre-action listener: _resource_record_pre_action 16:14:38 INFO - Running main action method: read_buildbot_config 16:14:38 INFO - Using buildbot properties: 16:14:38 INFO - { 16:14:38 INFO - "project": "", 16:14:38 INFO - "product": "firefox", 16:14:38 INFO - "script_repo_revision": "production", 16:14:38 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 16:14:38 INFO - "repository": "", 16:14:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 16:14:38 INFO - "buildid": "20170112144117", 16:14:38 INFO - "pgo_build": "True", 16:14:38 INFO - "basedir": "/builds/slave/test", 16:14:38 INFO - "buildnumber": 737, 16:14:38 INFO - "slavename": "talos-linux64-ix-041", 16:14:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:14:38 INFO - "platform": "ubuntu64_hw", 16:14:38 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 16:14:38 INFO - "branch": "mozilla-aurora", 16:14:38 INFO - "repo_path": "releases/mozilla-aurora", 16:14:38 INFO - "revision": "5be69f2ff0164ed5e53ac7fd70f88b220a1d6ade", 16:14:38 INFO - "stage_platform": "linux64-pgo", 16:14:38 INFO - "builduid": "812ccfb2206b4087ab8515ba0403bcf0", 16:14:38 INFO - "slavebuilddir": "test" 16:14:38 INFO - } 16:14:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZLcQY6-oSL-QFAZZ5mpGVA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 16:14:38 INFO - Running post-action listener: _resource_record_post_action 16:14:38 INFO - [mozharness: 2017-01-13 00:14:38.257532Z] Finished read-buildbot-config step (success) 16:14:38 INFO - [mozharness: 2017-01-13 00:14:38.257620Z] Running download-and-extract step. 16:14:38 INFO - Running pre-action listener: _resource_record_pre_action 16:14:38 INFO - Running main action method: download_and_extract 16:14:38 INFO - mkdir: /builds/slave/test/build/tests 16:14:38 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:14:38 INFO - trying https://queue.taskcluster.net/v1/task/ZLcQY6-oSL-QFAZZ5mpGVA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 16:14:38 INFO - Downloading https://queue.taskcluster.net/v1/task/ZLcQY6-oSL-QFAZZ5mpGVA/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:14:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZLcQY6-oSL-QFAZZ5mpGVA/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:14:38 INFO - Downloaded 1361 bytes. 16:14:38 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 16:14:38 INFO - Using the following test package requirements: 16:14:38 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 16:14:38 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 16:14:38 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 16:14:38 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 16:14:38 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 16:14:38 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 16:14:38 INFO - u'jsshell-linux-x86_64.zip'], 16:14:38 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 16:14:38 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 16:14:38 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 16:14:38 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 16:14:38 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 16:14:38 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 16:14:38 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 16:14:38 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 16:14:38 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 16:14:38 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 16:14:38 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 16:14:38 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:14:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZLcQY6-oSL-QFAZZ5mpGVA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 16:14:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZLcQY6-oSL-QFAZZ5mpGVA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:14:38 INFO - Fetch https://queue.taskcluster.net/v1/task/ZLcQY6-oSL-QFAZZ5mpGVA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 16:14:39 INFO - Http code: 200 16:14:39 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 16:14:39 INFO - x-amz-cf-id: yHF1JZCnc7txrZcN-O-LSGCPLY3F11YL-gJHwNbbEOtVTiiGo3uhSw== 16:14:39 INFO - x-amz-version-id: 2gftLwH0SXQ8le8XxCs5tOFpAbxvpnPs 16:14:39 INFO - Expected file size: 21948483 16:14:39 INFO - Obtained file size: 21948483 16:14:43 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:14:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZLcQY6-oSL-QFAZZ5mpGVA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 16:14:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZLcQY6-oSL-QFAZZ5mpGVA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:14:43 INFO - Fetch https://queue.taskcluster.net/v1/task/ZLcQY6-oSL-QFAZZ5mpGVA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 16:14:44 INFO - Http code: 200 16:14:44 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 16:14:44 INFO - x-amz-cf-id: oRYDwnJfwfYxgjsI_NqXS9pLdo5UWHQe7QNy4LBvvhMfh59FFGPHBg== 16:14:44 INFO - x-amz-version-id: 2gftLwH0SXQ8le8XxCs5tOFpAbxvpnPs 16:14:44 INFO - Expected file size: 21948483 16:14:44 INFO - Obtained file size: 21948483 16:14:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZLcQY6-oSL-QFAZZ5mpGVA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 16:14:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZLcQY6-oSL-QFAZZ5mpGVA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:14:48 INFO - Fetch https://queue.taskcluster.net/v1/task/ZLcQY6-oSL-QFAZZ5mpGVA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 16:14:49 INFO - Http code: 200 16:14:49 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 16:14:49 INFO - x-amz-cf-id: XzIo2FRf8uHCAQ9EkNVKelesU8YI7nHE2Xl7Oeg8h5Zhkp6aZCXT6w== 16:14:49 INFO - x-amz-version-id: _GK2feHyDfuJEgUt92ppGCvtnKxHzb.W 16:14:49 INFO - Expected file size: 14409038 16:14:49 INFO - Obtained file size: 14409038 16:14: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:14:49 INFO - trying https://queue.taskcluster.net/v1/task/ZLcQY6-oSL-QFAZZ5mpGVA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 16:14:49 INFO - Downloading https://queue.taskcluster.net/v1/task/ZLcQY6-oSL-QFAZZ5mpGVA/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:14:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZLcQY6-oSL-QFAZZ5mpGVA/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:14:51 INFO - Downloaded 64161510 bytes. 16:14:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZLcQY6-oSL-QFAZZ5mpGVA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 16:14:51 INFO - mkdir: /builds/slave/test/properties 16:14:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:14:51 INFO - Writing to file /builds/slave/test/properties/build_url 16:14:51 INFO - Contents: 16:14:51 INFO - build_url:https://queue.taskcluster.net/v1/task/ZLcQY6-oSL-QFAZZ5mpGVA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 16:14:51 INFO - Running post-action listener: _resource_record_post_action 16:14:51 INFO - Running post-action listener: set_extra_try_arguments 16:14:51 INFO - [mozharness: 2017-01-13 00:14:51.753045Z] Finished download-and-extract step (success) 16:14:51 INFO - [mozharness: 2017-01-13 00:14:51.753270Z] Running populate-webroot step. 16:14:51 INFO - Running pre-action listener: _resource_record_pre_action 16:14:51 INFO - Running main action method: populate_webroot 16:14:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:14:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:14:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:14:51 INFO - '--tppagecycles', 16:14:51 INFO - '7'], 16:14:51 INFO - 'tests': ['tsvgm']}}, 16:14:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:14:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:14:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:14:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:14:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:14:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:14:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:51 INFO - 'talos_options': ['--disable-e10s'], 16:14:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:14:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:14:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:51 INFO - 'talos_options': ['--disable-e10s'], 16:14:51 INFO - 'tests': ['damp', 'tps']}, 16:14:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:51 INFO - 'tests': ['damp', 'tps']}, 16:14:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:14:51 INFO - 'tests': ['dromaeo_dom']}, 16:14:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:14:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:14:51 INFO - 'tests': ['basic_compositor_video']}, 16:14:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:14:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:14:51 INFO - 'tests': ['a11yr', 16:14:51 INFO - 'ts_paint', 16:14:51 INFO - 'tpaint', 16:14:51 INFO - 'sessionrestore', 16:14:51 INFO - 'sessionrestore_no_auto_restore', 16:14:51 INFO - 'tabpaint']}, 16:14:51 INFO - 'other-e10s': {'tests': ['a11yr', 16:14:51 INFO - 'ts_paint', 16:14:51 INFO - 'tpaint', 16:14:51 INFO - 'sessionrestore', 16:14:51 INFO - 'sessionrestore_no_auto_restore', 16:14:51 INFO - 'tabpaint']}, 16:14:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:14:51 INFO - 'ts_paint', 16:14:51 INFO - 'tpaint', 16:14:51 INFO - 'sessionrestore', 16:14:51 INFO - 'sessionrestore_no_auto_restore', 16:14:51 INFO - 'tabpaint']}, 16:14:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:14:51 INFO - 'ts_paint', 16:14:51 INFO - 'tpaint', 16:14:51 INFO - 'sessionrestore', 16:14:51 INFO - 'sessionrestore_no_auto_restore', 16:14:51 INFO - 'tabpaint']}, 16:14:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:14:51 INFO - 'tests': ['a11yr', 16:14:51 INFO - 'ts_paint', 16:14:51 INFO - 'tpaint', 16:14:51 INFO - 'sessionrestore', 16:14:51 INFO - 'sessionrestore_no_auto_restore', 16:14:51 INFO - 'tabpaint']}, 16:14:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:14:51 INFO - 'tests': ['a11yr', 16:14:51 INFO - 'ts_paint', 16:14:51 INFO - 'tpaint', 16:14:51 INFO - 'sessionrestore', 16:14:51 INFO - 'sessionrestore_no_auto_restore', 16:14:51 INFO - 'tabpaint']}, 16:14:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:14:51 INFO - 'tests': ['tsvgx', 16:14:51 INFO - 'tsvgr_opacity', 16:14:51 INFO - 'tart', 16:14:51 INFO - 'tscrollx', 16:14:51 INFO - 'cart']}, 16:14:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:14:51 INFO - 'tsvgr_opacity', 16:14:51 INFO - 'tart', 16:14:51 INFO - 'tscrollx', 16:14:51 INFO - 'cart']}, 16:14:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:51 INFO - 'talos_options': ['--disable-e10s'], 16:14:51 INFO - 'tests': ['tp5o']}, 16:14:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:51 INFO - 'tests': ['tp5o']}, 16:14:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:51 INFO - 'talos_options': ['--disable-e10s', 16:14:51 INFO - '--xperf_path', 16:14:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:14:51 INFO - 'tests': ['tp5n']}, 16:14:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:51 INFO - 'talos_options': ['--xperf_path', 16:14:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:14:51 INFO - 'tests': ['tp5n']}}, 16:14:51 INFO - 'talos.zip': {'path': '', 16:14:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:14:51 INFO - Running post-action listener: _resource_record_post_action 16:14:51 INFO - [mozharness: 2017-01-13 00:14:51.772725Z] Finished populate-webroot step (success) 16:14:51 INFO - [mozharness: 2017-01-13 00:14:51.772812Z] Running create-virtualenv step. 16:14:51 INFO - Running pre-action listener: _resource_record_pre_action 16:14:51 INFO - Running main action method: create_virtualenv 16:14:51 INFO - Creating virtualenv /builds/slave/test/build/venv 16:14:51 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:14:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:14:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:14:51 INFO - Using real prefix '/usr' 16:14:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:14:52 INFO - Installing distribute.............................................................................................................................................................................................done. 16:14:54 INFO - Installing pip.................done. 16:14:54 INFO - Return code: 0 16:14:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:14:54 INFO - Reading from file tmpfile_stdout 16:14:54 INFO - Output received: 16:14:54 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:14:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:14: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:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14: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:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8eaaea5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16bfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bcf60>, '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 0x16bdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16be1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1484264711.283547-624905592', '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:14: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', 'pip>=1.5'] in /builds/slave/test/build 16:14: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 pip>=1.5 16:14:54 INFO - Using env: {'DISPLAY': ':0', 16:14:54 INFO - 'HOME': '/home/cltbld', 16:14:54 INFO - 'LANG': 'en_US.UTF-8', 16:14:54 INFO - 'LANGUAGE': 'en_US:en', 16:14:54 INFO - 'LOGNAME': 'cltbld', 16:14:54 INFO - 'MAIL': '/var/mail/cltbld', 16:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:54 INFO - 'MOZ_NO_REMOTE': '1', 16:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:54 INFO - 'NO_EM_RESTART': '1', 16:14:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:54 INFO - 'PWD': '/builds/slave/test', 16:14:54 INFO - 'SHELL': '/bin/bash', 16:14:54 INFO - 'SHLVL': '1', 16:14:54 INFO - 'TERM': 'linux', 16:14:54 INFO - 'TMOUT': '86400', 16:14:54 INFO - 'USER': 'cltbld', 16:14:54 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1484264711.283547-624905592', 16:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:54 INFO - '_': '/tools/buildbot/bin/python'} 16:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:54 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:14:54 INFO - Cleaning up... 16:14:54 INFO - Return code: 0 16:14:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:14: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:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14: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:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14: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', '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 0x7f8eaaea5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16bfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bcf60>, '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 0x16bdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16be1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1484264711.283547-624905592', '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:14: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', 'psutil>=3.1.1'] in /builds/slave/test/build 16:14: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 psutil>=3.1.1 16:14:54 INFO - Using env: {'DISPLAY': ':0', 16:14:54 INFO - 'HOME': '/home/cltbld', 16:14:54 INFO - 'LANG': 'en_US.UTF-8', 16:14:54 INFO - 'LANGUAGE': 'en_US:en', 16:14:54 INFO - 'LOGNAME': 'cltbld', 16:14:54 INFO - 'MAIL': '/var/mail/cltbld', 16:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:54 INFO - 'MOZ_NO_REMOTE': '1', 16:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:54 INFO - 'NO_EM_RESTART': '1', 16:14:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:54 INFO - 'PWD': '/builds/slave/test', 16:14:54 INFO - 'SHELL': '/bin/bash', 16:14:54 INFO - 'SHLVL': '1', 16:14:54 INFO - 'TERM': 'linux', 16:14:54 INFO - 'TMOUT': '86400', 16:14:54 INFO - 'USER': 'cltbld', 16:14:54 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1484264711.283547-624905592', 16:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:54 INFO - '_': '/tools/buildbot/bin/python'} 16:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:54 INFO - Downloading/unpacking psutil>=3.1.1 16:14:54 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:14:54 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:14:54 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:14:54 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:14:54 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:14:54 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:14:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:14:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:14:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:14:57 INFO - Installing collected packages: psutil 16:14:57 INFO - Running setup.py install for psutil 16:14:57 INFO - building 'psutil._psutil_linux' extension 16:14:57 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:14:57 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:14:57 INFO - building 'psutil._psutil_posix' extension 16:14:57 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:14:57 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:14:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:14:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:14:57 INFO - Successfully installed psutil 16:14:57 INFO - Cleaning up... 16:14:57 INFO - Return code: 0 16:14:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:14:57 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:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:57 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:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:57 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 0x7f8eaaea5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16bfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bcf60>, '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 0x16bdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16be1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1484264711.283547-624905592', '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:14:57 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:14:57 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:14:57 INFO - Using env: {'DISPLAY': ':0', 16:14:57 INFO - 'HOME': '/home/cltbld', 16:14:57 INFO - 'LANG': 'en_US.UTF-8', 16:14:57 INFO - 'LANGUAGE': 'en_US:en', 16:14:57 INFO - 'LOGNAME': 'cltbld', 16:14:57 INFO - 'MAIL': '/var/mail/cltbld', 16:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:57 INFO - 'MOZ_NO_REMOTE': '1', 16:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:57 INFO - 'NO_EM_RESTART': '1', 16:14:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:57 INFO - 'PWD': '/builds/slave/test', 16:14:57 INFO - 'SHELL': '/bin/bash', 16:14:57 INFO - 'SHLVL': '1', 16:14:57 INFO - 'TERM': 'linux', 16:14:57 INFO - 'TMOUT': '86400', 16:14:57 INFO - 'USER': 'cltbld', 16:14:57 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1484264711.283547-624905592', 16:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:57 INFO - '_': '/tools/buildbot/bin/python'} 16:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:14:57 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:14:57 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:14:57 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:14:57 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:14:57 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:14:57 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:14:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:14:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:14:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:14:59 INFO - Installing collected packages: mozsystemmonitor 16:14:59 INFO - Running setup.py install for mozsystemmonitor 16:14:59 INFO - Successfully installed mozsystemmonitor 16:14:59 INFO - Cleaning up... 16:15:00 INFO - Return code: 0 16:15:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:15:00 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:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:00 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:15:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:00 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 0x7f8eaaea5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16bfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bcf60>, '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 0x16bdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16be1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1484264711.283547-624905592', '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:15:00 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:15:00 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:15:00 INFO - Using env: {'DISPLAY': ':0', 16:15:00 INFO - 'HOME': '/home/cltbld', 16:15:00 INFO - 'LANG': 'en_US.UTF-8', 16:15:00 INFO - 'LANGUAGE': 'en_US:en', 16:15:00 INFO - 'LOGNAME': 'cltbld', 16:15:00 INFO - 'MAIL': '/var/mail/cltbld', 16:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:00 INFO - 'MOZ_NO_REMOTE': '1', 16:15:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:00 INFO - 'NO_EM_RESTART': '1', 16:15:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:00 INFO - 'PWD': '/builds/slave/test', 16:15:00 INFO - 'SHELL': '/bin/bash', 16:15:00 INFO - 'SHLVL': '1', 16:15:00 INFO - 'TERM': 'linux', 16:15:00 INFO - 'TMOUT': '86400', 16:15:00 INFO - 'USER': 'cltbld', 16:15:00 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1484264711.283547-624905592', 16:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:00 INFO - '_': '/tools/buildbot/bin/python'} 16:15:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:00 INFO - Downloading/unpacking jsonschema==2.5.1 16:15:00 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:15:00 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:15:00 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:15:00 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:15:00 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:15:00 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:15:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:15:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:15:02 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:15:02 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:15:02 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:15:02 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:15:02 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:15:02 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:15:02 INFO - Downloading functools32-3.2.3-2.tar.gz 16:15:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:15:02 INFO - warning: no files found matching '*.txt' 16:15:02 INFO - no previously-included directories found matching 'build' 16:15:02 INFO - no previously-included directories found matching 'dist' 16:15:02 INFO - no previously-included directories found matching '.git*' 16:15:02 INFO - Installing collected packages: jsonschema, functools32 16:15:02 INFO - Running setup.py install for functools32 16:15:02 INFO - warning: no files found matching '*.txt' 16:15:02 INFO - no previously-included directories found matching 'build' 16:15:02 INFO - no previously-included directories found matching 'dist' 16:15:02 INFO - no previously-included directories found matching '.git*' 16:15:02 INFO - Successfully installed jsonschema functools32 16:15:02 INFO - Cleaning up... 16:15:02 INFO - Return code: 0 16:15:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:02 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 0x7f8eaaea5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16bfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bcf60>, '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 0x16bdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16be1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1484264711.283547-624905592', '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:15:02 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:15:02 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:15:02 INFO - Using env: {'DISPLAY': ':0', 16:15:02 INFO - 'HOME': '/home/cltbld', 16:15:02 INFO - 'LANG': 'en_US.UTF-8', 16:15:02 INFO - 'LANGUAGE': 'en_US:en', 16:15:02 INFO - 'LOGNAME': 'cltbld', 16:15:02 INFO - 'MAIL': '/var/mail/cltbld', 16:15:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:02 INFO - 'MOZ_NO_REMOTE': '1', 16:15:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:02 INFO - 'NO_EM_RESTART': '1', 16:15:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:02 INFO - 'PWD': '/builds/slave/test', 16:15:02 INFO - 'SHELL': '/bin/bash', 16:15:02 INFO - 'SHLVL': '1', 16:15:02 INFO - 'TERM': 'linux', 16:15:02 INFO - 'TMOUT': '86400', 16:15:02 INFO - 'USER': 'cltbld', 16:15:02 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1484264711.283547-624905592', 16:15:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:02 INFO - '_': '/tools/buildbot/bin/python'} 16:15:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:15:02 INFO - Cleaning up... 16:15:02 INFO - Return code: 0 16:15:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:03 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 0x7f8eaaea5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16bfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bcf60>, '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 0x16bdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16be1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1484264711.283547-624905592', '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:15:03 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:15:03 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:15:03 INFO - Using env: {'DISPLAY': ':0', 16:15:03 INFO - 'HOME': '/home/cltbld', 16:15:03 INFO - 'LANG': 'en_US.UTF-8', 16:15:03 INFO - 'LANGUAGE': 'en_US:en', 16:15:03 INFO - 'LOGNAME': 'cltbld', 16:15:03 INFO - 'MAIL': '/var/mail/cltbld', 16:15:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:03 INFO - 'MOZ_NO_REMOTE': '1', 16:15:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:03 INFO - 'NO_EM_RESTART': '1', 16:15:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:03 INFO - 'PWD': '/builds/slave/test', 16:15:03 INFO - 'SHELL': '/bin/bash', 16:15:03 INFO - 'SHLVL': '1', 16:15:03 INFO - 'TERM': 'linux', 16:15:03 INFO - 'TMOUT': '86400', 16:15:03 INFO - 'USER': 'cltbld', 16:15:03 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1484264711.283547-624905592', 16:15:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:03 INFO - '_': '/tools/buildbot/bin/python'} 16:15:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:03 INFO - Downloading/unpacking blobuploader==1.2.4 16:15:03 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:15:03 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:15:03 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:15:03 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:15:03 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:15:03 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:15:05 INFO - Downloading blobuploader-1.2.4.tar.gz 16:15:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:15:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:15:05 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:15:05 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:15:05 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:15:05 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:15:05 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:15:05 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:15:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:15:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:15:05 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:15:05 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:15:05 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:15:05 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:15:05 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:15:05 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:15:05 INFO - Downloading docopt-0.6.1.tar.gz 16:15:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:15:06 INFO - Installing collected packages: blobuploader, requests, docopt 16:15:06 INFO - Running setup.py install for blobuploader 16:15:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:15:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:15:06 INFO - Running setup.py install for requests 16:15:06 INFO - Running setup.py install for docopt 16:15:06 INFO - Successfully installed blobuploader requests docopt 16:15:06 INFO - Cleaning up... 16:15:06 INFO - Return code: 0 16:15:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:15:06 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:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:06 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:15:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:06 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 0x7f8eaaea5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16bfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bcf60>, '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 0x16bdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16be1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1484264711.283547-624905592', '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:15:06 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:15:06 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:15:06 INFO - Using env: {'DISPLAY': ':0', 16:15:06 INFO - 'HOME': '/home/cltbld', 16:15:06 INFO - 'LANG': 'en_US.UTF-8', 16:15:06 INFO - 'LANGUAGE': 'en_US:en', 16:15:06 INFO - 'LOGNAME': 'cltbld', 16:15:06 INFO - 'MAIL': '/var/mail/cltbld', 16:15:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:06 INFO - 'MOZ_NO_REMOTE': '1', 16:15:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:06 INFO - 'NO_EM_RESTART': '1', 16:15:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:06 INFO - 'PWD': '/builds/slave/test', 16:15:06 INFO - 'SHELL': '/bin/bash', 16:15:06 INFO - 'SHLVL': '1', 16:15:06 INFO - 'TERM': 'linux', 16:15:06 INFO - 'TMOUT': '86400', 16:15:06 INFO - 'USER': 'cltbld', 16:15:06 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1484264711.283547-624905592', 16:15:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:06 INFO - '_': '/tools/buildbot/bin/python'} 16:15:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:15:06 INFO - Running setup.py (path:/tmp/pip-2xRmT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:15:06 INFO - Running setup.py (path:/tmp/pip-wqk4iq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:15:06 INFO - Running setup.py (path:/tmp/pip-df1PHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:15:07 INFO - Running setup.py (path:/tmp/pip-pa_vhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:15:07 INFO - Running setup.py (path:/tmp/pip-qf6U2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:15:07 INFO - Running setup.py (path:/tmp/pip-RXI4uX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:15:07 INFO - Running setup.py (path:/tmp/pip-xJqKjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:15:07 INFO - Running setup.py (path:/tmp/pip-PxQ0pr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:15:07 INFO - Running setup.py (path:/tmp/pip-DdMxOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:15:07 INFO - Running setup.py (path:/tmp/pip-sXNZIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:15:07 INFO - Running setup.py (path:/tmp/pip-3jgzwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:15:07 INFO - Running setup.py (path:/tmp/pip-qbzj5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:15:07 INFO - Running setup.py (path:/tmp/pip-X4F0no-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:15:07 INFO - Running setup.py (path:/tmp/pip-6bNAh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:15:07 INFO - Running setup.py (path:/tmp/pip-ialElG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:15:07 INFO - Running setup.py (path:/tmp/pip-yeCTGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:15:07 INFO - Running setup.py (path:/tmp/pip-5uDCE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:15:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:15:08 INFO - Running setup.py install for manifestparser 16:15:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:15:08 INFO - Running setup.py install for mozcrash 16:15:08 INFO - Running setup.py install for mozdebug 16:15:08 INFO - Running setup.py install for mozdevice 16:15:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:15:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:15:08 INFO - Running setup.py install for mozfile 16:15:08 INFO - Running setup.py install for mozhttpd 16:15:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:15:08 INFO - Running setup.py install for mozinfo 16:15:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:15:08 INFO - Running setup.py install for mozInstall 16:15:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:15:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:15:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:15:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:15:08 INFO - Running setup.py install for mozleak 16:15:08 INFO - Running setup.py install for mozlog 16:15:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:15:09 INFO - Running setup.py install for moznetwork 16:15:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:15:09 INFO - Running setup.py install for mozprocess 16:15:09 INFO - Running setup.py install for mozprofile 16:15:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:15:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:15:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:15:09 INFO - Running setup.py install for mozrunner 16:15:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:15:09 INFO - Running setup.py install for mozscreenshot 16:15:09 INFO - Running setup.py install for moztest 16:15:09 INFO - Running setup.py install for mozversion 16:15:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:15:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:15:09 INFO - Cleaning up... 16:15:09 INFO - Return code: 0 16:15:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:15:09 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:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:09 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:15:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:09 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 0x7f8eaaea5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16bfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bcf60>, '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 0x16bdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16be1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1484264711.283547-624905592', '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:15:09 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:15:09 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:15:09 INFO - Using env: {'DISPLAY': ':0', 16:15:09 INFO - 'HOME': '/home/cltbld', 16:15:09 INFO - 'LANG': 'en_US.UTF-8', 16:15:09 INFO - 'LANGUAGE': 'en_US:en', 16:15:09 INFO - 'LOGNAME': 'cltbld', 16:15:09 INFO - 'MAIL': '/var/mail/cltbld', 16:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:09 INFO - 'MOZ_NO_REMOTE': '1', 16:15:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:09 INFO - 'NO_EM_RESTART': '1', 16:15:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:09 INFO - 'PWD': '/builds/slave/test', 16:15:09 INFO - 'SHELL': '/bin/bash', 16:15:09 INFO - 'SHLVL': '1', 16:15:09 INFO - 'TERM': 'linux', 16:15:09 INFO - 'TMOUT': '86400', 16:15:09 INFO - 'USER': 'cltbld', 16:15:09 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1484264711.283547-624905592', 16:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:09 INFO - '_': '/tools/buildbot/bin/python'} 16:15:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:15:10 INFO - Running setup.py (path:/tmp/pip-_NaOKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:15:10 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:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:15:10 INFO - Running setup.py (path:/tmp/pip-Xc9zQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:15:10 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:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:15:10 INFO - Running setup.py (path:/tmp/pip-w98vJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:15:10 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:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:15:10 INFO - Running setup.py (path:/tmp/pip-3Z7nrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:15:10 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:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:15:10 INFO - Running setup.py (path:/tmp/pip-3P5iI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:15:10 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:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:15:10 INFO - Running setup.py (path:/tmp/pip-iC9qyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:15:10 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:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:15:10 INFO - Running setup.py (path:/tmp/pip-rELGbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:15:10 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:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:15:10 INFO - Running setup.py (path:/tmp/pip-j0WL9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:15:10 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:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:15:10 INFO - Running setup.py (path:/tmp/pip-VfKRJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:15:10 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:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:15:10 INFO - Running setup.py (path:/tmp/pip-ukChUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:15:10 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:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:15:10 INFO - Running setup.py (path:/tmp/pip-pW2xrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:15:10 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:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:15:10 INFO - Running setup.py (path:/tmp/pip-VQ2N9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:15:10 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:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:15:10 INFO - Running setup.py (path:/tmp/pip-oWUHWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:15:11 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:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:15:11 INFO - Running setup.py (path:/tmp/pip-TRljc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:15:11 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:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:15:11 INFO - Running setup.py (path:/tmp/pip-ZYYWYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:15:11 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:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:15:11 INFO - Running setup.py (path:/tmp/pip-weHW70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:15:11 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:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:15:11 INFO - Running setup.py (path:/tmp/pip-RzVZDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:15:11 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:15:11 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:15:11 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:15:11 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:15:11 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:15:11 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:15:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:15:11 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:15:11 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:15:11 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:15:11 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:15:11 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:15:11 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:15:13 INFO - Downloading blessings-1.6.tar.gz 16:15:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:15:13 INFO - Installing collected packages: blessings 16:15:13 INFO - Running setup.py install for blessings 16:15:13 INFO - Successfully installed blessings 16:15:13 INFO - Cleaning up... 16:15:13 INFO - Return code: 0 16:15:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:15:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:15:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:15:13 INFO - Reading from file tmpfile_stdout 16:15:13 INFO - Current package versions: 16:15:13 INFO - argparse == 1.2.1 16:15:13 INFO - blessings == 1.6 16:15:13 INFO - blobuploader == 1.2.4 16:15:13 INFO - docopt == 0.6.1 16:15:13 INFO - functools32 == 3.2.3-2 16:15:13 INFO - jsonschema == 2.5.1 16:15:13 INFO - manifestparser == 1.1 16:15:13 INFO - mozInstall == 1.12 16:15:13 INFO - mozcrash == 1.0 16:15:13 INFO - mozdebug == 0.1 16:15:13 INFO - mozdevice == 0.48 16:15:13 INFO - mozfile == 1.2 16:15:13 INFO - mozhttpd == 0.7 16:15:13 INFO - mozinfo == 0.9 16:15:13 INFO - mozleak == 0.1 16:15:13 INFO - mozlog == 3.4 16:15:13 INFO - moznetwork == 0.27 16:15:13 INFO - mozprocess == 0.23 16:15:13 INFO - mozprofile == 0.28 16:15:13 INFO - mozrunner == 6.13 16:15:13 INFO - mozscreenshot == 0.1 16:15:13 INFO - mozsystemmonitor == 0.3 16:15:13 INFO - moztest == 0.8 16:15:13 INFO - mozversion == 1.4 16:15:13 INFO - psutil == 3.1.1 16:15:13 INFO - requests == 1.2.3 16:15:13 INFO - wsgiref == 0.1.2 16:15:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:15:13 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:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:13 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:15:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:13 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 0x7f8eaaea5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16bfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bcf60>, '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 0x16bdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16be1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1484264711.283547-624905592', '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:15:13 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:15:13 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:15:13 INFO - Using env: {'DISPLAY': ':0', 16:15:13 INFO - 'HOME': '/home/cltbld', 16:15:13 INFO - 'LANG': 'en_US.UTF-8', 16:15:13 INFO - 'LANGUAGE': 'en_US:en', 16:15:13 INFO - 'LOGNAME': 'cltbld', 16:15:13 INFO - 'MAIL': '/var/mail/cltbld', 16:15:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:13 INFO - 'MOZ_NO_REMOTE': '1', 16:15:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:13 INFO - 'NO_EM_RESTART': '1', 16:15:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:13 INFO - 'PWD': '/builds/slave/test', 16:15:13 INFO - 'SHELL': '/bin/bash', 16:15:13 INFO - 'SHLVL': '1', 16:15:13 INFO - 'TERM': 'linux', 16:15:13 INFO - 'TMOUT': '86400', 16:15:13 INFO - 'USER': 'cltbld', 16:15:13 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1484264711.283547-624905592', 16:15:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:13 INFO - '_': '/tools/buildbot/bin/python'} 16:15:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:14 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:15:14 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:15:14 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:15:14 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:15:14 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:15:14 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:15:14 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:15:14 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:15:14 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:15:14 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:15:14 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:15:14 INFO - Cleaning up... 16:15:14 INFO - Return code: 0 16:15:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8eaaea5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16bfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bcf60>, '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 0x16bdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16be1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1484264711.283547-624905592', '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:15:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:15:14 INFO - Using env: {'DISPLAY': ':0', 16:15:14 INFO - 'HOME': '/home/cltbld', 16:15:14 INFO - 'LANG': 'en_US.UTF-8', 16:15:14 INFO - 'LANGUAGE': 'en_US:en', 16:15:14 INFO - 'LOGNAME': 'cltbld', 16:15:14 INFO - 'MAIL': '/var/mail/cltbld', 16:15:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:14 INFO - 'MOZ_NO_REMOTE': '1', 16:15:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:14 INFO - 'NO_EM_RESTART': '1', 16:15:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:14 INFO - 'PWD': '/builds/slave/test', 16:15:14 INFO - 'SHELL': '/bin/bash', 16:15:14 INFO - 'SHLVL': '1', 16:15:14 INFO - 'TERM': 'linux', 16:15:14 INFO - 'TMOUT': '86400', 16:15:14 INFO - 'USER': 'cltbld', 16:15:14 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1484264711.283547-624905592', 16:15:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:14 INFO - '_': '/tools/buildbot/bin/python'} 16:15:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:15:14 INFO - Cleaning up... 16:15:14 INFO - Return code: 0 16:15:14 INFO - Running post-action listener: _resource_record_post_action 16:15:14 INFO - Running post-action listener: _start_resource_monitoring 16:15:14 INFO - Starting resource monitoring. 16:15:14 INFO - [mozharness: 2017-01-13 00:15:14.347881Z] Finished create-virtualenv step (success) 16:15:14 INFO - [mozharness: 2017-01-13 00:15:14.348336Z] Running install step. 16:15:14 INFO - Running pre-action listener: _resource_record_pre_action 16:15:14 INFO - Running main action method: install 16:15:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:15:14 INFO - Reading from file tmpfile_stdout 16:15:14 INFO - Detecting whether we're running mozinstall >=1.0... 16:15:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:15:14 INFO - Reading from file tmpfile_stdout 16:15:14 INFO - Output received: 16:15:14 INFO - Usage: mozinstall [options] installer 16:15:14 INFO - Options: 16:15:14 INFO - -h, --help show this help message and exit 16:15:14 INFO - -d DEST, --destination=DEST 16:15:14 INFO - Directory to install application into. [default: 16:15:14 INFO - "/builds/slave/test"] 16:15:14 INFO - --app=APP Application being installed. [default: firefox] 16:15:14 INFO - mkdir: /builds/slave/test/build/application 16:15:14 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:15:14 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:15:30 INFO - Reading from file tmpfile_stdout 16:15:30 INFO - Output received: 16:15:30 INFO - /builds/slave/test/build/application/firefox/firefox 16:15:30 INFO - Running post-action listener: _resource_record_post_action 16:15:30 INFO - [mozharness: 2017-01-13 00:15:30.595696Z] Finished install step (success) 16:15:30 INFO - [mozharness: 2017-01-13 00:15:30.595939Z] Running run-tests step. 16:15:30 INFO - Running pre-action listener: _resource_record_pre_action 16:15:30 INFO - Running main action method: run_tests 16:15:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:15:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:15:30 INFO - Python 2.7.3 16:15:30 INFO - Return code: 0 16:15:30 INFO - grabbing minidump binary from tooltool 16:15:30 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:15:30 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 0x16bcf60>, '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 0x16bdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16be1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:15:30 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:15:30 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:15:30 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:15:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:15:30 INFO - Return code: 0 16:15:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:15:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:15:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:15:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:15:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:15:30 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/ZLcQY6-oSL-QFAZZ5mpGVA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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:15:30 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/ZLcQY6-oSL-QFAZZ5mpGVA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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:15:30 INFO - Using env: {'DISPLAY': ':0', 16:15:30 INFO - 'HOME': '/home/cltbld', 16:15:30 INFO - 'LANG': 'en_US.UTF-8', 16:15:30 INFO - 'LANGUAGE': 'en_US:en', 16:15:30 INFO - 'LOGNAME': 'cltbld', 16:15:30 INFO - 'MAIL': '/var/mail/cltbld', 16:15:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:15:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:15:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:30 INFO - 'MOZ_NO_REMOTE': '1', 16:15:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:15:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:30 INFO - 'NO_EM_RESTART': '1', 16:15:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:30 INFO - 'PWD': '/builds/slave/test', 16:15:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:15:30 INFO - 'SHELL': '/bin/bash', 16:15:30 INFO - 'SHLVL': '1', 16:15:30 INFO - 'TERM': 'linux', 16:15:30 INFO - 'TMOUT': '86400', 16:15:30 INFO - 'USER': 'cltbld', 16:15:30 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1484264711.283547-624905592', 16:15:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:30 INFO - '_': '/tools/buildbot/bin/python'} 16:15:30 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/ZLcQY6-oSL-QFAZZ5mpGVA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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:15:30 INFO - mozversion application_buildid: 20170112144117 16:15:30 INFO - mozversion application_changeset: 5be69f2ff0164ed5e53ac7fd70f88b220a1d6ade 16:15:30 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:15:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:15:30 INFO - mozversion application_name: Firefox 16:15:30 INFO - mozversion application_remotingname: firefox-dev 16:15:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:15:30 INFO - mozversion application_vendor: Mozilla 16:15:30 INFO - mozversion application_version: 52.0a2 16:15:30 INFO - mozversion platform_buildid: 20170112144117 16:15:30 INFO - mozversion platform_changeset: 5be69f2ff0164ed5e53ac7fd70f88b220a1d6ade 16:15:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:15:30 INFO - mozversion platform_version: 52.0a2 16:15:30 INFO - using testdate: 1484266530 16:15:30 INFO - actual date: 1484266530 16:15:30 INFO - starting webserver on 'localhost:49750' 16:15:30 INFO - SUITE-START | Running 2 tests 16:15:30 INFO - TEST-START | dromaeo_css 16:15:30 INFO - operating with platform_type : linux_ 16:15:30 INFO - Initialising browser for dromaeo_css test... 16:15:30 INFO - TEST-INFO | started process 14866 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmrurs7/profile http://localhost:49750/getInfo.html) 16:15:34 INFO - PROCESS | 14866 | __metrics Screen width/height:1600/1200 16:15:34 INFO - PROCESS | 14866 | colorDepth:24 16:15:34 INFO - PROCESS | 14866 | Browser inner width/height: 1024/697 16:15:34 INFO - PROCESS | 14866 | __metrics 16:15:35 INFO - PROCESS | 14866 | 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:15:35 INFO - PROCESS | 14866 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:15:35 INFO - PROCESS | 14866 | console.error: PushService: 16:15:35 INFO - PROCESS | 14866 | stateChangeProcessEnqueue: Error transitioning state 16:15:35 INFO - PROCESS | 14866 | UnknownError 16:15:36 INFO - TEST-INFO | 14866: exit 0 16:15:36 INFO - Browser initialized. 16:15:36 INFO - Running cycle 1/1 for dromaeo_css test... 16:15:36 INFO - TEST-INFO | started process 14953 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmrurs7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:15:48 INFO - PROCESS | 14953 | RSS: Main: 144453632 16:15:48 INFO - PROCESS | 14953 | 16:18:49 INFO - PROCESS | 14953 | Cycle 1(1): loaded http://localhost:49750/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49750/tests/dromaeo/cssquery-ext.html) 16:18:50 INFO - PROCESS | 14953 | RSS: Main: 245444608 16:18:50 INFO - PROCESS | 14953 | 16:21:53 INFO - PROCESS | 14953 | Cycle 1(1): loaded http://localhost:49750/tests/dromaeo/cssquery-ext.html (next: http://localhost:49750/tests/dromaeo/cssquery-jquery.html) 16:21:53 INFO - PROCESS | 14953 | RSS: Main: 229027840 16:21:53 INFO - PROCESS | 14953 | 16:24:55 INFO - PROCESS | 14953 | Cycle 1(1): loaded http://localhost:49750/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49750/tests/dromaeo/cssquery-mootools.html) 16:24:56 INFO - PROCESS | 14953 | RSS: Main: 205357056 16:24:56 INFO - PROCESS | 14953 | 16:27:58 INFO - PROCESS | 14953 | Cycle 1(1): loaded http://localhost:49750/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49750/tests/dromaeo/cssquery-prototype.html) 16:27:58 INFO - PROCESS | 14953 | RSS: Main: 229203968 16:27:58 INFO - PROCESS | 14953 | 16:31:01 INFO - PROCESS | 14953 | Cycle 1(1): loaded http://localhost:49750/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49750/tests/dromaeo/cssquery-yui.html) 16:31:02 INFO - PROCESS | 14953 | RSS: Main: 173387776 16:31:02 INFO - PROCESS | 14953 | 16:34:04 INFO - PROCESS | 14953 | Cycle 1(1): loaded http://localhost:49750/tests/dromaeo/cssquery-yui.html (next: http://localhost:49750/tests/dromaeo/cssquery-dojo.html) 16:34:05 INFO - PROCESS | 14953 | RSS: Main: 264069120 16:34:05 INFO - PROCESS | 14953 | 16:34:05 INFO - PROCESS | 14953 | __start_tp_report 16:34:05 INFO - PROCESS | 14953 | _x_x_mozilla_page_load 16:34:05 INFO - PROCESS | 14953 | _x_x_mozilla_page_load_details 16:34:05 INFO - PROCESS | 14953 | |i|pagename|runs| 16:34:05 INFO - PROCESS | 14953 | |0;dojo.html;3208.2781374190804;3211.3898359311734;3246.902592922213;3275.819829909357;3282.7537934654906;5429.484199001098;5503.972480137599;5508.421615730341;5516.586256030793;5523;5484.780608775654;5545.417731138233;5562.415946325628;5569.443055694429;5592.384837667853;5040.798368065273;5055.873603159914;5081.390233172006;5115.335006449175;5120.487951204868;4934.21052631579;4952.777125029383;5089.720065396402;5137.434882162959;5139.948600513984;4927.113119638464;4952.479989601094;4960.057589058086;4986.002799440108;4995.125852975733;5010.649254552182;5026.12042892496;5079.720615366154;5091.9236211456855;5124.180131178993;4807.855764327076;4978.925316120261;5004.174311238641;5035.949640503584;5055.266986287004;5348.679079255218;5361.919571206435;5421.430749771296;5424.05079111154;5429.212764149216;5834.329052159013;5846.649201047951;5940.435658612425;5941.792037278675;5942.405759424067;5611.551075913917;5965.582409231356;5973.641581505123;5987.251593550806;5991.221141251653;5286.36563612369;5434.619576629677;5440.619156659035;5483;5485.259489968843;5922.674252916131;5929.762809487658;5948.583599148018;5954.791582294685;5963.344032156459;5637;5715.371309155989;5734.025215713339;5744.856378590569;5766.308043034863;5782.88434231313;5810.825675229666;5865.178874957509;5868.471837534642;5963.075723262901;5868.765249389977;5875.823725288248;5878.735456904449;5879.323877754027;5912.556558258148;5837.357890632027;5885.852853678693;5888.411158884077;5897.764089436375;5906.40935906406;4497.257952437811;4499.550044995474;4543.636509079266;4544.068465964469;4568.931466028012;4110.116324990141;4110.46563946685;4115.670746340285;4119.361498967605;4147.502299723992;5640.915386269209;5656.406077361818;5681.517071048925;5682.119271512922;5709.42905709434;5713.914291285634;5800.129980502874;5822.563307751935;5886.676232807151;5897.026990546512;5696.401877802854;5697.857553561112;5706.029974904276;5706.743196556082;5727.1695604138;5138.845834624967;5142.922856157161;5148.227765835155;5151.484851514893;5190.480951904779;5840.2991641003355;6032.457078863011;6083.878322433615;6229.345918678474;6239.812805615838;5866.472017518444;5924.911126333022;5947.167396564398;5950.910736339045;5986.610870293417;6144.078388241799;6216.689165541615;6219.346968568235;6220.191375121205;6234.127222188988;5591.27313449249;5620.297462817148;5830.82507524775;5831.446012628793;5834.533237340917;5818.44724751148;5876.706164691663;5879.764809407747;5945.494632956074;5965.164876917148;5733.770649173986;5775.104858746733;5775.8556036099435;5779.335376431596;5796.362400136066;5649.265595472562;5775.1914731938405;5779.364269930388;5781.046127389102;5787.565932554991;5576.414476480073;5607.214989901336;5614.354349249888;5672.064109421899;5756.942430575808;5800.6809625471005;5804.912926306024;5809.302883653989;5810.215620891295;5819;5517.062099443185;5550.222968784293;5577.693226872561;5664.150377443417;5672.404397538199 16:34:05 INFO - PROCESS | 14953 | |1;ext.html;587.3568442555403;626.9185005949228;630.6436863172306;667.9098321726568;675.5608854244737;34053.31893362131;37586;44831.999999999956;45734.771326143324;45850;45513.7724311378;45892.541074589324;46057;46180;46206.76896615521;8874.423162494433;9009.099090091004;9022.368434209608;9026;9031.683891063814;8300.460470069425;8565.914340856574;10493.895061049368;10668.733281667981;10785.514651840647;10389.220808439359;10454.425006624633;10458.790824183512;10466.581336746522;10470.371777693363;10703.571857125706;10734;10763.408012559306;10768.492411062458;10777.83833242502;10771.730706732395;10838.67483975482;10846.837297440545;10848.077913377372;10850.294730842548;43277;43516;43603.34594981078;43615.563844361786;43634.34548481744;3723.3298006358846;3805.7335986480957;3905.1799122184375;3969.64273215412;4321.006168581244;32657.183570410692;32682.346353073044;33125.83437082799;33156;33176;3984.4222587724616;4032.213718324928;4084.4894388201474;4110.46563946688;4257.8296868125235;379006;381172;381734;382169;382805;66284.66857665777;66917.6654116736;66934.64120908506;67022.66488667525;67100.6644966772;40692.18615627671;41498.58501415008;41624.583754162675;69934.30065699278;70206;18686.906565467085;19227.423177304703;19231.903840480707;19240.326588569333;19245;12994.935025324812;13247.470101195844;14490.130592164503;14711;14713;20071.896045717625;20720.896395518226;20930.162793488395;21504.677429838564;21630.56738865214;7194.964025179841;7356.705731770669;7543.434242431839;7551.924480755232;7557.773266802004;966.1932286540676;1054.478033373485;1060.316096118015;1065.4885654885697;1185.1763024697925;33175.17062073419;34054.48918266228;34095;34270.657293426746;34701.65298347035;1128.5090985421368;1152.0380482297207;1162.8197629367462;1194.42070595761;1279.8400199975003;13744.862551374557;18605.162767675487;18737.026707025205;19211.32760353381;19728.210871564977;514995;516801;518182;520911;521637;60203.39796602065;60244.397556024756;60317;60335.396646033856;60691;1301.479408236713;1312.2913626641698;1375.848656647768;1386.8058471813954;1419.276169153739;31366.372672546877;33796.662033379354;34591.65408345985;34793.304133917685;34960.08330440799;52566.474335256156;52592;52998.735006326264;53001.734991324796;53108.734456327475;392739;393001;393566;394431;394486;29835.403291934475;32202.83898580492;32315.35369292648;32319;32640.34719305553;48113;48204.276935845286;48305.27542086942;48771.268430974276;49056.75471622619;41474.9262536878;41672.166556669305;41745.16509669729;42054.579454205064;43005.56994430016;41466.81525383905;41999.58000419957;42251.36622950597;42374;42637.147257054065;42365.36451953161;42811;43207.35188972105;43981.56018439903;44141.33787993247;35872;38375.42436863393;38554.0361490965;39372;39455.408168876915;28684.42631147407;28705.856470717514;29117.64122303984;29159.85420072886;29295.267618309714 16:34:05 INFO - PROCESS | 14953 | |2;jquery.html;394.5029263128457;428.81346614222815;430.90304681446673;437.17017506280047;450.71830106183637;16400.83599164008;19589.804101958976;20298.28955986539;20989.68515472269;21300.18948389385;20083.89958050208;20437.489062773402;20916.68624970623;20931.895340523275;21156.57686846262;5750.884982300351;5809.593328467009;5977.7608895644125;5986.191864098357;5990.041593345066;5862.677552734598;6046.093086037085;6049.758009679629;6051.969740151293;6058.727357268912;5810.738516766734;5950.553708471882;6013.037913933771;6020.8494787630225;6025.728842202089;5883.970580147094;5978.402159784008;5985.970070149665;6014.8496287592725;6019.668918209497;5232.555232805216;5329.920051199235;5377.193420986844;5406.351237851483;5413.296271484682;24657.87671061651;24966.500669986497;25085.62371564428;25145.874270628712;25249;2492.8130390220626;2503.662005629235;2619.292790946453;2747.4230411613585;2871.224769312295;15500.5349839505;15597.454089106941;15637.218139093;15799.684006319923;16249.756253656205;1998.4604156877706;2000.8899510526915;2040.540878302385;2098.244631932503;2133.0614529606923;75934;78076.21923780804;88779.55610221972;91662.54168729113;93669;10531.84202236967;11271.492782824793;11439.485223164978;11601.535938562532;12172;15228.629423351951;15974.281157347947;15976.201189940457;15979.121148336953;16011;8287.171282871785;8728.639473802505;8816.823663526822;8836.955815220883;8991.190792828545;8159.67361305553;8277.917220827836;8294.502329860228;8436;8536.914630853613;4954.380702412199;5051.87370315745;5064.11378008847;5141.074606570778;5164.870878227999;1968.507873031742;2017.2939471185261;2053.260826102602;2068.2037415595105;2074.6369385357802;934.7008957133788;1011.7369483934231;1015.6445244164631;1054.6941386997837;1056.709404913655;20339.18643254283;20644.613232060943;20901.686474702892;20926;21110.47223819417;999.8250306196387;1020.1532727835878;1029.3823705776624;1042.3329069395593;1064.5316060933164;9459.574319155654;11396.202265841477;11419.543218271343;11638.476268567934;11707.824382634097;379600;456448;463243;464436;545692;84550.5772471146;86382.56808715916;87964.56017719998;99045;106117.46941265244;506.68585477004495;530.8619758862724;533.3679589686234;533.4585395823243;533.9279197308314;9943.900560994587;11425.31448113116;11875.82186267224;11899.583514576949;12236.694082648006;40893;42025.579744202165;42266;42710.57289427066;42831.57168428276;55527.16709249284;56325.71837140788;56752.71623641856;57768;58543.12185317138;8364.414490985573;8706;8739.563021848755;8873.068327825744;8904.465732056098;13057.869421306046;13406.93296533511;13479.46082156742;13559.661008474866;13654.453821847412;5986.132010858314;8749.956250218707;9431.811363772824;10937.56249750001;11601.071914247008;5663.66018038919;10571.36571805694;11240.269382490113;11392.088632909514;11651.88348116542;12093.274403535816;12129.332886690963;12248.632541023784;12249.755004900031;12384.071194660257;8651.437656552303;8875.245604123722;9042.638294468148;9236.907630923604;9364.438133712;9119.589618467053;11191.66425007251;11742.70643233926;12216.144869859025;12588.559400420942 16:34:05 INFO - PROCESS | 14953 | |3;mootools.html;1485.99257003715;1518.893677442579;1623.691498615263;1761.6917039518082;1799.9640007199848;8581.35639827013;9213.447193168406;9216.216621587173;9222.861657075133;9231.215346695539;7768.961155194216;7972.043354797418;8773.25427338677;8999.955000225005;9044.321675874302;2489.3900994256433;2518.3326418499114;2532.240327901622;2534.1257266243115;2547.0575886921865;2480.60310350344;2525;2526.3178941685733;2526.3305224115625;2527.4060595759984;2474.096954611563;2480.417101981033;2489.7385774493687;2489.8132640051977;2501.0371007162194;2381.0475809676095;2387.8567285962813;2399.544086623536;2400.567897778399;2408.674828898094;2352.1649814316015;2354.376090336062;2384.7853693167526;2387.5224955009066;2402.1712509184304;9185.49479778612;9193.08069193082;9265.44407335562;9312.161905428477;9325.067493250688;5587.497125258706;5742.454466825645;5742.511886489653;5743.971280143614;5747.310322761254;3459.238967427162;3473.7394695397693;3588.1567831559564;3592.1378869071236;3608.711303095746;1142.605800998654;1159.6810877008807;1177.1348059176498;1177.805662065758;1199.5321824488456;12886.742265154644;12918.41867115982;12935.935320323339;12936.870631293756;12959.67600809978;4775.188218002948;4947.82682606107;5059.06407314648;5164.457731938168;5185.844424667191;10951.288166269167;10961.287516311415;10968.670939871816;10969.451527423596;10977.12183025356;5729.627574207747;5740.282464691913;5741.569382296345;5743.4543718346695;5746;4444.6666500012625;4823.541763532458;5011.649184557119;5049.192129259301;5269.578433725293;4231.280682284019;4270.850520231777;4346.891327716832;4384.802683879233;4399.890002749893;1378.8759011688996;1402.2778269191374;1407.5003373802358;1412.9434822607186;1424.1455126923763;584.9996505974746;843.2073850580434;917.8347897378402;926.578406824893;1005.8591797148405;5778.624389414675;5839.182514447981;5955.642661440327;6193.876122477525;6243.188385509855;902.1114202510522;965.0590674092704;986.3884391677062;987.0918754745651;1020.8877023527406;3734.626537346298;3896.6103389661375;4036.334004889219;4079.6124368184974;4121.381792731055;11148.386838723947;11301.71745706364;11365.261258018203;11432.657020289405;11485.885141148481;11274;11352.829707554394;11367.886321136848;11369;11383.54465821358;8423.284020858297;8668.479891206547;8719.346049046348;8729.08344623818;8745.825083498294;5886.735096920564;5895.764169433174;6018.7291571878495;6022.277326720821;6041.063635136561;10349.74125646865;10517.73705657334;10543.42011189392;10659.09397701204;10667.89332106669;10839.458027098772;10866.565337386415;10908.018278354668;10922.617708380169;10960.890391096305;7033.331833475811;7096.858062838611;7118.679659415442;7138.64306784669;7179.353858152791;8421.70524031656;8455.069942306465;8490.957545212234;8516.276116530164;8520.61657225414;5844.766209351578;7234.710611575689;7408.288599087078;7562.546247225184;7798.493097948615;6781.457483401217;6853.109095817512;6967.268436814062;7164.140303163654;7223.277672232734;6987;6994.090768200102;7037.472189585904;7041.788746337413;7044.5068845182395;5407.351117865881;5451.972740136433;5482.671039737628;5498.505134537911;5700.572457065654;5423.186522021729;5453.072977593739;5492.176173573996;5601.243832082617;5645.379008309001 16:34:05 INFO - PROCESS | 14953 | |4;prototype.html;350.3448551209239;356.7395801065223;358.8223829204544;363.37318126232236;365.2202547560958;5361.7587208575615;5369.140937450009;5412.161115027172;5435.4564543545675;5440.911817636478;4995.800167993276;5085.745712714368;5130.307408499861;5180.974095129529;5275.894482110355;4190.141021090669;4191.685623578243;4195.139996300759;4196.811143498535;4203.831846726127;4203.810828512725;4206.642435392995;4214.536400995888;4225.8520951766695;4250.53244143144;3908.667763240128;3966.7818269995137;4141.378793181017;4162.666986641061;4196.454460920076;4134.524529679095;4147.585241475858;4170.35359519275;4172.9999999999845;4174.248635245654;3725.4970578972034;3729.9440508392395;3732.850685972558;3735.6652092442223;3742.7380083394173;5028.371453568304;5088.745562721849;5101.903090835488;5146.871328216787;5155.7626169719;4773.904521909542;4783.3064205690325;4783.330333753277;4788.473267940523;4794.928076078827;5453.654928380794;5460.726963651801;5463.754131064112;5501.284832971688;5518.448155184489;3961.4652021976954;4041.595840415935;4114.444549985744;4136.420901073852;4144.44050053242;5641.830745077613;5677.501899164355;5691.51622112121;5691.971540142273;5715.342735585461;4153.522344930311;4213.799067265814;4218.135282267128;4225.3239481683395;4231.365295205744;3979.522457305084;4148.979255103705;4263.4031235627035;4265.253580623378;4279.988405449434;4707.882302942386;4720.221163508051;4726.338312636233;4756.262779269219;4759.571638552477;5581;5591.608587398843;5592.496675299242;5599.356074051455;5627.606067575231;1361.379957850155;1398.8041674165624;1404.0873432268902;1406.4093080906043;1416.6387571169491;919.7010971434311;943.5376665434026;963.1764841060792;986.6102889358663;988.367444835306;5291.021161085211;5308.522232999048;5315.441878602768;5316.601254905898;5317.707526086102;5456.599096397573;5480.314960629921;5486.423925487846;5522.475364840334;5540.889182216414;5281.9471805281455;5322.392027906375;5483.287172667528;5519.2824932758485;5531.834044978657;2888.7722717845254;2906.3315437449505;2915.6063931369417;2935.251510864716;2941.2205765472168;5596.776128954796;5748.827535173868;5795;5808.5933984621515;5821.53427725781;5546.389897111315;5592.748326325325;5609.663420194802;5630.183623374588;5645.4072322405555;5782.508486778587;5794.565407594448;5798.9130163047585;5813.389594092644;5820.505257053198;5360.731963401737;5506.64206826555;5512.834614961557;5519.0407405372125;5527.474889885454;5400.108982017923;5447.972760136174;5455.290812194389;5473.75368108444;5484.177373394023;5603.943960560506;5737;5785.074388097884;5849.766009359578;5884.205632239593;4093.0381360380884;4096.692748043968;4107.322291821816;4113.25961326964;4156.272652285898;5411.540019098264;5442.564594832483;5488.313960754906;5504.091824848855;5517.868836888509;5241.768184476568;5252.553532949589;5363.927214557026;5386.542143917811;5402.378726446509;5251.789928402821;5282.76227569768;5301.098813201688;5333.226682131147;5389.407165211902;5257.158854583248;5305;5323.361196656426;5324.467553244799;5430.891382172414;5478.808241711521;5544.473275038865;5553.944750497392;5560.777568897199;5571.66570005801;5437.945620543744;5448.891022179613;5449.128139497661;5457.61796674229;5472.370677372153 16:34:05 INFO - PROCESS | 14953 | |5;yui.html;693.3343989769824;751.1024325930515;816.7508909782516;841.7685136587438;854.8204876975835;14888.032277901928;15531.223438828056;15538.689226215483;15563;15583.92208038961;14107.858921410783;14485.63785905353;14499.347529361177;14522.564323070299;14528;702.9015937768717;719.8344380792421;821.3347188777079;821.5153059694779;842.0526907229367;826.1243082332717;840.7729912923508;840.8066144786673;840.8570543007703;842.5871323051691;881.6385282034367;882.7616543533242;882.841088604051;883.0198479687542;883.1477624092781;729.4310437858452;737.9741709040212;857.5583574459158;881.2509367038031;881.6473410635733;645.3062957320899;645.7029766307504;650.5738741124571;650.8991106378519;651.6350843527592;14551.272436378245;14653.34059967304;14702.705945881022;14923.179225142612;14986.47547335838;12735.872641273561;13480.730385392335;13800.861991380058;13935.163890166623;13960.93019534906;11828.467718952581;11860.52557897683;11992.460339284753;12163;12322.445489952885;4334.848280310174;4350.912981740379;4355.673324500675;4540.409746732937;4542.4776150742755;68438;69570.65214673945;71973;72543;74980.62509687472;11021.504032318566;11095.778084438427;11136.554537818396;11229.887701123047;11380.772384552263;18758.624827503645;18768;18818.623627527373;18855.151518181716;18900.810991889906;7996.480228785227;8087.665535186628;8275.875861862078;8462.02686691026;8546.786330341667;4419.42547468827;4439.844605438794;4441.045175287329;4448.421705178306;4532.9546704533195;3380.8309584520675;3483.024753069094;3491.9301613967577;3494.371013217645;3501.5798104227656;597.9760809567656;612.5222326585271;624.887520246351;626.37675512865;626.7242413338116;544.6487015874818;568.7469076261107;590.1825971030154;659.3867703036127;669.093378472173;8458.830823383621;8573.271271941954;8802.230627388844;9000.8649870252;9115.817683646423;579.9507041901401;648.6821457485798;675.8175292670951;676.3034074902858;702.4240123099112;3832.9116435977353;4031.616996385397;4069.877903662895;4179.561146079679;4211.305134652809;85052.57473712716;87656.12343876607;90076.09923900808;92606.53696731474;93427;69754.65122674355;77687.61156194183;81373.59313203396;83721;85010.14989850023;70307.64846175736;71407.64296178486;72134.63932680304;73122.26877731155;73465.6326718363;7766.766996990099;7900.446968712135;8146.918530814616;8168.959155204186;8213.917860821315;40312.79843600763;46435.53564464447;46579.53420465752;48232.276515852995;49840;40122.79938600288;40411;45647.77176114098;62652;63570.68214658897;11094.611688590861;12348.197367171106;12654.240745554927;12812.935935320264;13199.34003299812;13037.739245215233;13168.80246796318;13864.168149911038;14553.927230364205;14992.550223493312;13691.589252322447;13773.793393098911;13922.721545569235;14108;14654.926725366306;12535.417101613586;12788.48846046185;12875.35623218854;12899.419526121159;13078;12704.491820327454;12766.872331276569;13031.869681303446;13312.866871331164;13364.465421383426;10060.949695251476;10244.231682623684;10482.423466709404;10593.311434756715;10608.946955265174;10477.16182705397;10606.416647084485;10614;10743.048396013579;10879.619213327496 16:34:05 INFO - PROCESS | 14953 | __end_tp_report 16:34:05 INFO - PROCESS | 14953 | __start_cc_report 16:34:05 INFO - PROCESS | 14953 | _x_x_mozilla_cycle_collect,972 16:34:05 INFO - PROCESS | 14953 | __end_cc_report 16:34:05 INFO - PROCESS | 14953 | __startTimestamp1484267645183__endTimestamp 16:34:05 INFO - PROCESS | 14953 | 16:34:05 INFO - PROCESS | 14953 | ------- Summary: start ------- 16:34:05 INFO - PROCESS | 14953 | Number of tests: 6 16:34:05 INFO - PROCESS | 14953 | 16:34:05 INFO - PROCESS | 14953 | [#0] dojo.html Cycles:165 Average:5478.92 Median:5682.12 stddev:604.24 (10.6%) stddev-sans-first:579.24 16:34:05 INFO - PROCESS | 14953 | Values: 3208.3 3211.4 3246.9 3275.8 3282.8 5429.5 5504.0 5508.4 5516.6 5523.0 5484.8 5545.4 5562.4 5569.4 5592.4 5040.8 5055.9 5081.4 5115.3 5120.5 4934.2 4952.8 5089.7 5137.4 5139.9 4927.1 4952.5 4960.1 4986.0 4995.1 5010.6 5026.1 5079.7 5091.9 5124.2 4807.9 4978.9 5004.2 5035.9 5055.3 5348.7 5361.9 5421.4 5424.1 5429.2 5834.3 5846.6 5940.4 5941.8 5942.4 5611.6 5965.6 5973.6 5987.3 5991.2 5286.4 5434.6 5440.6 5483.0 5485.3 5922.7 5929.8 5948.6 5954.8 5963.3 5637.0 5715.4 5734.0 5744.9 5766.3 5782.9 5810.8 5865.2 5868.5 5963.1 5868.8 5875.8 5878.7 5879.3 5912.6 5837.4 5885.9 5888.4 5897.8 5906.4 4497.3 4499.6 4543.6 4544.1 4568.9 4110.1 4110.5 4115.7 4119.4 4147.5 5640.9 5656.4 5681.5 5682.1 5709.4 5713.9 5800.1 5822.6 5886.7 5897.0 5696.4 5697.9 5706.0 5706.7 5727.2 5138.8 5142.9 5148.2 5151.5 5190.5 5840.3 6032.5 6083.9 6229.3 6239.8 5866.5 5924.9 5947.2 5950.9 5986.6 6144.1 6216.7 6219.3 6220.2 6234.1 5591.3 5620.3 5830.8 5831.4 5834.5 5818.4 5876.7 5879.8 5945.5 5965.2 5733.8 5775.1 5775.9 5779.3 5796.4 5649.3 5775.2 5779.4 5781.0 5787.6 5576.4 5607.2 5614.4 5672.1 5756.9 5800.7 5804.9 5809.3 5810.2 5819.0 5517.1 5550.2 5577.7 5664.2 5672.4 16:34:05 INFO - PROCESS | 14953 | 16:34:05 INFO - PROCESS | 14953 | [#1] ext.html Cycles:180 Average:60449.08 Median:392870.00 stddev:115042.51 (29.3%) stddev-sans-first:115277.44 16:34:05 INFO - PROCESS | 14953 | Values: 587.4 626.9 630.6 667.9 675.6 34053.3 37586.0 44832.0 45734.8 45850.0 45513.8 45892.5 46057.0 46180.0 46206.8 8874.4 9009.1 9022.4 9026.0 9031.7 8300.5 8565.9 10493.9 10668.7 10785.5 10389.2 10454.4 10458.8 10466.6 10470.4 10703.6 10734.0 10763.4 10768.5 10777.8 10771.7 10838.7 10846.8 10848.1 10850.3 43277.0 43516.0 43603.3 43615.6 43634.3 3723.3 3805.7 3905.2 3969.6 4321.0 32657.2 32682.3 33125.8 33156.0 33176.0 3984.4 4032.2 4084.5 4110.5 4257.8 379006.0 381172.0 381734.0 382169.0 382805.0 66284.7 66917.7 66934.6 67022.7 67100.7 40692.2 41498.6 41624.6 69934.3 70206.0 18686.9 19227.4 19231.9 19240.3 19245.0 12994.9 13247.5 14490.1 14711.0 14713.0 20071.9 20720.9 20930.2 21504.7 21630.6 7195.0 7356.7 7543.4 7551.9 7557.8 966.2 1054.5 1060.3 1065.5 1185.2 33175.2 34054.5 34095.0 34270.7 34701.7 1128.5 1152.0 1162.8 1194.4 1279.8 13744.9 18605.2 18737.0 19211.3 19728.2 514995.0 516801.0 518182.0 520911.0 521637.0 60203.4 60244.4 60317.0 60335.4 60691.0 1301.5 1312.3 1375.8 1386.8 1419.3 31366.4 33796.7 34591.7 34793.3 34960.1 52566.5 52592.0 52998.7 53001.7 53108.7 392739.0 393001.0 393566.0 394431.0 394486.0 29835.4 32202.8 32315.4 32319.0 32640.3 48113.0 48204.3 48305.3 48771.3 49056.8 41474.9 41672.2 41745.2 42054.6 43005.6 41466.8 41999.6 42251.4 42374.0 42637.1 42365.4 42811.0 43207.4 43981.6 44141.3 35872.0 38375.4 38554.0 39372.0 39455.4 28684.4 28705.9 29117.6 29159.9 29295.3 16:34:05 INFO - PROCESS | 14953 | 16:34:05 INFO - PROCESS | 14953 | [#2] jquery.html Cycles:180 Average:28516.34 Median:42145.79 stddev:76928.39 (182.5%) stddev-sans-first:77115.21 16:34:05 INFO - PROCESS | 14953 | Values: 394.5 428.8 430.9 437.2 450.7 16400.8 19589.8 20298.3 20989.7 21300.2 20083.9 20437.5 20916.7 20931.9 21156.6 5750.9 5809.6 5977.8 5986.2 5990.0 5862.7 6046.1 6049.8 6052.0 6058.7 5810.7 5950.6 6013.0 6020.8 6025.7 5884.0 5978.4 5986.0 6014.8 6019.7 5232.6 5329.9 5377.2 5406.4 5413.3 24657.9 24966.5 25085.6 25145.9 25249.0 2492.8 2503.7 2619.3 2747.4 2871.2 15500.5 15597.5 15637.2 15799.7 16249.8 1998.5 2000.9 2040.5 2098.2 2133.1 75934.0 78076.2 88779.6 91662.5 93669.0 10531.8 11271.5 11439.5 11601.5 12172.0 15228.6 15974.3 15976.2 15979.1 16011.0 8287.2 8728.6 8816.8 8837.0 8991.2 8159.7 8277.9 8294.5 8436.0 8536.9 4954.4 5051.9 5064.1 5141.1 5164.9 1968.5 2017.3 2053.3 2068.2 2074.6 934.7 1011.7 1015.6 1054.7 1056.7 20339.2 20644.6 20901.7 20926.0 21110.5 999.8 1020.2 1029.4 1042.3 1064.5 9459.6 11396.2 11419.5 11638.5 11707.8 379600.0 456448.0 463243.0 464436.0 545692.0 84550.6 86382.6 87964.6 99045.0 106117.5 506.7 530.9 533.4 533.5 533.9 9943.9 11425.3 11875.8 11899.6 12236.7 40893.0 42025.6 42266.0 42710.6 42831.6 55527.2 56325.7 56752.7 57768.0 58543.1 8364.4 8706.0 8739.6 8873.1 8904.5 13057.9 13406.9 13479.5 13559.7 13654.5 5986.1 8750.0 9431.8 10937.6 11601.1 5663.7 10571.4 11240.3 11392.1 11651.9 12093.3 12129.3 12248.6 12249.8 12384.1 8651.4 8875.2 9042.6 9236.9 9364.4 9119.6 11191.7 11742.7 12216.1 12588.6 16:34:05 INFO - PROCESS | 14953 | 16:34:05 INFO - PROCESS | 14953 | [#3] mootools.html Cycles:180 Average:5970.29 Median:4979.74 stddev:3398.68 (68.3%) stddev-sans-first:3391.51 16:34:05 INFO - PROCESS | 14953 | Values: 1486.0 1518.9 1623.7 1761.7 1800.0 8581.4 9213.4 9216.2 9222.9 9231.2 7769.0 7972.0 8773.3 9000.0 9044.3 2489.4 2518.3 2532.2 2534.1 2547.1 2480.6 2525.0 2526.3 2526.3 2527.4 2474.1 2480.4 2489.7 2489.8 2501.0 2381.0 2387.9 2399.5 2400.6 2408.7 2352.2 2354.4 2384.8 2387.5 2402.2 9185.5 9193.1 9265.4 9312.2 9325.1 5587.5 5742.5 5742.5 5744.0 5747.3 3459.2 3473.7 3588.2 3592.1 3608.7 1142.6 1159.7 1177.1 1177.8 1199.5 12886.7 12918.4 12935.9 12936.9 12959.7 4775.2 4947.8 5059.1 5164.5 5185.8 10951.3 10961.3 10968.7 10969.5 10977.1 5729.6 5740.3 5741.6 5743.5 5746.0 4444.7 4823.5 5011.6 5049.2 5269.6 4231.3 4270.9 4346.9 4384.8 4399.9 1378.9 1402.3 1407.5 1412.9 1424.1 585.0 843.2 917.8 926.6 1005.9 5778.6 5839.2 5955.6 6193.9 6243.2 902.1 965.1 986.4 987.1 1020.9 3734.6 3896.6 4036.3 4079.6 4121.4 11148.4 11301.7 11365.3 11432.7 11485.9 11274.0 11352.8 11367.9 11369.0 11383.5 8423.3 8668.5 8719.3 8729.1 8745.8 5886.7 5895.8 6018.7 6022.3 6041.1 10349.7 10517.7 10543.4 10659.1 10667.9 10839.5 10866.6 10908.0 10922.6 10960.9 7033.3 7096.9 7118.7 7138.6 7179.4 8421.7 8455.1 8491.0 8516.3 8520.6 5844.8 7234.7 7408.3 7562.5 7798.5 6781.5 6853.1 6967.3 7164.1 7223.3 6987.0 6994.1 7037.5 7041.8 7044.5 5407.4 5452.0 5482.7 5498.5 5700.6 5423.2 5453.1 5492.2 5601.2 5645.4 16:34:05 INFO - PROCESS | 14953 | 16:34:05 INFO - PROCESS | 14953 | [#4] prototype.html Cycles:180 Average:4640.90 Median:5316.02 stddev:1331.92 (25.1%) stddev-sans-first:1296.14 16:34:05 INFO - PROCESS | 14953 | Values: 350.3 356.7 358.8 363.4 365.2 5361.8 5369.1 5412.2 5435.5 5440.9 4995.8 5085.7 5130.3 5181.0 5275.9 4190.1 4191.7 4195.1 4196.8 4203.8 4203.8 4206.6 4214.5 4225.9 4250.5 3908.7 3966.8 4141.4 4162.7 4196.5 4134.5 4147.6 4170.4 4173.0 4174.2 3725.5 3729.9 3732.9 3735.7 3742.7 5028.4 5088.7 5101.9 5146.9 5155.8 4773.9 4783.3 4783.3 4788.5 4794.9 5453.7 5460.7 5463.8 5501.3 5518.4 3961.5 4041.6 4114.4 4136.4 4144.4 5641.8 5677.5 5691.5 5692.0 5715.3 4153.5 4213.8 4218.1 4225.3 4231.4 3979.5 4149.0 4263.4 4265.3 4280.0 4707.9 4720.2 4726.3 4756.3 4759.6 5581.0 5591.6 5592.5 5599.4 5627.6 1361.4 1398.8 1404.1 1406.4 1416.6 919.7 943.5 963.2 986.6 988.4 5291.0 5308.5 5315.4 5316.6 5317.7 5456.6 5480.3 5486.4 5522.5 5540.9 5281.9 5322.4 5483.3 5519.3 5531.8 2888.8 2906.3 2915.6 2935.3 2941.2 5596.8 5748.8 5795.0 5808.6 5821.5 5546.4 5592.7 5609.7 5630.2 5645.4 5782.5 5794.6 5798.9 5813.4 5820.5 5360.7 5506.6 5512.8 5519.0 5527.5 5400.1 5448.0 5455.3 5473.8 5484.2 5603.9 5737.0 5785.1 5849.8 5884.2 4093.0 4096.7 4107.3 4113.3 4156.3 5411.5 5442.6 5488.3 5504.1 5517.9 5241.8 5252.6 5363.9 5386.5 5402.4 5251.8 5282.8 5301.1 5333.2 5389.4 5257.2 5305.0 5323.4 5324.5 5430.9 5478.8 5544.5 5553.9 5560.8 5571.7 5437.9 5448.9 5449.1 5457.6 5472.4 16:34:05 INFO - PROCESS | 14953 | 16:34:05 INFO - PROCESS | 14953 | [#5] yui.html Cycles:180 Average:17925.42 Median:4536.68 stddev:24125.50 (531.8%) stddev-sans-first:24158.48 16:34:05 INFO - PROCESS | 14953 | Values: 693.3 751.1 816.8 841.8 854.8 14888.0 15531.2 15538.7 15563.0 15583.9 14107.9 14485.6 14499.3 14522.6 14528.0 702.9 719.8 821.3 821.5 842.1 826.1 840.8 840.8 840.9 842.6 881.6 882.8 882.8 883.0 883.1 729.4 738.0 857.6 881.3 881.6 645.3 645.7 650.6 650.9 651.6 14551.3 14653.3 14702.7 14923.2 14986.5 12735.9 13480.7 13800.9 13935.2 13960.9 11828.5 11860.5 11992.5 12163.0 12322.4 4334.8 4350.9 4355.7 4540.4 4542.5 68438.0 69570.7 71973.0 72543.0 74980.6 11021.5 11095.8 11136.6 11229.9 11380.8 18758.6 18768.0 18818.6 18855.2 18900.8 7996.5 8087.7 8275.9 8462.0 8546.8 4419.4 4439.8 4441.0 4448.4 4533.0 3380.8 3483.0 3491.9 3494.4 3501.6 598.0 612.5 624.9 626.4 626.7 544.6 568.7 590.2 659.4 669.1 8458.8 8573.3 8802.2 9000.9 9115.8 580.0 648.7 675.8 676.3 702.4 3832.9 4031.6 4069.9 4179.6 4211.3 85052.6 87656.1 90076.1 92606.5 93427.0 69754.7 77687.6 81373.6 83721.0 85010.1 70307.6 71407.6 72134.6 73122.3 73465.6 7766.8 7900.4 8146.9 8169.0 8213.9 40312.8 46435.5 46579.5 48232.3 49840.0 40122.8 40411.0 45647.8 62652.0 63570.7 11094.6 12348.2 12654.2 12812.9 13199.3 13037.7 13168.8 13864.2 14553.9 14992.6 13691.6 13773.8 13922.7 14108.0 14654.9 12535.4 12788.5 12875.4 12899.4 13078.0 12704.5 12766.9 13031.9 13312.9 13364.5 10060.9 10244.2 10482.4 10593.3 10608.9 10477.2 10606.4 10614.0 10743.0 10879.6 16:34:05 INFO - PROCESS | 14953 | -------- Summary: end -------- 16:34:05 INFO - PROCESS | 14953 | 16:34:05 INFO - TEST-INFO | 14953: exit 0 16:34:05 INFO - TEST-OK | dromaeo_css | took 1115014ms 16:34:05 INFO - TEST-START | kraken 16:34:05 INFO - operating with platform_type : linux_ 16:34:05 INFO - Initialising browser for kraken test... 16:34:05 INFO - TEST-INFO | started process 15279 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDY8PkX/profile http://localhost:49750/getInfo.html) 16:34:10 INFO - PROCESS | 15279 | __metrics Screen width/height:1600/1200 16:34:10 INFO - PROCESS | 15279 | colorDepth:24 16:34:10 INFO - PROCESS | 15279 | Browser inner width/height: 1024/697 16:34:10 INFO - PROCESS | 15279 | __metrics 16:34:10 INFO - PROCESS | 15279 | 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:34:10 INFO - PROCESS | 15279 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:34:11 INFO - PROCESS | 15279 | console.error: PushService: 16:34:11 INFO - PROCESS | 15279 | stateChangeProcessEnqueue: Error transitioning state 16:34:11 INFO - PROCESS | 15279 | UnknownError 16:34:11 INFO - TEST-INFO | 15279: exit 0 16:34:11 INFO - Browser initialized. 16:34:11 INFO - Running cycle 1/1 for kraken test... 16:34:11 INFO - TEST-INFO | started process 15371 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDY8PkX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:34:23 INFO - PROCESS | 15371 | RSS: Main: 144080896 16:34:23 INFO - PROCESS | 15371 | 16:34:25 INFO - PROCESS | 15371 | Cycle 1(1): loaded http://localhost:49750/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49750/tests/kraken/driver.html?testName=audio-beat-detection) 16:34:26 INFO - PROCESS | 15371 | RSS: Main: 185348096 16:34:26 INFO - PROCESS | 15371 | 16:34:29 INFO - PROCESS | 15371 | Cycle 1(1): loaded http://localhost:49750/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49750/tests/kraken/driver.html?testName=audio-dft) 16:34:29 INFO - PROCESS | 15371 | RSS: Main: 175570944 16:34:29 INFO - PROCESS | 15371 | 16:34:32 INFO - PROCESS | 15371 | Cycle 1(1): loaded http://localhost:49750/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49750/tests/kraken/driver.html?testName=audio-fft) 16:34:33 INFO - PROCESS | 15371 | RSS: Main: 266502144 16:34:33 INFO - PROCESS | 15371 | 16:34:35 INFO - PROCESS | 15371 | Cycle 1(1): loaded http://localhost:49750/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49750/tests/kraken/driver.html?testName=audio-oscillator) 16:34:35 INFO - PROCESS | 15371 | RSS: Main: 173170688 16:34:35 INFO - PROCESS | 15371 | 16:34:38 INFO - PROCESS | 15371 | Cycle 1(1): loaded http://localhost:49750/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49750/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:34:38 INFO - PROCESS | 15371 | RSS: Main: 175734784 16:34:38 INFO - PROCESS | 15371 | 16:34:41 INFO - PROCESS | 15371 | Cycle 1(1): loaded http://localhost:49750/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49750/tests/kraken/driver.html?testName=imaging-darkroom) 16:34:42 INFO - PROCESS | 15371 | RSS: Main: 214622208 16:34:42 INFO - PROCESS | 15371 | 16:34:45 INFO - PROCESS | 15371 | Cycle 1(1): loaded http://localhost:49750/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49750/tests/kraken/driver.html?testName=imaging-desaturate) 16:34:46 INFO - PROCESS | 15371 | RSS: Main: 212496384 16:34:46 INFO - PROCESS | 15371 | 16:34:48 INFO - PROCESS | 15371 | Cycle 1(1): loaded http://localhost:49750/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49750/tests/kraken/driver.html?testName=json-parse-financial) 16:34:49 INFO - PROCESS | 15371 | RSS: Main: 211824640 16:34:49 INFO - PROCESS | 15371 | 16:34:50 INFO - PROCESS | 15371 | Cycle 1(1): loaded http://localhost:49750/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49750/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:34:51 INFO - PROCESS | 15371 | RSS: Main: 174276608 16:34:51 INFO - PROCESS | 15371 | 16:34:53 INFO - PROCESS | 15371 | Cycle 1(1): loaded http://localhost:49750/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49750/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:34:53 INFO - PROCESS | 15371 | RSS: Main: 180895744 16:34:53 INFO - PROCESS | 15371 | 16:34:55 INFO - PROCESS | 15371 | Cycle 1(1): loaded http://localhost:49750/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49750/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:34:56 INFO - PROCESS | 15371 | RSS: Main: 189759488 16:34:56 INFO - PROCESS | 15371 | 16:34:58 INFO - PROCESS | 15371 | Cycle 1(1): loaded http://localhost:49750/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49750/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:34:59 INFO - PROCESS | 15371 | RSS: Main: 198623232 16:34:59 INFO - PROCESS | 15371 | 16:35:02 INFO - PROCESS | 15371 | Cycle 1(1): loaded http://localhost:49750/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49750/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:35:02 INFO - PROCESS | 15371 | RSS: Main: 194564096 16:35:02 INFO - PROCESS | 15371 | 16:35:04 INFO - PROCESS | 15371 | Cycle 1(1): loaded http://localhost:49750/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49750/tests/kraken/driver.html?testName=ai-astar) 16:35:04 INFO - PROCESS | 15371 | RSS: Main: 247177216 16:35:04 INFO - PROCESS | 15371 | 16:35:04 INFO - PROCESS | 15371 | __start_tp_report 16:35:04 INFO - PROCESS | 15371 | _x_x_mozilla_page_load 16:35:04 INFO - PROCESS | 15371 | _x_x_mozilla_page_load_details 16:35:04 INFO - PROCESS | 15371 | |i|pagename|runs| 16:35:04 INFO - PROCESS | 15371 | |0;ai-astar;100;110;109;109;113;109;111;109;109;109 16:35:04 INFO - PROCESS | 15371 | |1;audio-beat-detection;146;120;116;152;121;124;119;124;144;129 16:35:04 INFO - PROCESS | 15371 | |2;audio-dft;160;160;162;160;160;160;161;159;159;161 16:35:04 INFO - PROCESS | 15371 | |3;audio-fft;74;75;76;104;75;76;75;79;95;76 16:35:04 INFO - PROCESS | 15371 | |4;audio-oscillator;82;82;116;81;87;81;97;82;81;114 16:35:04 INFO - PROCESS | 15371 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;118;117;117 16:35:04 INFO - PROCESS | 15371 | |6;imaging-darkroom;146;145;146;146;146;146;146;146;146;145 16:35:04 INFO - PROCESS | 15371 | |7;imaging-desaturate;85;84;85;85;84;84;84;84;84;84 16:35:04 INFO - PROCESS | 15371 | |8;json-parse-financial;50;51;51;50;50;51;51;51;50;51 16:35:04 INFO - PROCESS | 15371 | |9;json-stringify-tinderbox;62;60;61;60;61;61;58;59;59;60 16:35:04 INFO - PROCESS | 15371 | |10;stanford-crypto-aes;76;76;74;77;75;80;75;82;75;73 16:35:04 INFO - PROCESS | 15371 | |11;stanford-crypto-ccm;123;125;123;124;133;131;120;120;154;122 16:35:04 INFO - PROCESS | 15371 | |12;stanford-crypto-pbkdf2;158;151;153;156;155;151;154;152;156;151 16:35:04 INFO - PROCESS | 15371 | |13;stanford-crypto-sha256-iterative;73;62;66;63;61;62;60;61;61;60 16:35:04 INFO - PROCESS | 15371 | __end_tp_report 16:35:04 INFO - PROCESS | 15371 | __start_cc_report 16:35:04 INFO - PROCESS | 15371 | _x_x_mozilla_cycle_collect,1606 16:35:04 INFO - PROCESS | 15371 | __end_cc_report 16:35:04 INFO - PROCESS | 15371 | __startTimestamp1484267704678__endTimestamp 16:35:04 INFO - PROCESS | 15371 | 16:35:04 INFO - PROCESS | 15371 | ------- Summary: start ------- 16:35:04 INFO - PROCESS | 15371 | Number of tests: 14 16:35:04 INFO - PROCESS | 15371 | 16:35:04 INFO - PROCESS | 15371 | [#0] ai-astar Cycles:10 Average:108.80 Median:109.00 stddev:3.36 (3.1%) stddev-sans-first:1.39 16:35:04 INFO - PROCESS | 15371 | Values: 100.0 110.0 109.0 109.0 113.0 109.0 111.0 109.0 109.0 109.0 16:35:04 INFO - PROCESS | 15371 | 16:35:04 INFO - PROCESS | 15371 | [#1] audio-beat-detection Cycles:10 Average:129.50 Median:126.50 stddev:12.93 (10.2%) stddev-sans-first:12.26 16:35:04 INFO - PROCESS | 15371 | Values: 146.0 120.0 116.0 152.0 121.0 124.0 119.0 124.0 144.0 129.0 16:35:04 INFO - PROCESS | 15371 | 16:35:04 INFO - PROCESS | 15371 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 16:35:04 INFO - PROCESS | 15371 | Values: 160.0 160.0 162.0 160.0 160.0 160.0 161.0 159.0 159.0 161.0 16:35:04 INFO - PROCESS | 15371 | 16:35:04 INFO - PROCESS | 15371 | [#3] audio-fft Cycles:10 Average:80.50 Median:76.00 stddev:10.32 (13.6%) stddev-sans-first:10.67 16:35:04 INFO - PROCESS | 15371 | Values: 74.0 75.0 76.0 104.0 75.0 76.0 75.0 79.0 95.0 76.0 16:35:04 INFO - PROCESS | 15371 | 16:35:04 INFO - PROCESS | 15371 | [#4] audio-oscillator Cycles:10 Average:90.30 Median:82.00 stddev:13.92 (17.0%) stddev-sans-first:14.44 16:35:04 INFO - PROCESS | 15371 | Values: 82.0 82.0 116.0 81.0 87.0 81.0 97.0 82.0 81.0 114.0 16:35:04 INFO - PROCESS | 15371 | 16:35:04 INFO - PROCESS | 15371 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 16:35:04 INFO - PROCESS | 15371 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 16:35:04 INFO - PROCESS | 15371 | 16:35:04 INFO - PROCESS | 15371 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 16:35:04 INFO - PROCESS | 15371 | Values: 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 16:35:04 INFO - PROCESS | 15371 | 16:35:04 INFO - PROCESS | 15371 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 16:35:04 INFO - PROCESS | 15371 | Values: 85.0 84.0 85.0 85.0 84.0 84.0 84.0 84.0 84.0 84.0 16:35:04 INFO - PROCESS | 15371 | 16:35:04 INFO - PROCESS | 15371 | [#8] json-parse-financial Cycles:10 Average:50.60 Median:51.00 stddev:0.52 (1.0%) stddev-sans-first:0.50 16:35:04 INFO - PROCESS | 15371 | Values: 50.0 51.0 51.0 50.0 50.0 51.0 51.0 51.0 50.0 51.0 16:35:04 INFO - PROCESS | 15371 | 16:35:04 INFO - PROCESS | 15371 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.50 stddev:1.20 (2.0%) stddev-sans-first:1.05 16:35:04 INFO - PROCESS | 15371 | Values: 62.0 60.0 61.0 60.0 61.0 61.0 58.0 59.0 59.0 60.0 16:35:04 INFO - PROCESS | 15371 | 16:35:04 INFO - PROCESS | 15371 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:76.00 stddev:2.75 (3.6%) stddev-sans-first:2.92 16:35:04 INFO - PROCESS | 15371 | Values: 76.0 76.0 74.0 77.0 75.0 80.0 75.0 82.0 75.0 73.0 16:35:04 INFO - PROCESS | 15371 | 16:35:04 INFO - PROCESS | 15371 | [#11] stanford-crypto-ccm Cycles:10 Average:127.50 Median:124.50 stddev:10.26 (8.2%) stddev-sans-first:10.75 16:35:04 INFO - PROCESS | 15371 | Values: 123.0 125.0 123.0 124.0 133.0 131.0 120.0 120.0 154.0 122.0 16:35:04 INFO - PROCESS | 15371 | 16:35:04 INFO - PROCESS | 15371 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.70 Median:154.50 stddev:2.50 (1.6%) stddev-sans-first:2.11 16:35:04 INFO - PROCESS | 15371 | Values: 158.0 151.0 153.0 156.0 155.0 151.0 154.0 152.0 156.0 151.0 16:35:04 INFO - PROCESS | 15371 | 16:35:04 INFO - PROCESS | 15371 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:62.00 stddev:3.96 (6.4%) stddev-sans-first:1.86 16:35:04 INFO - PROCESS | 15371 | Values: 73.0 62.0 66.0 63.0 61.0 62.0 60.0 61.0 61.0 60.0 16:35:04 INFO - PROCESS | 15371 | -------- Summary: end -------- 16:35:04 INFO - PROCESS | 15371 | 16:35:05 INFO - TEST-INFO | 15371: exit 0 16:35:05 INFO - TEST-OK | kraken | took 59982ms 16:35:05 INFO - SUITE-END | took 1174s 16:35:06 INFO - Completed test suite (00:19:35) 16:35:06 INFO - javascript benchmark 16:35:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3208.2781374190804, 3211.3898359311734, 3246.902592922213, 3275.819829909357, 3282.7537934654906, 5429.484199001098, 5503.972480137599, 5508.421615730341, 5516.586256030793, 5523.0, 5484.780608775654, 5545.417731138233, 5562.415946325628, 5569.443055694429, 5592.384837667853, 5040.798368065273, 5055.873603159914, 5081.390233172006, 5115.335006449175, 5120.487951204868, 4934.21052631579, 4952.777125029383, 5089.720065396402, 5137.434882162959, 5139.948600513984, 4927.113119638464, 4952.479989601094, 4960.057589058086, 4986.002799440108, 4995.125852975733, 5010.649254552182, 5026.12042892496, 5079.720615366154, 5091.9236211456855, 5124.180131178993, 4807.855764327076, 4978.925316120261, 5004.174311238641, 5035.949640503584, 5055.266986287004, 5348.679079255218, 5361.919571206435, 5421.430749771296, 5424.05079111154, 5429.212764149216, 5834.329052159013, 5846.649201047951, 5940.435658612425, 5941.792037278675, 5942.405759424067, 5611.551075913917, 5965.582409231356, 5973.641581505123, 5987.251593550806, 5991.221141251653, 5286.36563612369, 5434.619576629677, 5440.619156659035, 5483.0, 5485.259489968843, 5922.674252916131, 5929.762809487658, 5948.583599148018, 5954.791582294685, 5963.344032156459, 5637.0, 5715.371309155989, 5734.025215713339, 5744.856378590569, 5766.308043034863, 5782.88434231313, 5810.825675229666, 5865.178874957509, 5868.471837534642, 5963.075723262901, 5868.765249389977, 5875.823725288248, 5878.735456904449, 5879.323877754027, 5912.556558258148, 5837.357890632027, 5885.852853678693, 5888.411158884077, 5897.764089436375, 5906.40935906406, 4497.257952437811, 4499.550044995474, 4543.636509079266, 4544.068465964469, 4568.931466028012, 4110.116324990141, 4110.46563946685, 4115.670746340285, 4119.361498967605, 4147.502299723992, 5640.915386269209, 5656.406077361818, 5681.517071048925, 5682.119271512922, 5709.42905709434, 5713.914291285634, 5800.129980502874, 5822.563307751935, 5886.676232807151, 5897.026990546512, 5696.401877802854, 5697.857553561112, 5706.029974904276, 5706.743196556082, 5727.1695604138, 5138.845834624967, 5142.922856157161, 5148.227765835155, 5151.484851514893, 5190.480951904779, 5840.2991641003355, 6032.457078863011, 6083.878322433615, 6229.345918678474, 6239.812805615838, 5866.472017518444, 5924.911126333022, 5947.167396564398, 5950.910736339045, 5986.610870293417, 6144.078388241799, 6216.689165541615, 6219.346968568235, 6220.191375121205, 6234.127222188988, 5591.27313449249, 5620.297462817148, 5830.82507524775, 5831.446012628793, 5834.533237340917, 5818.44724751148, 5876.706164691663, 5879.764809407747, 5945.494632956074, 5965.164876917148, 5733.770649173986, 5775.104858746733, 5775.8556036099435, 5779.335376431596, 5796.362400136066, 5649.265595472562, 5775.1914731938405, 5779.364269930388, 5781.046127389102, 5787.565932554991, 5576.414476480073, 5607.214989901336, 5614.354349249888, 5672.064109421899, 5756.942430575808, 5800.6809625471005, 5804.912926306024, 5809.302883653989, 5810.215620891295, 5819.0, 5517.062099443185, 5550.222968784293, 5577.693226872561, 5664.150377443417, 5672.404397538199], "value": 5439.695473981295, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.3568442555403, 626.9185005949228, 630.6436863172306, 667.9098321726568, 675.5608854244737, 34053.31893362131, 37586.0, 44831.999999999956, 45734.771326143324, 45850.0, 45513.7724311378, 45892.541074589324, 46057.0, 46180.0, 46206.76896615521, 8874.423162494433, 9009.099090091004, 9022.368434209608, 9026.0, 9031.683891063814, 8300.460470069425, 8565.914340856574, 10493.895061049368, 10668.733281667981, 10785.514651840647, 10389.220808439359, 10454.425006624633, 10458.790824183512, 10466.581336746522, 10470.371777693363, 10703.571857125706, 10734.0, 10763.408012559306, 10768.492411062458, 10777.83833242502, 10771.730706732395, 10838.67483975482, 10846.837297440545, 10848.077913377372, 10850.294730842548, 43277.0, 43516.0, 43603.34594981078, 43615.563844361786, 43634.34548481744, 3723.3298006358846, 3805.7335986480957, 3905.1799122184375, 3969.64273215412, 4321.006168581244, 32657.183570410692, 32682.346353073044, 33125.83437082799, 33156.0, 33176.0, 3984.4222587724616, 4032.213718324928, 4084.4894388201474, 4110.46563946688, 4257.8296868125235, 379006.0, 381172.0, 381734.0, 382169.0, 382805.0, 66284.66857665777, 66917.6654116736, 66934.64120908506, 67022.66488667525, 67100.6644966772, 40692.18615627671, 41498.58501415008, 41624.583754162675, 69934.30065699278, 70206.0, 18686.906565467085, 19227.423177304703, 19231.903840480707, 19240.326588569333, 19245.0, 12994.935025324812, 13247.470101195844, 14490.130592164503, 14711.0, 14713.0, 20071.896045717625, 20720.896395518226, 20930.162793488395, 21504.677429838564, 21630.56738865214, 7194.964025179841, 7356.705731770669, 7543.434242431839, 7551.924480755232, 7557.773266802004, 966.1932286540676, 1054.478033373485, 1060.316096118015, 1065.4885654885697, 1185.1763024697925, 33175.17062073419, 34054.48918266228, 34095.0, 34270.657293426746, 34701.65298347035, 1128.5090985421368, 1152.0380482297207, 1162.8197629367462, 1194.42070595761, 1279.8400199975003, 13744.862551374557, 18605.162767675487, 18737.026707025205, 19211.32760353381, 19728.210871564977, 514995.0, 516801.0, 518182.0, 520911.0, 521637.0, 60203.39796602065, 60244.397556024756, 60317.0, 60335.396646033856, 60691.0, 1301.479408236713, 1312.2913626641698, 1375.848656647768, 1386.8058471813954, 1419.276169153739, 31366.372672546877, 33796.662033379354, 34591.65408345985, 34793.304133917685, 34960.08330440799, 52566.474335256156, 52592.0, 52998.735006326264, 53001.734991324796, 53108.734456327475, 392739.0, 393001.0, 393566.0, 394431.0, 394486.0, 29835.403291934475, 32202.83898580492, 32315.35369292648, 32319.0, 32640.34719305553, 48113.0, 48204.276935845286, 48305.27542086942, 48771.268430974276, 49056.75471622619, 41474.9262536878, 41672.166556669305, 41745.16509669729, 42054.579454205064, 43005.56994430016, 41466.81525383905, 41999.58000419957, 42251.36622950597, 42374.0, 42637.147257054065, 42365.36451953161, 42811.0, 43207.35188972105, 43981.56018439903, 44141.33787993247, 35872.0, 38375.42436863393, 38554.0361490965, 39372.0, 39455.408168876915, 28684.42631147407, 28705.856470717514, 29117.64122303984, 29159.85420072886, 29295.267618309714], "value": 21158.682153724974, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.5029263128457, 428.81346614222815, 430.90304681446673, 437.17017506280047, 450.71830106183637, 16400.83599164008, 19589.804101958976, 20298.28955986539, 20989.68515472269, 21300.18948389385, 20083.89958050208, 20437.489062773402, 20916.68624970623, 20931.895340523275, 21156.57686846262, 5750.884982300351, 5809.593328467009, 5977.7608895644125, 5986.191864098357, 5990.041593345066, 5862.677552734598, 6046.093086037085, 6049.758009679629, 6051.969740151293, 6058.727357268912, 5810.738516766734, 5950.553708471882, 6013.037913933771, 6020.8494787630225, 6025.728842202089, 5883.970580147094, 5978.402159784008, 5985.970070149665, 6014.8496287592725, 6019.668918209497, 5232.555232805216, 5329.920051199235, 5377.193420986844, 5406.351237851483, 5413.296271484682, 24657.87671061651, 24966.500669986497, 25085.62371564428, 25145.874270628712, 25249.0, 2492.8130390220626, 2503.662005629235, 2619.292790946453, 2747.4230411613585, 2871.224769312295, 15500.5349839505, 15597.454089106941, 15637.218139093, 15799.684006319923, 16249.756253656205, 1998.4604156877706, 2000.8899510526915, 2040.540878302385, 2098.244631932503, 2133.0614529606923, 75934.0, 78076.21923780804, 88779.55610221972, 91662.54168729113, 93669.0, 10531.84202236967, 11271.492782824793, 11439.485223164978, 11601.535938562532, 12172.0, 15228.629423351951, 15974.281157347947, 15976.201189940457, 15979.121148336953, 16011.0, 8287.171282871785, 8728.639473802505, 8816.823663526822, 8836.955815220883, 8991.190792828545, 8159.67361305553, 8277.917220827836, 8294.502329860228, 8436.0, 8536.914630853613, 4954.380702412199, 5051.87370315745, 5064.11378008847, 5141.074606570778, 5164.870878227999, 1968.507873031742, 2017.2939471185261, 2053.260826102602, 2068.2037415595105, 2074.6369385357802, 934.7008957133788, 1011.7369483934231, 1015.6445244164631, 1054.6941386997837, 1056.709404913655, 20339.18643254283, 20644.613232060943, 20901.686474702892, 20926.0, 21110.47223819417, 999.8250306196387, 1020.1532727835878, 1029.3823705776624, 1042.3329069395593, 1064.5316060933164, 9459.574319155654, 11396.202265841477, 11419.543218271343, 11638.476268567934, 11707.824382634097, 379600.0, 456448.0, 463243.0, 464436.0, 545692.0, 84550.5772471146, 86382.56808715916, 87964.56017719998, 99045.0, 106117.46941265244, 506.68585477004495, 530.8619758862724, 533.3679589686234, 533.4585395823243, 533.9279197308314, 9943.900560994587, 11425.31448113116, 11875.82186267224, 11899.583514576949, 12236.694082648006, 40893.0, 42025.579744202165, 42266.0, 42710.57289427066, 42831.57168428276, 55527.16709249284, 56325.71837140788, 56752.71623641856, 57768.0, 58543.12185317138, 8364.414490985573, 8706.0, 8739.563021848755, 8873.068327825744, 8904.465732056098, 13057.869421306046, 13406.93296533511, 13479.46082156742, 13559.661008474866, 13654.453821847412, 5986.132010858314, 8749.956250218707, 9431.811363772824, 10937.56249750001, 11601.071914247008, 5663.66018038919, 10571.36571805694, 11240.269382490113, 11392.088632909514, 11651.88348116542, 12093.274403535816, 12129.332886690963, 12248.632541023784, 12249.755004900031, 12384.071194660257, 8651.437656552303, 8875.245604123722, 9042.638294468148, 9236.907630923604, 9364.438133712, 9119.589618467053, 11191.66425007251, 11742.70643233926, 12216.144869859025, 12588.559400420942], "value": 9257.619692658878, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1485.99257003715, 1518.893677442579, 1623.691498615263, 1761.6917039518082, 1799.9640007199848, 8581.35639827013, 9213.447193168406, 9216.216621587173, 9222.861657075133, 9231.215346695539, 7768.961155194216, 7972.043354797418, 8773.25427338677, 8999.955000225005, 9044.321675874302, 2489.3900994256433, 2518.3326418499114, 2532.240327901622, 2534.1257266243115, 2547.0575886921865, 2480.60310350344, 2525.0, 2526.3178941685733, 2526.3305224115625, 2527.4060595759984, 2474.096954611563, 2480.417101981033, 2489.7385774493687, 2489.8132640051977, 2501.0371007162194, 2381.0475809676095, 2387.8567285962813, 2399.544086623536, 2400.567897778399, 2408.674828898094, 2352.1649814316015, 2354.376090336062, 2384.7853693167526, 2387.5224955009066, 2402.1712509184304, 9185.49479778612, 9193.08069193082, 9265.44407335562, 9312.161905428477, 9325.067493250688, 5587.497125258706, 5742.454466825645, 5742.511886489653, 5743.971280143614, 5747.310322761254, 3459.238967427162, 3473.7394695397693, 3588.1567831559564, 3592.1378869071236, 3608.711303095746, 1142.605800998654, 1159.6810877008807, 1177.1348059176498, 1177.805662065758, 1199.5321824488456, 12886.742265154644, 12918.41867115982, 12935.935320323339, 12936.870631293756, 12959.67600809978, 4775.188218002948, 4947.82682606107, 5059.06407314648, 5164.457731938168, 5185.844424667191, 10951.288166269167, 10961.287516311415, 10968.670939871816, 10969.451527423596, 10977.12183025356, 5729.627574207747, 5740.282464691913, 5741.569382296345, 5743.4543718346695, 5746.0, 4444.6666500012625, 4823.541763532458, 5011.649184557119, 5049.192129259301, 5269.578433725293, 4231.280682284019, 4270.850520231777, 4346.891327716832, 4384.802683879233, 4399.890002749893, 1378.8759011688996, 1402.2778269191374, 1407.5003373802358, 1412.9434822607186, 1424.1455126923763, 584.9996505974746, 843.2073850580434, 917.8347897378402, 926.578406824893, 1005.8591797148405, 5778.624389414675, 5839.182514447981, 5955.642661440327, 6193.876122477525, 6243.188385509855, 902.1114202510522, 965.0590674092704, 986.3884391677062, 987.0918754745651, 1020.8877023527406, 3734.626537346298, 3896.6103389661375, 4036.334004889219, 4079.6124368184974, 4121.381792731055, 11148.386838723947, 11301.71745706364, 11365.261258018203, 11432.657020289405, 11485.885141148481, 11274.0, 11352.829707554394, 11367.886321136848, 11369.0, 11383.54465821358, 8423.284020858297, 8668.479891206547, 8719.346049046348, 8729.08344623818, 8745.825083498294, 5886.735096920564, 5895.764169433174, 6018.7291571878495, 6022.277326720821, 6041.063635136561, 10349.74125646865, 10517.73705657334, 10543.42011189392, 10659.09397701204, 10667.89332106669, 10839.458027098772, 10866.565337386415, 10908.018278354668, 10922.617708380169, 10960.890391096305, 7033.331833475811, 7096.858062838611, 7118.679659415442, 7138.64306784669, 7179.353858152791, 8421.70524031656, 8455.069942306465, 8490.957545212234, 8516.276116530164, 8520.61657225414, 5844.766209351578, 7234.710611575689, 7408.288599087078, 7562.546247225184, 7798.493097948615, 6781.457483401217, 6853.109095817512, 6967.268436814062, 7164.140303163654, 7223.277672232734, 6987.0, 6994.090768200102, 7037.472189585904, 7041.788746337413, 7044.5068845182395, 5407.351117865881, 5451.972740136433, 5482.671039737628, 5498.505134537911, 5700.572457065654, 5423.186522021729, 5453.072977593739, 5492.176173573996, 5601.243832082617, 5645.379008309001], "value": 4786.144247704849, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.3448551209239, 356.7395801065223, 358.8223829204544, 363.37318126232236, 365.2202547560958, 5361.7587208575615, 5369.140937450009, 5412.161115027172, 5435.4564543545675, 5440.911817636478, 4995.800167993276, 5085.745712714368, 5130.307408499861, 5180.974095129529, 5275.894482110355, 4190.141021090669, 4191.685623578243, 4195.139996300759, 4196.811143498535, 4203.831846726127, 4203.810828512725, 4206.642435392995, 4214.536400995888, 4225.8520951766695, 4250.53244143144, 3908.667763240128, 3966.7818269995137, 4141.378793181017, 4162.666986641061, 4196.454460920076, 4134.524529679095, 4147.585241475858, 4170.35359519275, 4172.9999999999845, 4174.248635245654, 3725.4970578972034, 3729.9440508392395, 3732.850685972558, 3735.6652092442223, 3742.7380083394173, 5028.371453568304, 5088.745562721849, 5101.903090835488, 5146.871328216787, 5155.7626169719, 4773.904521909542, 4783.3064205690325, 4783.330333753277, 4788.473267940523, 4794.928076078827, 5453.654928380794, 5460.726963651801, 5463.754131064112, 5501.284832971688, 5518.448155184489, 3961.4652021976954, 4041.595840415935, 4114.444549985744, 4136.420901073852, 4144.44050053242, 5641.830745077613, 5677.501899164355, 5691.51622112121, 5691.971540142273, 5715.342735585461, 4153.522344930311, 4213.799067265814, 4218.135282267128, 4225.3239481683395, 4231.365295205744, 3979.522457305084, 4148.979255103705, 4263.4031235627035, 4265.253580623378, 4279.988405449434, 4707.882302942386, 4720.221163508051, 4726.338312636233, 4756.262779269219, 4759.571638552477, 5581.0, 5591.608587398843, 5592.496675299242, 5599.356074051455, 5627.606067575231, 1361.379957850155, 1398.8041674165624, 1404.0873432268902, 1406.4093080906043, 1416.6387571169491, 919.7010971434311, 943.5376665434026, 963.1764841060792, 986.6102889358663, 988.367444835306, 5291.021161085211, 5308.522232999048, 5315.441878602768, 5316.601254905898, 5317.707526086102, 5456.599096397573, 5480.314960629921, 5486.423925487846, 5522.475364840334, 5540.889182216414, 5281.9471805281455, 5322.392027906375, 5483.287172667528, 5519.2824932758485, 5531.834044978657, 2888.7722717845254, 2906.3315437449505, 2915.6063931369417, 2935.251510864716, 2941.2205765472168, 5596.776128954796, 5748.827535173868, 5795.0, 5808.5933984621515, 5821.53427725781, 5546.389897111315, 5592.748326325325, 5609.663420194802, 5630.183623374588, 5645.4072322405555, 5782.508486778587, 5794.565407594448, 5798.9130163047585, 5813.389594092644, 5820.505257053198, 5360.731963401737, 5506.64206826555, 5512.834614961557, 5519.0407405372125, 5527.474889885454, 5400.108982017923, 5447.972760136174, 5455.290812194389, 5473.75368108444, 5484.177373394023, 5603.943960560506, 5737.0, 5785.074388097884, 5849.766009359578, 5884.205632239593, 4093.0381360380884, 4096.692748043968, 4107.322291821816, 4113.25961326964, 4156.272652285898, 5411.540019098264, 5442.564594832483, 5488.313960754906, 5504.091824848855, 5517.868836888509, 5241.768184476568, 5252.553532949589, 5363.927214557026, 5386.542143917811, 5402.378726446509, 5251.789928402821, 5282.76227569768, 5301.098813201688, 5333.226682131147, 5389.407165211902, 5257.158854583248, 5305.0, 5323.361196656426, 5324.467553244799, 5430.891382172414, 5478.808241711521, 5544.473275038865, 5553.944750497392, 5560.777568897199, 5571.66570005801, 5437.945620543744, 5448.891022179613, 5449.128139497661, 5457.61796674229, 5472.370677372153], "value": 4223.171501530185, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.3343989769824, 751.1024325930515, 816.7508909782516, 841.7685136587438, 854.8204876975835, 14888.032277901928, 15531.223438828056, 15538.689226215483, 15563.0, 15583.92208038961, 14107.858921410783, 14485.63785905353, 14499.347529361177, 14522.564323070299, 14528.0, 702.9015937768717, 719.8344380792421, 821.3347188777079, 821.5153059694779, 842.0526907229367, 826.1243082332717, 840.7729912923508, 840.8066144786673, 840.8570543007703, 842.5871323051691, 881.6385282034367, 882.7616543533242, 882.841088604051, 883.0198479687542, 883.1477624092781, 729.4310437858452, 737.9741709040212, 857.5583574459158, 881.2509367038031, 881.6473410635733, 645.3062957320899, 645.7029766307504, 650.5738741124571, 650.8991106378519, 651.6350843527592, 14551.272436378245, 14653.34059967304, 14702.705945881022, 14923.179225142612, 14986.47547335838, 12735.872641273561, 13480.730385392335, 13800.861991380058, 13935.163890166623, 13960.93019534906, 11828.467718952581, 11860.52557897683, 11992.460339284753, 12163.0, 12322.445489952885, 4334.848280310174, 4350.912981740379, 4355.673324500675, 4540.409746732937, 4542.4776150742755, 68438.0, 69570.65214673945, 71973.0, 72543.0, 74980.62509687472, 11021.504032318566, 11095.778084438427, 11136.554537818396, 11229.887701123047, 11380.772384552263, 18758.624827503645, 18768.0, 18818.623627527373, 18855.151518181716, 18900.810991889906, 7996.480228785227, 8087.665535186628, 8275.875861862078, 8462.02686691026, 8546.786330341667, 4419.42547468827, 4439.844605438794, 4441.045175287329, 4448.421705178306, 4532.9546704533195, 3380.8309584520675, 3483.024753069094, 3491.9301613967577, 3494.371013217645, 3501.5798104227656, 597.9760809567656, 612.5222326585271, 624.887520246351, 626.37675512865, 626.7242413338116, 544.6487015874818, 568.7469076261107, 590.1825971030154, 659.3867703036127, 669.093378472173, 8458.830823383621, 8573.271271941954, 8802.230627388844, 9000.8649870252, 9115.817683646423, 579.9507041901401, 648.6821457485798, 675.8175292670951, 676.3034074902858, 702.4240123099112, 3832.9116435977353, 4031.616996385397, 4069.877903662895, 4179.561146079679, 4211.305134652809, 85052.57473712716, 87656.12343876607, 90076.09923900808, 92606.53696731474, 93427.0, 69754.65122674355, 77687.61156194183, 81373.59313203396, 83721.0, 85010.14989850023, 70307.64846175736, 71407.64296178486, 72134.63932680304, 73122.26877731155, 73465.6326718363, 7766.766996990099, 7900.446968712135, 8146.918530814616, 8168.959155204186, 8213.917860821315, 40312.79843600763, 46435.53564464447, 46579.53420465752, 48232.276515852995, 49840.0, 40122.79938600288, 40411.0, 45647.77176114098, 62652.0, 63570.68214658897, 11094.611688590861, 12348.197367171106, 12654.240745554927, 12812.935935320264, 13199.34003299812, 13037.739245215233, 13168.80246796318, 13864.168149911038, 14553.927230364205, 14992.550223493312, 13691.589252322447, 13773.793393098911, 13922.721545569235, 14108.0, 14654.926725366306, 12535.417101613586, 12788.48846046185, 12875.35623218854, 12899.419526121159, 13078.0, 12704.491820327454, 12766.872331276569, 13031.869681303446, 13312.866871331164, 13364.465421383426, 10060.949695251476, 10244.231682623684, 10482.423466709404, 10593.311434756715, 10608.946955265174, 10477.16182705397, 10606.416647084485, 10614.0, 10743.048396013579, 10879.619213327496], "value": 7093.943735156304, "unit": "score"}], "name": "dromaeo_css", "value": 7311.728829629173, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 109.0, 109.0, 113.0, 109.0, 111.0, 109.0, 109.0, 109.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 120.0, 116.0, 152.0, 121.0, 124.0, 119.0, 124.0, 144.0, 129.0], "value": 129.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 160.0, 160.0, 160.0, 161.0, 159.0, 159.0, 161.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 104.0, 75.0, 76.0, 75.0, 79.0, 95.0, 76.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 116.0, 81.0, 87.0, 81.0, 97.0, 82.0, 81.0, 114.0], "value": 90.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 85.0, 85.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 51.0, 50.0, 50.0, 51.0, 51.0, 51.0, 50.0, 51.0], "value": 50.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 61.0, 60.0, 61.0, 61.0, 58.0, 59.0, 59.0, 60.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 74.0, 77.0, 75.0, 80.0, 75.0, 82.0, 75.0, 73.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 125.0, 123.0, 124.0, 133.0, 131.0, 120.0, 120.0, 154.0, 122.0], "value": 127.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 151.0, 153.0, 156.0, 155.0, 151.0, 154.0, 152.0, 156.0, 151.0], "value": 153.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 62.0, 66.0, 63.0, 61.0, 62.0, 60.0, 61.0, 61.0, 60.0], "value": 62.9, "unit": "score"}], "name": "kraken", "value": 1447.5, "alertThreshold": 2.0}]} 16:35:06 INFO - Return code: 0 16:35:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:35:06 INFO - # TBPL SUCCESS # 16:35:06 INFO - Running post-action listener: _resource_record_post_action 16:35:06 INFO - [mozharness: 2017-01-13 00:35:06.496637Z] Finished run-tests step (success) 16:35:06 INFO - Running post-run listener: _resource_record_post_run 16:35:06 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 367554560; Read time: 8; Write time: 253164 16:35:06 INFO - TinderboxPrint: CPU usage
13.0% 16:35:06 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 16:35:06 INFO - TinderboxPrint: I/O write bytes / time
367,554,560 / 253,164 16:35:06 INFO - TinderboxPrint: CPU idle
8,276.6 (87.0%) 16:35:06 INFO - TinderboxPrint: CPU user
1,192.4 (12.5%) 16:35:06 INFO - TinderboxPrint: Swap in / out
0 / 0 16:35:06 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118833152; Read time: 0; Write time: 82836 16:35:06 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 247545856; Read time: 0; Write time: 170296 16:35:07 INFO - Running post-run listener: _upload_blobber_files 16:35:07 INFO - Blob upload gear active. 16:35:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:35:07 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 16:35:07 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'] 16:35:07 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 16:35:07 INFO - (blobuploader) - INFO - Open directory for files ... 16:35:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:35:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:35:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:35:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:35:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:35:11 INFO - (blobuploader) - INFO - Done attempting. 16:35:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:35:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:35:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:35:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:35:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:35:12 INFO - (blobuploader) - INFO - Done attempting. 16:35:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:35:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:35:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:35:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:35:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:35:12 INFO - (blobuploader) - INFO - Done attempting. 16:35:12 INFO - (blobuploader) - INFO - Iteration through files over. 16:35:12 INFO - Return code: 0 16:35:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:35:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:35:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c8853439c2eb2ef9e0780fbf7bcae6e1d283929208ceb3db24bf013f3bc395c4c057055fa392d21791a1bf25586bbe62d4623482f6bd35082a340a7465cce685", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c04874a3bdc48a8f16621d477fef16e51417e5645634b81d486afb0a16d21b5cb7e188df2a0699a0c6ccaf76a35cbf04e2471dc52fd3f47496094d705f7355e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b8422d3b6bf939e3f1c4a1d164fde1aaadb3c25d8d8272f44a4c54e482bca7f466b0171a39b9f8002d9913ef03602bbc9e354874558f7f36bf0ba8d93757c6c2"} 16:35:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:35:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:35:12 INFO - Contents: 16:35:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c8853439c2eb2ef9e0780fbf7bcae6e1d283929208ceb3db24bf013f3bc395c4c057055fa392d21791a1bf25586bbe62d4623482f6bd35082a340a7465cce685", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c04874a3bdc48a8f16621d477fef16e51417e5645634b81d486afb0a16d21b5cb7e188df2a0699a0c6ccaf76a35cbf04e2471dc52fd3f47496094d705f7355e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b8422d3b6bf939e3f1c4a1d164fde1aaadb3c25d8d8272f44a4c54e482bca7f466b0171a39b9f8002d9913ef03602bbc9e354874558f7f36bf0ba8d93757c6c2"} 16:35:12 INFO - Running post-run listener: copy_logs_to_upload_dir 16:35:12 INFO - Copying logs to upload dir... 16:35:12 INFO - mkdir: /builds/slave/test/build/upload/logs 16:35:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.252768 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-12 16:35:12.723755) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 16:35:12.727374) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1484264711.283547-624905592 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/c8853439c2eb2ef9e0780fbf7bcae6e1d283929208ceb3db24bf013f3bc395c4c057055fa392d21791a1bf25586bbe62d4623482f6bd35082a340a7465cce685", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c04874a3bdc48a8f16621d477fef16e51417e5645634b81d486afb0a16d21b5cb7e188df2a0699a0c6ccaf76a35cbf04e2471dc52fd3f47496094d705f7355e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b8422d3b6bf939e3f1c4a1d164fde1aaadb3c25d8d8272f44a4c54e482bca7f466b0171a39b9f8002d9913ef03602bbc9e354874558f7f36bf0ba8d93757c6c2"} build_url:https://queue.taskcluster.net/v1/task/ZLcQY6-oSL-QFAZZ5mpGVA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011459 build_url: 'https://queue.taskcluster.net/v1/task/ZLcQY6-oSL-QFAZZ5mpGVA/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/c8853439c2eb2ef9e0780fbf7bcae6e1d283929208ceb3db24bf013f3bc395c4c057055fa392d21791a1bf25586bbe62d4623482f6bd35082a340a7465cce685", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c04874a3bdc48a8f16621d477fef16e51417e5645634b81d486afb0a16d21b5cb7e188df2a0699a0c6ccaf76a35cbf04e2471dc52fd3f47496094d705f7355e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b8422d3b6bf939e3f1c4a1d164fde1aaadb3c25d8d8272f44a4c54e482bca7f466b0171a39b9f8002d9913ef03602bbc9e354874558f7f36bf0ba8d93757c6c2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 16:35:12.752268) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 16:35:12.752667) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1484264711.283547-624905592 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.11 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 16:35:12.862711) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 16:35:12.863030) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 16:35:12.863325) ========= ========= Total master_lag: 0.19 =========