builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0040 starttime: 1465288644.36 results: success (0) buildid: 20160606120332 builduid: 394ff36afaaf47b0a5ccdc9e3ac607e3 revision: 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:24.358383) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:24.358821) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 4 secs) (at 2016-06-07 01:37:24.359094) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 4 secs) (at 2016-06-07 01:37:28.849440) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:28.849852) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lNduFWahUX/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.IkjwyJLb6P/Listeners TMPDIR=/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-06-07 01:37:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.97M=0.001s 2016-06-07 01:37:28 (7.97 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.078198 ========= master_lag: 0.57 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:29.495667) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:29.495979) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lNduFWahUX/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.IkjwyJLb6P/Listeners TMPDIR=/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.020670 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:29.535946) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 01:37:29.540871) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 --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-beta --rev 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lNduFWahUX/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.IkjwyJLb6P/Listeners TMPDIR=/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-06-07 01:37:29,616 truncating revision to first 12 chars 2016-06-07 01:37:29,616 Setting DEBUG logging. 2016-06-07 01:37:29,616 attempt 1/10 2016-06-07 01:37:29,616 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/46d72a56c57d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 01:37:31,241 unpacking tar archive at: mozilla-beta-46d72a56c57d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.877969 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 01:37:31.441143) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:31.442961) ========= script_repo_revision: 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:31.443409) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:31.443726) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:31.468701) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-07 01:37:31.469069) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lNduFWahUX/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.IkjwyJLb6P/Listeners TMPDIR=/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 01:37:31 INFO - MultiFileLogger online at 20160607 01:37:31 in /builds/slave/test 01:37:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 01:37:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:37:31 INFO - {'append_to_log': False, 01:37:31 INFO - 'base_work_dir': '/builds/slave/test', 01:37:31 INFO - 'blob_upload_branch': 'Mozilla-Beta', 01:37:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:37:31 INFO - 'branch': 'Mozilla-Beta', 01:37:31 INFO - 'buildbot_json_path': 'buildprops.json', 01:37:31 INFO - 'config_files': ('talos/mac_config.py',), 01:37:31 INFO - 'default_actions': ('clobber', 01:37:31 INFO - 'read-buildbot-config', 01:37:31 INFO - 'download-and-extract', 01:37:31 INFO - 'populate-webroot', 01:37:31 INFO - 'create-virtualenv', 01:37:31 INFO - 'install', 01:37:31 INFO - 'run-tests'), 01:37:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:37:31 INFO - 'download_minidump_stackwalk': True, 01:37:31 INFO - 'download_symbols': 'ondemand', 01:37:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:37:31 INFO - 'tooltool.py': '/tools/tooltool.py', 01:37:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:37:31 INFO - '/tools/misc-python/virtualenv.py')}, 01:37:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:37:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:37:31 INFO - 'installer_path': 'installer.exe', 01:37:31 INFO - 'log_level': 'info', 01:37:31 INFO - 'log_name': 'talos', 01:37:31 INFO - 'log_to_console': True, 01:37:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:37:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:37:31 INFO - 'opt_config_files': (), 01:37:31 INFO - 'pip_index': False, 01:37:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:37:31 INFO - 'cmd': ('bash', 01:37:31 INFO - '-c', 01:37:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:37:31 INFO - 'enabled': True, 01:37:31 INFO - 'halt_on_failure': False, 01:37:31 INFO - 'name': 'check_screen_resolution'},), 01:37:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:37:31 INFO - 'cmd': ('bash', 01:37:31 INFO - '-c', 01:37:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:37:31 INFO - 'enabled': True, 01:37:31 INFO - 'halt_on_failure': False, 01:37:31 INFO - 'name': 'check_screen_resolution'},), 01:37:31 INFO - 'run_cmd_checks_enabled': True, 01:37:31 INFO - 'sps_profile': False, 01:37:31 INFO - 'sps_profile_interval': 0, 01:37:31 INFO - 'suite': 'dromaeojs-e10s', 01:37:31 INFO - 'system_bits': '32', 01:37:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:37:31 INFO - 'title': 't-yosemite-r7-0040', 01:37:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:37:31 INFO - 'use_talos_json': True, 01:37:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:37:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:37:31 INFO - 'work_dir': 'build'} 01:37:31 INFO - ##### 01:37:31 INFO - ##### Running clobber step. 01:37:31 INFO - ##### 01:37:31 INFO - Running pre-action listener: _resource_record_pre_action 01:37:31 INFO - Running main action method: clobber 01:37:31 INFO - rmtree: /builds/slave/test/build 01:37:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:37:33 INFO - Running post-action listener: _resource_record_post_action 01:37:33 INFO - ##### 01:37:33 INFO - ##### Running read-buildbot-config step. 01:37:33 INFO - ##### 01:37:33 INFO - Running pre-action listener: _resource_record_pre_action 01:37:33 INFO - Running main action method: read_buildbot_config 01:37:33 INFO - Using buildbot properties: 01:37:33 INFO - { 01:37:33 INFO - "project": "", 01:37:33 INFO - "product": "firefox", 01:37:33 INFO - "script_repo_revision": "production", 01:37:33 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 01:37:33 INFO - "repository": "", 01:37:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 01:37:33 INFO - "buildid": "20160606120332", 01:37:33 INFO - "pgo_build": "False", 01:37:33 INFO - "basedir": "/builds/slave/test", 01:37:33 INFO - "buildnumber": 2, 01:37:33 INFO - "slavename": "t-yosemite-r7-0040", 01:37:33 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 01:37:33 INFO - "platform": "yosemite_r7", 01:37:33 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 01:37:33 INFO - "branch": "mozilla-beta", 01:37:33 INFO - "repo_path": "releases/mozilla-beta", 01:37:33 INFO - "revision": "46d72a56c57dafb4dc1061d4741a3e1181ac3d68", 01:37:33 INFO - "stage_platform": "macosx64", 01:37:33 INFO - "builduid": "394ff36afaaf47b0a5ccdc9e3ac607e3", 01:37:33 INFO - "slavebuilddir": "test" 01:37:33 INFO - } 01:37:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 01:37:33 INFO - Running post-action listener: _resource_record_post_action 01:37:33 INFO - ##### 01:37:33 INFO - ##### Running download-and-extract step. 01:37:33 INFO - ##### 01:37:33 INFO - Running pre-action listener: _resource_record_pre_action 01:37:33 INFO - Running main action method: download_and_extract 01:37:33 INFO - mkdir: /builds/slave/test/build/tests 01:37:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:33 INFO - https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 01:37:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 01:37:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 01:37:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 01:37:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 01:37:34 INFO - Downloaded 1165 bytes. 01:37:34 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 01:37:34 INFO - Using the following test package requirements: 01:37:34 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 01:37:34 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:37:34 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 01:37:34 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:37:34 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 01:37:34 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 01:37:34 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:37:34 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 01:37:34 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 01:37:34 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:37:34 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 01:37:34 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:37:34 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 01:37:34 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:37:34 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 01:37:34 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:37:34 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 01:37:34 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 01:37:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:34 INFO - https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:37:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:37:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:37:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 01:37:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 01:37:36 INFO - Downloaded 18292404 bytes. 01:37:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:37:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:37:39 INFO - Return code: 0 01:37:39 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 01:37:39 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:39 INFO - https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:37:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:37:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:37:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 01:37:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 01:37:40 INFO - Downloaded 18292404 bytes. 01:37:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:37:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:37:44 INFO - Return code: 0 01:37:44 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:44 INFO - https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:37:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 01:37:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 01:37:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 01:37:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 01:37:45 INFO - Downloaded 10840145 bytes. 01:37:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:37:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 01:37:45 INFO - Return code: 0 01:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:45 INFO - https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 01:37:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:37:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:37:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 01:37:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 01:37:47 INFO - Downloaded 86246253 bytes. 01:37:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:37:47 INFO - mkdir: /builds/slave/test/properties 01:37:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:37:47 INFO - Writing to file /builds/slave/test/properties/build_url 01:37:47 INFO - Contents: 01:37:47 INFO - build_url:https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:37:49 INFO - Running post-action listener: _resource_record_post_action 01:37:49 INFO - Running post-action listener: set_extra_try_arguments 01:37:49 INFO - ##### 01:37:49 INFO - ##### Running populate-webroot step. 01:37:49 INFO - ##### 01:37:49 INFO - Running pre-action listener: _resource_record_pre_action 01:37:49 INFO - Running main action method: populate_webroot 01:37:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:37:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:37:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:37:49 INFO - '--tppagecycles', 01:37:49 INFO - '7'], 01:37:49 INFO - 'tests': ['tsvgm']}}, 01:37:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:37:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:37:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:37:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:37:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:37:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:37:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:49 INFO - 'talos_options': ['--disable-e10s'], 01:37:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:37:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:37:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:49 INFO - 'talos_options': ['--disable-e10s'], 01:37:49 INFO - 'tests': ['damp', 'tps']}, 01:37:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:49 INFO - 'tests': ['damp', 'tps']}, 01:37:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:37:49 INFO - 'tests': ['dromaeo_dom']}, 01:37:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:37:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:37:49 INFO - 'tests': ['a11yr', 01:37:49 INFO - 'ts_paint', 01:37:49 INFO - 'tpaint', 01:37:49 INFO - 'sessionrestore', 01:37:49 INFO - 'sessionrestore_no_auto_restore', 01:37:49 INFO - 'tabpaint']}, 01:37:49 INFO - 'other-e10s': {'tests': ['a11yr', 01:37:49 INFO - 'ts_paint', 01:37:49 INFO - 'tpaint', 01:37:49 INFO - 'sessionrestore', 01:37:49 INFO - 'sessionrestore_no_auto_restore', 01:37:49 INFO - 'tabpaint']}, 01:37:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:37:49 INFO - 'ts_paint', 01:37:49 INFO - 'tpaint', 01:37:49 INFO - 'sessionrestore', 01:37:49 INFO - 'sessionrestore_no_auto_restore', 01:37:49 INFO - 'tabpaint']}, 01:37:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:37:49 INFO - 'ts_paint', 01:37:49 INFO - 'tpaint', 01:37:49 INFO - 'sessionrestore', 01:37:49 INFO - 'sessionrestore_no_auto_restore', 01:37:49 INFO - 'tabpaint']}, 01:37:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:37:49 INFO - 'tests': ['a11yr', 01:37:49 INFO - 'ts_paint', 01:37:49 INFO - 'tpaint', 01:37:49 INFO - 'sessionrestore', 01:37:49 INFO - 'sessionrestore_no_auto_restore', 01:37:49 INFO - 'tabpaint']}, 01:37:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:37:49 INFO - 'tests': ['a11yr', 01:37:49 INFO - 'ts_paint', 01:37:49 INFO - 'tpaint', 01:37:49 INFO - 'sessionrestore', 01:37:49 INFO - 'sessionrestore_no_auto_restore', 01:37:49 INFO - 'tabpaint']}, 01:37:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:37:49 INFO - 'tests': ['tsvgx', 01:37:49 INFO - 'tsvgr_opacity', 01:37:49 INFO - 'tart', 01:37:49 INFO - 'tscrollx', 01:37:49 INFO - 'cart']}, 01:37:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:37:49 INFO - 'tsvgr_opacity', 01:37:49 INFO - 'tart', 01:37:49 INFO - 'tscrollx', 01:37:49 INFO - 'cart']}, 01:37:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:49 INFO - 'talos_options': ['--disable-e10s'], 01:37:49 INFO - 'tests': ['tp5o']}, 01:37:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:49 INFO - 'tests': ['tp5o']}, 01:37:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:49 INFO - 'talos_options': ['--disable-e10s', 01:37:49 INFO - '--xperf_path', 01:37:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:37:49 INFO - 'tests': ['tp5n']}, 01:37:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:49 INFO - 'talos_options': ['--xperf_path', 01:37:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:37:49 INFO - 'tests': ['tp5n']}}, 01:37:49 INFO - 'talos.zip': {'path': '', 01:37:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:37:49 INFO - Running post-action listener: _resource_record_post_action 01:37:49 INFO - ##### 01:37:49 INFO - ##### Running create-virtualenv step. 01:37:49 INFO - ##### 01:37:49 INFO - Running pre-action listener: _resource_record_pre_action 01:37:49 INFO - Running main action method: create_virtualenv 01:37:49 INFO - Creating virtualenv /builds/slave/test/build/venv 01:37:49 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 01:37:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:37:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:37:49 INFO - Using real prefix '/tools/python27' 01:37:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:37:49 INFO - Installing distribute.............................................................................................................................................................................................done. 01:37:52 INFO - Installing pip.................done. 01:37:52 INFO - Return code: 0 01:37:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:37:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:52 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 0x109256a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109266420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0d3597360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090f5e00>, '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 0x108f5edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090f0b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNduFWahUX/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IkjwyJLb6P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:37:52 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 01:37:52 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 01:37:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNduFWahUX/Render', 01:37:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:52 INFO - 'HOME': '/Users/cltbld', 01:37:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:52 INFO - 'LOGNAME': 'cltbld', 01:37:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:52 INFO - 'MOZ_NO_REMOTE': '1', 01:37:52 INFO - 'NO_EM_RESTART': '1', 01:37:52 INFO - 'PAGER': '/bin/cat', 01:37:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:52 INFO - 'PWD': '/builds/slave/test', 01:37:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:52 INFO - 'SHELL': '/bin/bash', 01:37:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IkjwyJLb6P/Listeners', 01:37:52 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 01:37:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:52 INFO - 'USER': 'cltbld', 01:37:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:52 INFO - 'XPC_FLAGS': '0x0', 01:37:52 INFO - 'XPC_SERVICE_NAME': '0', 01:37:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:52 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 01:37:52 INFO - Cleaning up... 01:37:53 INFO - Return code: 0 01:37:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:53 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109256a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109266420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0d3597360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090f5e00>, '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 0x108f5edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090f0b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNduFWahUX/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IkjwyJLb6P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:37:53 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>=0.7.1'] in /builds/slave/test/build 01:37:53 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>=0.7.1 01:37:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNduFWahUX/Render', 01:37:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:53 INFO - 'HOME': '/Users/cltbld', 01:37:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:53 INFO - 'LOGNAME': 'cltbld', 01:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:53 INFO - 'MOZ_NO_REMOTE': '1', 01:37:53 INFO - 'NO_EM_RESTART': '1', 01:37:53 INFO - 'PAGER': '/bin/cat', 01:37:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:53 INFO - 'PWD': '/builds/slave/test', 01:37:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:53 INFO - 'SHELL': '/bin/bash', 01:37:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IkjwyJLb6P/Listeners', 01:37:53 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 01:37:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:53 INFO - 'USER': 'cltbld', 01:37:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:53 INFO - 'XPC_FLAGS': '0x0', 01:37:53 INFO - 'XPC_SERVICE_NAME': '0', 01:37:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:53 INFO - Downloading/unpacking psutil>=0.7.1 01:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:37:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:37:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:37:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:37:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:37:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:37:56 INFO - Installing collected packages: psutil 01:37:56 INFO - Running setup.py install for psutil 01:37:56 INFO - building 'psutil._psutil_osx' extension 01:37:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 01:37:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 01:37:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 01:37:56 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 01:37:56 INFO - building 'psutil._psutil_posix' extension 01:37:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 01:37:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:37:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:37:56 INFO - ^ 01:37:56 INFO - 1 warning generated. 01:37:56 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 01:37:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:37:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:37:57 INFO - Successfully installed psutil 01:37:57 INFO - Cleaning up... 01:37:57 INFO - Return code: 0 01:37:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:37: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37: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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109256a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109266420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0d3597360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090f5e00>, '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 0x108f5edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090f0b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNduFWahUX/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IkjwyJLb6P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:37: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.0.0'] in /builds/slave/test/build 01:37: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.0.0 01:37:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNduFWahUX/Render', 01:37:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:57 INFO - 'HOME': '/Users/cltbld', 01:37:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:57 INFO - 'LOGNAME': 'cltbld', 01:37:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:57 INFO - 'MOZ_NO_REMOTE': '1', 01:37:57 INFO - 'NO_EM_RESTART': '1', 01:37:57 INFO - 'PAGER': '/bin/cat', 01:37:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:57 INFO - 'PWD': '/builds/slave/test', 01:37:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:57 INFO - 'SHELL': '/bin/bash', 01:37:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IkjwyJLb6P/Listeners', 01:37:57 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 01:37:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:57 INFO - 'USER': 'cltbld', 01:37:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:57 INFO - 'XPC_FLAGS': '0x0', 01:37:57 INFO - 'XPC_SERVICE_NAME': '0', 01:37:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:37: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 01:37: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 01:37: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 01:37: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 01:37: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 01:37: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 01:37:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:37:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:38:00 INFO - Installing collected packages: mozsystemmonitor 01:38:00 INFO - Running setup.py install for mozsystemmonitor 01:38:00 INFO - Successfully installed mozsystemmonitor 01:38:00 INFO - Cleaning up... 01:38:00 INFO - Return code: 0 01:38:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:38: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38: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', '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 0x109256a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109266420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0d3597360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090f5e00>, '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 0x108f5edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090f0b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNduFWahUX/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IkjwyJLb6P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:38: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:38: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 blobuploader==1.2.4 01:38:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNduFWahUX/Render', 01:38:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:38:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:38:00 INFO - 'HOME': '/Users/cltbld', 01:38:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:38:00 INFO - 'LOGNAME': 'cltbld', 01:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:00 INFO - 'MOZ_NO_REMOTE': '1', 01:38:00 INFO - 'NO_EM_RESTART': '1', 01:38:00 INFO - 'PAGER': '/bin/cat', 01:38:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:00 INFO - 'PWD': '/builds/slave/test', 01:38:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:38:00 INFO - 'SHELL': '/bin/bash', 01:38:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IkjwyJLb6P/Listeners', 01:38:00 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 01:38:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:38:00 INFO - 'USER': 'cltbld', 01:38:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:38:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:00 INFO - 'XPC_FLAGS': '0x0', 01:38:00 INFO - 'XPC_SERVICE_NAME': '0', 01:38:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:00 INFO - Downloading/unpacking blobuploader==1.2.4 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38:02 INFO - Downloading blobuploader-1.2.4.tar.gz 01:38:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:38:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:38:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38:04 INFO - Downloading docopt-0.6.1.tar.gz 01:38:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:38:04 INFO - Installing collected packages: blobuploader, requests, docopt 01:38:04 INFO - Running setup.py install for blobuploader 01:38:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:38:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:38:04 INFO - Running setup.py install for requests 01:38:04 INFO - Running setup.py install for docopt 01:38:04 INFO - Successfully installed blobuploader requests docopt 01:38:04 INFO - Cleaning up... 01:38:05 INFO - Return code: 0 01:38:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:05 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 0x109256a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109266420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0d3597360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090f5e00>, '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 0x108f5edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090f0b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNduFWahUX/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IkjwyJLb6P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:38:05 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 01:38:05 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 01:38:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNduFWahUX/Render', 01:38:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:38:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:38:05 INFO - 'HOME': '/Users/cltbld', 01:38:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:38:05 INFO - 'LOGNAME': 'cltbld', 01:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:05 INFO - 'MOZ_NO_REMOTE': '1', 01:38:05 INFO - 'NO_EM_RESTART': '1', 01:38:05 INFO - 'PAGER': '/bin/cat', 01:38:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:05 INFO - 'PWD': '/builds/slave/test', 01:38:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:38:05 INFO - 'SHELL': '/bin/bash', 01:38:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IkjwyJLb6P/Listeners', 01:38:05 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 01:38:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:38:05 INFO - 'USER': 'cltbld', 01:38:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:38:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:05 INFO - 'XPC_FLAGS': '0x0', 01:38:05 INFO - 'XPC_SERVICE_NAME': '0', 01:38:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:38:05 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-JJmI9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:38:05 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-Np6NzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:38:05 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-_cutfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:38:05 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-_vrxn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:38:05 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-pGl5Cv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:38:05 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-Iynao2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:38:05 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-SZC7VM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:38:06 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-N8_hzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:38:06 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-vpEYXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:38:06 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-SiJcS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:38:06 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-mslzH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:38:06 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-AbmJgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:38:06 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-XRsdV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:38:06 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-kts_Fi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:38:06 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-fRJfUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:38:06 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-7JKTVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:38:06 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-I3pJK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:38:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:38:07 INFO - Running setup.py install for manifestparser 01:38:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:38:07 INFO - Running setup.py install for mozcrash 01:38:07 INFO - Running setup.py install for mozdebug 01:38:07 INFO - Running setup.py install for mozdevice 01:38:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:38:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:38:07 INFO - Running setup.py install for mozfile 01:38:07 INFO - Running setup.py install for mozhttpd 01:38:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:38:07 INFO - Running setup.py install for mozinfo 01:38:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:38:08 INFO - Running setup.py install for mozInstall 01:38:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:38:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:38:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:38:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:38:08 INFO - Running setup.py install for mozleak 01:38:08 INFO - Running setup.py install for mozlog 01:38:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:38:08 INFO - Running setup.py install for moznetwork 01:38:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:38:08 INFO - Running setup.py install for mozprocess 01:38:08 INFO - Running setup.py install for mozprofile 01:38:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:38:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:38:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:38:09 INFO - Running setup.py install for mozrunner 01:38:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:38:09 INFO - Running setup.py install for mozscreenshot 01:38:09 INFO - Running setup.py install for moztest 01:38:09 INFO - Running setup.py install for mozversion 01:38:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:38:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:38:09 INFO - Cleaning up... 01:38:09 INFO - Return code: 0 01:38:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:38: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38: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 0x109256a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109266420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0d3597360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090f5e00>, '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 0x108f5edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090f0b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNduFWahUX/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IkjwyJLb6P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:38: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 01:38: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 01:38:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNduFWahUX/Render', 01:38:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:38:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:38:09 INFO - 'HOME': '/Users/cltbld', 01:38:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:38:09 INFO - 'LOGNAME': 'cltbld', 01:38:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:09 INFO - 'MOZ_NO_REMOTE': '1', 01:38:09 INFO - 'NO_EM_RESTART': '1', 01:38:09 INFO - 'PAGER': '/bin/cat', 01:38:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:38:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:09 INFO - 'PWD': '/builds/slave/test', 01:38:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:38:09 INFO - 'SHELL': '/bin/bash', 01:38:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IkjwyJLb6P/Listeners', 01:38:09 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 01:38:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:38:09 INFO - 'USER': 'cltbld', 01:38:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:38:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:38:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:09 INFO - 'XPC_FLAGS': '0x0', 01:38:09 INFO - 'XPC_SERVICE_NAME': '0', 01:38:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:38:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:38:09 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-6piZ8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:38: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)) 01:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:38:10 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-cUSQ_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:38:10 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-ZlAacG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:38: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)) 01:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:38:10 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-MMszJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:38: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)) 01:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:38:10 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-hS4eTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:38: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)) 01:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:38:10 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-IsvIdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:38: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)) 01:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:38:10 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-DtP9O4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:38: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)) 01:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:38:10 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-li8doV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:38: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)) 01:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:38:10 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-XNB3cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:38: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)) 01:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:38:10 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-zXt4X6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 01:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:38:11 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-FAVZTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:38:11 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)) 01:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:38:11 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-iwH5Qk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 01:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:38:11 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-HxtHfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:38: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)) 01:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:38:11 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-nz0rjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 01:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:38:11 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-17T_BQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:38: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)) 01:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:38:11 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-O5Wtzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:38:11 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-veo5tr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:38: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)) 01:38: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==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:38: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==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:38: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)) 01:38: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)) 01:38: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)) 01:38:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38:14 INFO - Downloading blessings-1.6.tar.gz 01:38:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:38:14 INFO - Installing collected packages: blessings 01:38:14 INFO - Running setup.py install for blessings 01:38:14 INFO - Successfully installed blessings 01:38:14 INFO - Cleaning up... 01:38:14 INFO - Return code: 0 01:38:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:38:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:38:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:38:14 INFO - Reading from file tmpfile_stdout 01:38:14 INFO - Current package versions: 01:38:14 INFO - blessings == 1.6 01:38:14 INFO - blobuploader == 1.2.4 01:38:14 INFO - docopt == 0.6.1 01:38:14 INFO - manifestparser == 1.1 01:38:14 INFO - mozInstall == 1.12 01:38:14 INFO - mozcrash == 0.17 01:38:14 INFO - mozdebug == 0.1 01:38:14 INFO - mozdevice == 0.48 01:38:14 INFO - mozfile == 1.2 01:38:14 INFO - mozhttpd == 0.7 01:38:14 INFO - mozinfo == 0.9 01:38:14 INFO - mozleak == 0.1 01:38:14 INFO - mozlog == 3.1 01:38:14 INFO - moznetwork == 0.27 01:38:14 INFO - mozprocess == 0.22 01:38:14 INFO - mozprofile == 0.28 01:38:14 INFO - mozrunner == 6.11 01:38:14 INFO - mozscreenshot == 0.1 01:38:14 INFO - mozsystemmonitor == 0.0 01:38:14 INFO - moztest == 0.7 01:38:14 INFO - mozversion == 1.4 01:38:14 INFO - psutil == 3.1.1 01:38:14 INFO - requests == 1.2.3 01:38:14 INFO - wsgiref == 0.1.2 01:38:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:38: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:14 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 0x109256a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109266420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0d3597360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090f5e00>, '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 0x108f5edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090f0b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNduFWahUX/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IkjwyJLb6P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:38:14 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 01:38:14 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 01:38:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNduFWahUX/Render', 01:38:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:38:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:38:14 INFO - 'HOME': '/Users/cltbld', 01:38:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:38:14 INFO - 'LOGNAME': 'cltbld', 01:38:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:14 INFO - 'MOZ_NO_REMOTE': '1', 01:38:14 INFO - 'NO_EM_RESTART': '1', 01:38:14 INFO - 'PAGER': '/bin/cat', 01:38:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:38:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:14 INFO - 'PWD': '/builds/slave/test', 01:38:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:38:14 INFO - 'SHELL': '/bin/bash', 01:38:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IkjwyJLb6P/Listeners', 01:38:14 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 01:38:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:38:14 INFO - 'USER': 'cltbld', 01:38:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:38:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:38:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:14 INFO - 'XPC_FLAGS': '0x0', 01:38:14 INFO - 'XPC_SERVICE_NAME': '0', 01:38:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:38:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:15 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)) 01:38:15 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)) 01:38:15 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)) 01:38:15 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)) 01:38:15 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)) 01:38:15 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)) 01:38:15 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)) 01:38:15 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)) 01:38:15 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)) 01:38:15 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)) 01:38:15 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)) 01:38:15 INFO - Cleaning up... 01:38:15 INFO - Return code: 0 01:38:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:38:15 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:15 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:15 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 0x109256a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109266420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0d3597360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090f5e00>, '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 0x108f5edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090f0b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNduFWahUX/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IkjwyJLb6P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:38:15 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 01:38:15 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 01:38:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNduFWahUX/Render', 01:38:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:38:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:38:15 INFO - 'HOME': '/Users/cltbld', 01:38:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:38:15 INFO - 'LOGNAME': 'cltbld', 01:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:15 INFO - 'MOZ_NO_REMOTE': '1', 01:38:15 INFO - 'NO_EM_RESTART': '1', 01:38:15 INFO - 'PAGER': '/bin/cat', 01:38:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:15 INFO - 'PWD': '/builds/slave/test', 01:38:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:38:15 INFO - 'SHELL': '/bin/bash', 01:38:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IkjwyJLb6P/Listeners', 01:38:15 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 01:38:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:38:15 INFO - 'USER': 'cltbld', 01:38:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:38:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:15 INFO - 'XPC_FLAGS': '0x0', 01:38:15 INFO - 'XPC_SERVICE_NAME': '0', 01:38:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:38:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:15 INFO - Downloading/unpacking jsonschema 01:38:15 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 01:38:15 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 01:38:15 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 01:38:15 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 01:38:15 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 01:38:15 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 01:38:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:38:17 INFO - Downloading/unpacking functools32 (from jsonschema) 01:38:17 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 01:38:17 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 01:38:17 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 01:38:17 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 01:38:17 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 01:38:17 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 01:38:18 INFO - Downloading functools32-3.2.3-2.tar.gz 01:38:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:38:18 INFO - warning: no files found matching '*.txt' 01:38:18 INFO - no previously-included directories found matching 'build' 01:38:18 INFO - no previously-included directories found matching 'dist' 01:38:18 INFO - no previously-included directories found matching '.git*' 01:38:18 INFO - Installing collected packages: jsonschema, functools32 01:38:18 INFO - Running setup.py install for functools32 01:38:18 INFO - warning: no files found matching '*.txt' 01:38:18 INFO - no previously-included directories found matching 'build' 01:38:18 INFO - no previously-included directories found matching 'dist' 01:38:18 INFO - no previously-included directories found matching '.git*' 01:38:18 INFO - Successfully installed jsonschema functools32 01:38:18 INFO - Cleaning up... 01:38:18 INFO - Return code: 0 01:38:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:38:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:19 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:19 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109256a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109266420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0d3597360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090f5e00>, '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 0x108f5edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090f0b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNduFWahUX/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IkjwyJLb6P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:38:19 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', 'flake8'] in /builds/slave/test/build 01:38:19 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 flake8 01:38:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNduFWahUX/Render', 01:38:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:38:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:38:19 INFO - 'HOME': '/Users/cltbld', 01:38:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:38:19 INFO - 'LOGNAME': 'cltbld', 01:38:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:19 INFO - 'MOZ_NO_REMOTE': '1', 01:38:19 INFO - 'NO_EM_RESTART': '1', 01:38:19 INFO - 'PAGER': '/bin/cat', 01:38:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:38:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:19 INFO - 'PWD': '/builds/slave/test', 01:38:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:38:19 INFO - 'SHELL': '/bin/bash', 01:38:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IkjwyJLb6P/Listeners', 01:38:19 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 01:38:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:38:19 INFO - 'USER': 'cltbld', 01:38:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:38:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:38:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:19 INFO - 'XPC_FLAGS': '0x0', 01:38:19 INFO - 'XPC_SERVICE_NAME': '0', 01:38:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:38:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:19 INFO - Downloading/unpacking flake8 01:38:19 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 01:38:19 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 01:38:19 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 01:38:19 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 01:38:19 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 01:38:19 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 01:38:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:38:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:38:22 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 01:38:22 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 01:38:22 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 01:38:22 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 01:38:22 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 01:38:22 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 01:38:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:38:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:38:22 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 01:38:22 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 01:38:22 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 01:38:22 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 01:38:22 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 01:38:22 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 01:38:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:38:23 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 01:38:23 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 01:38:23 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 01:38:23 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 01:38:23 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 01:38:23 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 01:38:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:38:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:38:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:38:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:38:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:38:23 INFO - no previously-included directories found matching 'docs/_build' 01:38:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:38:23 INFO - Running setup.py install for pep8 01:38:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:38:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:38:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:38:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:38:23 INFO - no previously-included directories found matching 'docs/_build' 01:38:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:38:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:38:23 INFO - Cleaning up... 01:38:24 INFO - Return code: 0 01:38:24 INFO - Running post-action listener: _resource_record_post_action 01:38:24 INFO - Running post-action listener: _start_resource_monitoring 01:38:24 INFO - Starting resource monitoring. 01:38:24 INFO - ##### 01:38:24 INFO - ##### Running install step. 01:38:24 INFO - ##### 01:38:24 INFO - Running pre-action listener: _resource_record_pre_action 01:38:24 INFO - Running main action method: install 01:38:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:38:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:38:24 INFO - Reading from file tmpfile_stdout 01:38:24 INFO - Detecting whether we're running mozinstall >=1.0... 01:38:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:38:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:38:24 INFO - Reading from file tmpfile_stdout 01:38:24 INFO - Output received: 01:38:24 INFO - Usage: mozinstall [options] installer 01:38:24 INFO - Options: 01:38:24 INFO - -h, --help show this help message and exit 01:38:24 INFO - -d DEST, --destination=DEST 01:38:24 INFO - Directory to install application into. [default: 01:38:24 INFO - "/builds/slave/test"] 01:38:24 INFO - --app=APP Application being installed. [default: firefox] 01:38:24 INFO - mkdir: /builds/slave/test/build/application 01:38:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:38:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 01:38:46 INFO - Reading from file tmpfile_stdout 01:38:46 INFO - Output received: 01:38:46 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 01:38:46 INFO - Running post-action listener: _resource_record_post_action 01:38:46 INFO - ##### 01:38:46 INFO - ##### Running run-tests step. 01:38:46 INFO - ##### 01:38:46 INFO - Running pre-action listener: _resource_record_pre_action 01:38:46 INFO - Running main action method: run_tests 01:38:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:38:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:38:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:38:46 INFO - 2016-06-07 01:38:46.162 screenresolution[1939:17536] starting screenresolution argv=screenresolution get 01:38:46 INFO - 2016-06-07 01:38:46.164 screenresolution[1939:17536] Display 0: 1600x1200x32@60 01:38:46 INFO - 2016-06-07 01:38:46.170 screenresolution[1940:17539] starting screenresolution argv=screenresolution list 01:38:46 INFO - Available Modes on Display 0 01:38:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:38:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:38:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:38:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:38:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:38:46 INFO - Intel Iris: 01:38:46 INFO - Chipset Model: Intel Iris 01:38:46 INFO - Type: GPU 01:38:46 INFO - Bus: Built-In 01:38:46 INFO - VRAM (Dynamic, Max): 1536 MB 01:38:46 INFO - Vendor: Intel (0x8086) 01:38:46 INFO - Device ID: 0x0a2e 01:38:46 INFO - Revision ID: 0x0009 01:38:46 INFO - Displays: 01:38:46 INFO - Display: 01:38:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:38:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:38:46 INFO - Display Serial Number: 1600x1200 60 01:38:46 INFO - Main Display: Yes 01:38:46 INFO - Mirror: Off 01:38:46 INFO - Online: Yes 01:38:46 INFO - Rotation: Supported 01:38:46 INFO - Return code: 0 01:38:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:38:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:38:46 INFO - Python 2.7.3 01:38:46 INFO - Return code: 0 01:38:46 INFO - grabbing minidump binary from tooltool 01:38:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:46 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090f5e00>, '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 0x108f5edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090f0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:38:46 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:38:46 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 01:38:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:38:46 INFO - Return code: 0 01:38:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:38:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:38:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:38:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:38:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:38:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:38:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:38:47 INFO - Return code: 0 01:38:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 01:38:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0040 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 01:38:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNduFWahUX/Render', 01:38:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:38:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:38:47 INFO - 'HOME': '/Users/cltbld', 01:38:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:38:47 INFO - 'LOGNAME': 'cltbld', 01:38:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:38:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:38:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:47 INFO - 'MOZ_NO_REMOTE': '1', 01:38:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:38:47 INFO - 'NO_EM_RESTART': '1', 01:38:47 INFO - 'PAGER': '/bin/cat', 01:38:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:38:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:47 INFO - 'PWD': '/builds/slave/test', 01:38:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:38:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:38:47 INFO - 'SHELL': '/bin/bash', 01:38:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IkjwyJLb6P/Listeners', 01:38:47 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 01:38:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:38:47 INFO - 'USER': 'cltbld', 01:38:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:38:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:38:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:47 INFO - 'XPC_FLAGS': '0x0', 01:38:47 INFO - 'XPC_SERVICE_NAME': '0', 01:38:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:38:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 01:38:47 INFO - mozversion application_buildid: 20160606120332 01:38:47 INFO - mozversion application_changeset: 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 01:38:47 INFO - mozversion application_display_name: Firefox 01:38:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:38:47 INFO - mozversion application_name: Firefox 01:38:47 INFO - mozversion application_remotingname: firefox 01:38:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 01:38:47 INFO - mozversion application_vendor: Mozilla 01:38:47 INFO - mozversion application_version: 48.0 01:38:47 INFO - mozversion platform_buildid: 20160606120332 01:38:47 INFO - mozversion platform_changeset: 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 01:38:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 01:38:47 INFO - mozversion platform_version: 48.0 01:38:47 INFO - using testdate: 1465288727 01:38:47 INFO - actual date: 1465288727 01:38:47 INFO - starting webserver on 'localhost:53224' 01:38:47 INFO - SUITE-START | Running 2 tests 01:38:47 INFO - TEST-START | dromaeo_css 01:38:47 INFO - operating with platform_type : mac_ 01:38:47 INFO - Initialising browser for dromaeo_css test... 01:38:47 INFO - TEST-INFO | started process 1958 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/tmpY9eoUn/profile http://localhost:53224/getInfo.html) 01:38:50 INFO - PROCESS | 1958 | __metrics Screen width/height:1600/1200 01:38:50 INFO - PROCESS | 1958 | colorDepth:24 01:38:50 INFO - PROCESS | 1958 | Browser inner width/height: 1024/689 01:38:50 INFO - PROCESS | 1958 | __metrics 01:38:50 ERROR - PROCESS | 1958 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 01:38:51 INFO - TEST-INFO | 1958: exit 0 01:38:51 INFO - Browser initialized. 01:38:51 INFO - Running cycle 1/1 for dromaeo_css test... 01:38:51 INFO - TEST-INFO | started process 1962 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/tmpY9eoUn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:39:03 INFO - PROCESS | 1962 | RSS: Main: 170971136 01:39:03 INFO - PROCESS | 1962 | 01:39:52 INFO - PROCESS | 1962 | 1465288792727 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:42:03 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:53224/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53224/tests/dromaeo/cssquery-ext.html) 01:42:04 INFO - PROCESS | 1962 | RSS: Main: 181800960 01:42:04 INFO - PROCESS | 1962 | 01:45:06 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:53224/tests/dromaeo/cssquery-ext.html (next: http://localhost:53224/tests/dromaeo/cssquery-jquery.html) 01:45:07 INFO - PROCESS | 1962 | RSS: Main: 192540672 01:45:07 INFO - PROCESS | 1962 | 01:48:09 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:53224/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53224/tests/dromaeo/cssquery-mootools.html) 01:48:09 INFO - PROCESS | 1962 | RSS: Main: 194736128 01:48:09 INFO - PROCESS | 1962 | 01:51:11 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:53224/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53224/tests/dromaeo/cssquery-prototype.html) 01:51:11 INFO - PROCESS | 1962 | RSS: Main: 198316032 01:51:11 INFO - PROCESS | 1962 | 01:54:14 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:53224/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53224/tests/dromaeo/cssquery-yui.html) 01:54:15 INFO - PROCESS | 1962 | RSS: Main: 198115328 01:54:15 INFO - PROCESS | 1962 | 01:57:17 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:53224/tests/dromaeo/cssquery-yui.html (next: http://localhost:53224/tests/dromaeo/cssquery-dojo.html) 01:57:17 INFO - PROCESS | 1962 | RSS: Main: 202403840 01:57:17 INFO - PROCESS | 1962 | 01:57:17 INFO - PROCESS | 1962 | __start_tp_report 01:57:17 INFO - PROCESS | 1962 | _x_x_mozilla_page_load 01:57:17 INFO - PROCESS | 1962 | _x_x_mozilla_page_load_details 01:57:17 INFO - PROCESS | 1962 | |i|pagename|runs| 01:57:17 INFO - PROCESS | 1962 | |0;dojo.html;3023.410434965182;3616.2767446510707;3633.636636336368;3664.395374763164;3683.852645894164;5934.910976335353;5967.254093238345;5988.341282458931;6018.6689732064715;6065.27216733992;5948.7620495180245;5966.8806623867495;5973.342932277446;6014.007688731354;6019.097135429688;5350.35795704515;5366.356037275533;5380;5456.127019676853;5554.361248456439;5337.973310133444;5384.488473595002;5438.238646589481;5484.204790305404;5537.197106419567;5337.226102215176;5446.7276636168235;5488.231647569323;5498.780048798043;5503.449655034485;3720.218754061637;5167.819126330579;5381.623286369956;5456.48163424474;5467.125259958388;4426.62373698236;5196.090684130262;5342.385625653022;5343.412224655285;5353.705546194958;5705.71471426427;5808.477237048686;5854.882902341929;5856.1508581255475;5984.910226346608;6243.250809902841;6243.282022567418;6288.528360372945;6295.811125666238;6296.464800491964;6180.134781130645;6267.780627678009;6343.302236754;6376.808695739135;6407.551471397004;5999.190109335227;6086.2087928569445;6098.237720285008;6100.145979562864;6101.267847858286;6283.340249273851;6492.513061520405;6501.577397469244;6505.577137486048;6514.869702606016;5936.910946335808;6158.7228574714245;6191.9690401547705;6219.533534984895;6220.657863817443;6306.243250809932;6328.493720502349;6363.427291543783;6390.329015453403;6399.712012959428;6132.325444201134;6205.6586887720705;6281.309056003836;6286.748530058747;6290.654014029273;6218.595791273553;6273.1844860167885;6283.654399008098;6293.370662933761;6298.149749783812;5047.848564543069;5065.442801291929;5094.388673359221;5103;5123.975204959023;4484.932726009112;4504;4534.251848445036;4570.200214962369;4574.130915126116;5965.224520812353;6019.939800602026;6089.451949324582;6091.695415229221;6105.908411373833;6292.874142517124;6332.145160403379;6381.074744162163;6383.521235907326;6387.680615969183;5934.080217566284;6012.488938440281;6067.605605635619;6114.510839132859;6116.755329786759;5503.477169668875;5559.138333558305;5579.581531385163;5590.105583106683;5594.496495315441;6549.083128362033;6550.443212327005;6557.409833115043;6565.343465653492;6567.770128045591;6217.222847144107;6247.250329960252;6321.810345689637;6339.366063393623;6361.904571431525;5813.491274794299;6221.69344437655;6614.305497922649;6615.17310336208;6653.268140504638;5098.617603679813;6259.78090766821;6267;6279.529035322461;6284.780032698834;6185.8144255672405;6231.657258850807;6271.78048768291;6322.841928951813;6346.428821405911;5100.974495127501;5126.231065340229;5453.182022696627;6152.507799376129;6207.596506227081;6126.632402055891;6252.906206406817;6263.718132683949;6267.341929097562;6272.341404152498;4999.175136102503;6128.930927367261;6131.407250743203;6225.750969961332;6236.314005459305;6182.969085154546;6269.686515674107;6270;6281.780137695158;6285.465735412358;4940.901181976268;6124.228368151265;6257.186565746424;6277.497800175884;6280.403361680633 01:57:17 INFO - PROCESS | 1962 | |1;ext.html;530.3688610553442;532.8294945617404;561.3908908833915;566.4562020460357;603.0833133636874;32908.17729556759;39638.60361396385;39691.20617587647;39770;40037;40702.59297407025;40873.18253634925;41447.79276103615;41514.58485415145;41567;9610.519474026289;9788.216942644607;9823.263255255884;9839.803203935917;9846.704598862045;9743.805123897519;9948.502574871227;9984.201263898907;9993.650222242222;10015.19878409729;8358.122397148303;9011;9568.23454123672;9964.750881227956;9995.650152244672;9833.606655733762;9906.653267135616;9910.90089099107;9943.502824858728;9953.452560109192;9739.90260097397;9809.264305177068;9846.212303015813;9869.654562090293;9891.752706182331;39330.41004384936;39352;39683.80948571547;39806.40290395646;39956.80021599903;2562.7565381288746;3211.678832116793;3218.6459489456142;3237.125975986494;3401.0817079388426;29481;29582;29703.25741856449;30332;31447.52828707571;2804.1307194769483;2804.775617950559;2825.70330115337;2856.5001124803075;2875.856207189632;442023.78988105175;442481;444571.77714111545;447744.76127619477;448732;52348.47651523436;64685.67657161684;65137.67431162909;65147.67426162839;65246;67234.66382668153;70730;71958.56082878313;72171;72235.63882180555;18211;18357.908210458863;18397;18403.81596184048;18485.89084654925;11998.940005300092;14006.929965350311;14217.64455888611;14266.215358155401;14272.35774390155;17681.646367072586;19345.613087738166;19668.409947701304;20093.698594521094;20142.19431222764;7433.219511951275;8354.373421993374;8450.239478446969;8463.703770368007;8491.532965686947;956.168133723651;1056.0706578211125;1059.6344261229863;1068.2308737708838;1143.1997601678859;30140.888559092;30164.095077147722;30274.84862575673;30647.38705225883;30808.383832323227;1099.6975831646362;1100.9449527523752;1103.6688993301977;1147.2485521983115;1154.3074155506797;14390.568282951528;14481.637959051108;14651.853481465261;14724.484643037442;15032.62418439526;525378;573628;584932;624622;625196;58467.415325846196;59056.704716476146;59077;59223.815523689285;59472.70263648654;1527.3279756906925;1552.3169805285863;1561.2271925397001;1564.7261729197344;1572.0646215501758;25979.870100649376;28575.857120715096;28759;29450;29692;51754.74122629363;51948.96102077862;52481.21278180907;52750.47249527609;52754.681132971986;576601;579537;579801;582167;582301;25909.056895562746;26850.865745671148;26989.86505067462;27020.72979270261;27393.86303068472;44743.55256447524;45826.54173458223;46273.3059004122;46715.766421167675;46953.06093878172;37278.8136059318;37865.81067094757;38033;38636.420453693776;38804;36374.27251454903;36870.07824804401;36885.81557092197;37198.44202336913;37609.623903760614;37070.25859482741;37421.4386784193;37596.62403375931;37868;38162;26847.865760671073;31825;32807.34385312328;33076.1730956728;33249;24891.62662560099;24893.626595601443;25168.265752617925;25412.110576130486;25615.743842561336 01:57:17 INFO - PROCESS | 1962 | |2;jquery.html;413.7806962309975;416.4232537934959;421.7553818785104;422.9577042295771;427.7305297662473;20759.896200518975;20904.37286881394;21616.89191554044;22188.55622887545;22826.65760013601;21264.57470850582;21396.679049814265;21436.14255429781;21566.460838479044;21727.45681357963;5620.550355971523;6149.600275982069;6149.754009839612;6149.938500614981;6161.075838624198;4477.149341625097;5993.730282137292;6150.354212807658;6484.967575162118;6762.797116086525;5737.913931291013;6649;6694.062831203635;6710.798676039727;6740.258571557125;6441.645709485976;6576.53964222507;6584.473242140617;6585.9012114818315;6612.603243805387;5682.119271512922;5765;5770.913436298459;5778.682172480512;5793.913091303634;13034.348282585928;13645.317734113254;24883.755812209318;26035.349116272057;26043.869780650977;2283.25794116911;2343.5312937412587;2390.6653068570413;2531.5949448088218;2557.450148218142;9871.111599955966;9889.20886329099;10147.441890696009;10212.540435680412;10333.121684656813;1618.732909070002;1772.3176577017812;1787.731840223964;1816.1917946513806;1901.4390754727388;111864.60949647175;123793;124662.75337246602;125961.11058334132;126856.73143268541;11857.644270671894;11996.40017999114;12041.397930103634;12062.87937120635;12127.272363658209;15222.695546089017;15289.617759555878;15551.22243887801;15556.14441205722;15615;8839.46963182211;9194.90805091954;9286.303527235485;9297.953510232406;9353.953230233805;7007.509474336849;7782.221777822172;7805.102413222438;9337.159655631025;9385.249180065579;3587.7488575799443;4645.907081858344;4725.787339569728;4751.52484751529;4754.191787396151;1874.3720853513953;2000.5398758285385;2036.7861374555755;2094.7591027032086;2116.978830211678;880.9515476648718;932.5989824375448;1029.2332212501585;1040.5837664933936;1089.5587287148717;19928.800711992986;20553.177872884917;20569.794302057086;20702.585948281252;20739.8963005184;1001.8998100190068;1006.6778630838207;1019.2712210769188;1029.361795686679;1039.2673165418362;11051.834222486668;11419.086473082134;11507.712307192387;11507.942460287644;11539.942300288445;554434.2278288583;643507;643915;648713;657224;135623;139305;139499;140841;147451;1074.6023971130733;1078.2021304234966;1117.6032508459543;1127.4531852051748;1138.174823253135;18230.270789168284;18788;18818.341358052403;18933.148008339384;19103.904480478064;49424.139205481166;54496;55282.72358638181;56349.154762677776;56499.15251271152;76968.46063078595;81259.18740812753;81591.77612335938;82465;82825;8295.460795048302;8328.958880139982;8429.873551896604;8623.353248506513;8822.735317940473;11278;13171.802422963472;13308.866911330762;13470.79793803074;13629.25039122818;10865.674029779118;11276.492557834754;11513.654590362303;11842.993345565379;11994.700132496757;9976.60093596277;11262.267952583055;11336.546538138382;11343.659690209306;11573.826392603949;10929.344239345664;11634.069274458192;11679.357635329798;11852.76294474123;11936.761264774483;7238.348548630438;8371.16288371158;8388.748337549883;8426.620802064044;8455.28130108923;8633.30933525329;11246.156538259827;11533.942330288295;11627.709307267385;11851.762964740828 01:57:17 INFO - PROCESS | 1962 | |3;mootools.html;1449.4854326714017;1668.1909274002107;1772.6100257943249;1961.7547806524185;2044.2027609232393;8180.836383272331;8280.171982801718;9026.052264512222;9088.591013404397;9250.86123708144;7857.960710196456;8884.64461421544;9020.684276050339;9048.72853814385;9050.275977921767;2534.51844149611;2544.6437498750142;2556.75710807473;2563.3207200091897;2565.9358516037155;2488;2522.419843436011;2528.4184637533376;2533.809964252679;2535.9239222823344;2512.258883629334;2535.3154648244963;2551.4897020595863;2552.0557393764334;2566.9614955775587;2501.537215615117;2515.383730985902;2515.421453065787;2518.2193520008764;2538.9873050634815;2510.1716433576876;2532.6074458458784;2533.3539947313316;2544.6310285008753;2552.8978840846344;8713.738587842312;8762.079981601904;8820.735377938672;8830.911690883073;8835.425697329718;5675.858103547403;5677;5731.025725626611;5815.069588865761;5848.356680765112;3650.2881938022097;3737.5514938207316;3784.7539909906045;3797.373433383488;3802.543694756647;920.4385324951774;1044.738815296176;1071.9142468602572;1073.1146803886747;1073.1843798712957;9727.65953191635;12137.271763694207;12455.065870059781;12462.501499939992;12474;4935.802567897315;5032.496750325012;5044.344235249468;5101.413337466165;5120.308758317579;10301.793964120676;10321.535530901128;10516.053555179917;10534.894651053544;10541.31481453703;5563.666180029211;5718.571107166979;5747.994101032303;5752;5764.221830052973;4596.747178905125;5037.79848806051;5160.071187186342;5167.199084141964;5173.844784656466;4191.685623578243;4199.874003779892;4269.018125831076;4298.26929421999;4308.633766129851;1375.2367436073075;1401.089291960234;1402.2287741742;1406.0579411793917;1415.7239338329132;769.4959801330137;919.1360121485782;965.2471072563412;991.4893829677721;1002.0981116994617;5053.393592768818;5818.5636077294375;5891.41085891416;6045.123457098696;6106.419890110433;468.85465505693344;479.38399157083677;481.86748644123145;483.74119845882285;490.225443798797;3691.837071322525;3958.802059896994;4004.439378487014;4028.8388464461677;4036.2734707752297;10096.040876116756;10812.243142979916;10964.451777411097;11005.724856878482;11048.005679488884;10611.363318200933;10867.076298514714;10870.456477176109;10884.129269658408;10930.945345273381;8107.878381824277;8476.618552165044;8621.741347759576;8653.6538538459;8687.653413720884;6007.759689612367;6030.879382412415;6059.6364218147055;6090;6095.4761309672585;9352;9548.57031433601;9579.233661307218;9597.136257736836;9751.268654851056;9638.518074096408;9737.464439455898;9768.56041478121;9818.31271810995;9839.5080245986;5919.6152250103605;7305.086864141982;7471.701131954661;7675.61621918913;7811.843763124592;8205;8209.096999330188;8241.79395515117;8286.337093032422;8293.129221431664;7248.565086094851;7327.487075904635;7354.485186036926;7444.330010299099;7521.736739214101;7275.272472752682;7355;7505.512141710771;7564.357029652541;7653.6555854985545;7172.49792514519;7191.3887319578425;7200;7220.3140701633265;7244.818879528054;4948.307236986897;5002.6498145130945;5042.974785126051;5059.392872855281;5116.897662046813;4963.503649635008;5004.499550044967;5032.521910418504;5096.643234973516;5248.921266181087 01:57:17 INFO - PROCESS | 1962 | |4;prototype.html;326.5330577274498;333.8831608270336;343.74219335498384;344.4282491064831;346.6550781971935;5544.916826247604;6760.763373281936;6819.386255237027;6971.930280697192;6981.650917454126;6815.897761533581;6959.686814093366;6962.96518517408;6968.372846443832;6975.9536069589585;5048.6465947383695;5056.595472362203;5059.180318859256;5083.389993200821;5098.617603679721;4343.913121737563;5096.643234973553;5097.649122982412;5101.464346243647;5104.464031276718;4803.18345881201;5023.296738456619;5030.06943715412;5031.069252188357;5053.216751403538;4869.196582563855;5007.774650140753;5029.371328583927;5033.823816166453;5043.470435604264;4231.767252801094;4236.766977816219;4275.593818587229;4281.422008028907;4297.05464797744;6584.242812076624;6592.5714828536475;6601.70292336846;6615.636140012298;6631.171103612049;4938.432080310774;5899.820035992819;5958.046712526018;5972.581919265654;6000.36996115406;7327.450441216877;7337.559746415232;7360.07999000125;7364.263573642593;7384.852302953965;4517.774111294455;4733.95266047342;4738.8341408050555;4801.447833499157;4809.615230781564;7711.691532338699;7765.378769698411;7817.68729250835;7819.452638315321;7827.021622297213;4790.5448982346625;4797.136515427187;4810.965642386904;4812.422509298906;4819.662623616383;4883.145449546315;4885.780139893714;4890.657653964188;4898.853034408973;4924.975375123101;4946.4064312282035;5884.94071067212;5885.529157667376;5886.646801191942;5932.495737862244;5674.574406919498;6837.589744615339;7362.631868406558;7443.106827180773;7455.4408419368765;1439.9856001440062;1666.5833541614597;1676.2289346900561;1693.0857337038108;1699.4731633193749;994.0953732103751;1039.8076355874186;1047.7642530430744;1060.3213943076437;1065.5790962569743;5730.570207234391;5935.82192534216;6847.383735463832;6908.965455172692;7052.541584796972;7800.219978002267;7801.258880406353;7812.960935195288;7824.295813376823;7832;7004.15950085993;7035.964820175866;7041.119860017498;7046.753363632249;7079.1858936223;2954.6897575754665;3962.870581884149;4074.083331250504;4117.958820411817;4141.337386018223;6997.685104170325;7686.423518236154;8133.511989280662;8136.308413784895;8150.796230094295;7983.441159118806;8003.439759216799;8011.118776934532;8030.23712747288;8055.429191307756;8111.310538604167;8129.4715843469985;8132.512049276944;8150.021997360236;8177.345812334999;7456.440766942609;7770;7771.572563508835;7779.416543759127;7785.532868027936;7622.31399174077;7632.274933881273;7684.6926122954455;7689.577073260801;7693.615319233904;6539.346065393613;8124.22819832115;8124.350051995708;8145.674173033012;8160.632771525415;3985.342418501031;4079.775612341231;4671.486136524912;4769.332293478985;4770.165221086366;7372.59450730215;7755.612219388895;7775.105862825621;7778.338841198562;7810.531368117931;5967.582269241285;7484.288992545699;7484.700611975678;7488.850222995618;7533.096028476618;5987.880242395215;7491.175970643334;7509.7371591994015;7514.47398682087;7543.73596924105;7274.599897005503;7305;7337.706491740484;7338.486305958531;7356.66894989716;5749.281339832521;7409.851802963803;7436.665350059368;7453.627318633939;7472.775816725507;5929.347771745019;7029.683664235019;7167.211606723361;7325.7802265932105;7421.888671669822 01:57:17 INFO - PROCESS | 1962 | |5;yui.html;714.6998260730493;729.3618084176346;757.2398607077207;788.1842293226512;788.8580055589995;15375.846241537582;15379;15495.84504154958;15907.363705451782;15934.601634959132;14528.564143075699;14574.344154513046;14592.41630334788;14600.780988285183;14674.192919389428;778.1129512355891;934.3926447808927;940.2055263302499;962.7208109648194;965.8696076029752;955.7085089047838;965.8647789309503;967.6661551764665;968.7723385004518;971.2327261463436;982.2731178927578;1009.8535712321709;1014.2342531388828;1016.6797458800454;1018.6689325969089;1014.3812274512542;1015.2943704125636;1017.2523195451338;1019.3119644240182;1020.6784862768242;748.7379417203989;758.1963119093723;760.7831767946165;761.8704820180583;762.2758379539405;15308.693826123526;15448.995815271972;15459.458918937895;15477.148756818371;15528.456504022304;12883.162594431426;13019.349032548334;13052.21686698801;13127.146735462164;13304.534341298106;10023.298369114165;10095.697129086138;10501.894981050245;10586.735331616694;10817.972292632187;3558.1104723819044;3567.8751243706347;3589.6769290763955;3591.6408359163875;3691.6123807000145;86191;86842.13157868404;87219.56390218071;87288.56355718244;87301.69047464294;9776.462294573725;9780.217582593375;9827.705168844946;9874.506274686237;9987.900120998842;21686.24098156557;21992.560148797256;22620.208292709674;23227.95474203665;23307.650385244237;7655.1962043985695;7713.730019449293;7852.882206766903;7949.7217597383815;8101.6354264058255;4152.397902304149;4178.206140833232;4199.181159673895;4213.641840443596;4460.576245256695;3734.9439758403646;3802.6767724743154;3803.8098095095133;3812.5424949006297;3813.389857622767;678.0642713055951;690.858374033322;692.8129405060605;694.5589550635282;694.6804469943883;603.9879202416015;610.7129649064932;621.1366200980641;622.4895585619839;622.9003359462464;8315.459495132796;8412.369072319601;8427.620757065946;8636.318555985297;8674.956625216833;546.9042917489423;555.7721334252936;621.2048577820398;628.3465196195997;629.1003864473755;3402.8298585070647;3921.568627450978;3971.7219794614675;4002.519697636244;4041.1715598302276;67526;67703;67738.66130669315;68008.6599567009;68028;79252;79775.60112199401;80029.99999999884;80995.59502202451;81080.59459702663;68504.3149568508;69253.6867277796;69863;70305.2969470309;72800.54398911992;7066.717331306896;7837.921620783947;7851.84296314082;8071.717489887826;8296.626651800803;50921.23618145657;51677.22484162665;51736.48263517317;51798;52717.20924186063;59360.40639593549;69100.61798763897;69673;70527;70801.6459917697;10051.706103104636;10090.899091008996;10184.083432490816;10324.277300589187;10388;10869.076128529163;10902.18233632465;11011.787279332051;11060.889391105986;11291.491882865126;8978.416402933788;10022.047905448972;10096.848547271944;10122.44326562046;10266.178705703674;10360.637377692046;10458.424786636808;10464.947675261576;10610.098141658045;10837.891621083689;10395.688129356131;10474.109700675528;10499.842502362319;10688.89311106879;10834;8563;8711.346649001223;8720.302375809793;8939.553022348986;8974.93397119644;8730.126987301219;9104.180623743894;9145.496997665192;9187.173154416134;9198.448093114435 01:57:17 INFO - PROCESS | 1962 | __end_tp_report 01:57:17 INFO - PROCESS | 1962 | __start_cc_report 01:57:17 INFO - PROCESS | 1962 | _x_x_mozilla_cycle_collect,394 01:57:17 INFO - PROCESS | 1962 | __end_cc_report 01:57:17 INFO - PROCESS | 1962 | __startTimestamp1465289837484__endTimestamp 01:57:17 INFO - PROCESS | 1962 | 01:57:17 INFO - PROCESS | 1962 | ------- Summary: start ------- 01:57:17 INFO - PROCESS | 1962 | Number of tests: 6 01:57:17 INFO - PROCESS | 1962 | 01:57:17 INFO - PROCESS | 1962 | [#0] dojo.html Cycles:165 Average:5854.16 Median:6116.76 stddev:670.26 (11.0%) stddev-sans-first:634.46 01:57:17 INFO - PROCESS | 1962 | Values: 3023.4 3616.3 3633.6 3664.4 3683.9 5934.9 5967.3 5988.3 6018.7 6065.3 5948.8 5966.9 5973.3 6014.0 6019.1 5350.4 5366.4 5380.0 5456.1 5554.4 5338.0 5384.5 5438.2 5484.2 5537.2 5337.2 5446.7 5488.2 5498.8 5503.4 3720.2 5167.8 5381.6 5456.5 5467.1 4426.6 5196.1 5342.4 5343.4 5353.7 5705.7 5808.5 5854.9 5856.2 5984.9 6243.3 6243.3 6288.5 6295.8 6296.5 6180.1 6267.8 6343.3 6376.8 6407.6 5999.2 6086.2 6098.2 6100.1 6101.3 6283.3 6492.5 6501.6 6505.6 6514.9 5936.9 6158.7 6192.0 6219.5 6220.7 6306.2 6328.5 6363.4 6390.3 6399.7 6132.3 6205.7 6281.3 6286.7 6290.7 6218.6 6273.2 6283.7 6293.4 6298.1 5047.8 5065.4 5094.4 5103.0 5124.0 4484.9 4504.0 4534.3 4570.2 4574.1 5965.2 6019.9 6089.5 6091.7 6105.9 6292.9 6332.1 6381.1 6383.5 6387.7 5934.1 6012.5 6067.6 6114.5 6116.8 5503.5 5559.1 5579.6 5590.1 5594.5 6549.1 6550.4 6557.4 6565.3 6567.8 6217.2 6247.3 6321.8 6339.4 6361.9 5813.5 6221.7 6614.3 6615.2 6653.3 5098.6 6259.8 6267.0 6279.5 6284.8 6185.8 6231.7 6271.8 6322.8 6346.4 5101.0 5126.2 5453.2 6152.5 6207.6 6126.6 6252.9 6263.7 6267.3 6272.3 4999.2 6128.9 6131.4 6225.8 6236.3 6183.0 6269.7 6270.0 6281.8 6285.5 4940.9 6124.2 6257.2 6277.5 6280.4 01:57:17 INFO - PROCESS | 1962 | 01:57:17 INFO - PROCESS | 1962 | [#1] ext.html Cycles:180 Average:67802.97 Median:39067.21 stddev:144524.82 (369.9%) stddev-sans-first:144841.99 01:57:17 INFO - PROCESS | 1962 | Values: 530.4 532.8 561.4 566.5 603.1 32908.2 39638.6 39691.2 39770.0 40037.0 40702.6 40873.2 41447.8 41514.6 41567.0 9610.5 9788.2 9823.3 9839.8 9846.7 9743.8 9948.5 9984.2 9993.7 10015.2 8358.1 9011.0 9568.2 9964.8 9995.7 9833.6 9906.7 9910.9 9943.5 9953.5 9739.9 9809.3 9846.2 9869.7 9891.8 39330.4 39352.0 39683.8 39806.4 39956.8 2562.8 3211.7 3218.6 3237.1 3401.1 29481.0 29582.0 29703.3 30332.0 31447.5 2804.1 2804.8 2825.7 2856.5 2875.9 442023.8 442481.0 444571.8 447744.8 448732.0 52348.5 64685.7 65137.7 65147.7 65246.0 67234.7 70730.0 71958.6 72171.0 72235.6 18211.0 18357.9 18397.0 18403.8 18485.9 11998.9 14006.9 14217.6 14266.2 14272.4 17681.6 19345.6 19668.4 20093.7 20142.2 7433.2 8354.4 8450.2 8463.7 8491.5 956.2 1056.1 1059.6 1068.2 1143.2 30140.9 30164.1 30274.8 30647.4 30808.4 1099.7 1100.9 1103.7 1147.2 1154.3 14390.6 14481.6 14651.9 14724.5 15032.6 525378.0 573628.0 584932.0 624622.0 625196.0 58467.4 59056.7 59077.0 59223.8 59472.7 1527.3 1552.3 1561.2 1564.7 1572.1 25979.9 28575.9 28759.0 29450.0 29692.0 51754.7 51949.0 52481.2 52750.5 52754.7 576601.0 579537.0 579801.0 582167.0 582301.0 25909.1 26850.9 26989.9 27020.7 27393.9 44743.6 45826.5 46273.3 46715.8 46953.1 37278.8 37865.8 38033.0 38636.4 38804.0 36374.3 36870.1 36885.8 37198.4 37609.6 37070.3 37421.4 37596.6 37868.0 38162.0 26847.9 31825.0 32807.3 33076.2 33249.0 24891.6 24893.6 25168.3 25412.1 25615.7 01:57:17 INFO - PROCESS | 1962 | 01:57:17 INFO - PROCESS | 1962 | [#2] jquery.html Cycles:180 Average:36601.52 Median:21501.30 stddev:105426.92 (490.3%) stddev-sans-first:105687.66 01:57:17 INFO - PROCESS | 1962 | Values: 413.8 416.4 421.8 423.0 427.7 20759.9 20904.4 21616.9 22188.6 22826.7 21264.6 21396.7 21436.1 21566.5 21727.5 5620.6 6149.6 6149.8 6149.9 6161.1 4477.1 5993.7 6150.4 6485.0 6762.8 5737.9 6649.0 6694.1 6710.8 6740.3 6441.6 6576.5 6584.5 6585.9 6612.6 5682.1 5765.0 5770.9 5778.7 5793.9 13034.3 13645.3 24883.8 26035.3 26043.9 2283.3 2343.5 2390.7 2531.6 2557.5 9871.1 9889.2 10147.4 10212.5 10333.1 1618.7 1772.3 1787.7 1816.2 1901.4 111864.6 123793.0 124662.8 125961.1 126856.7 11857.6 11996.4 12041.4 12062.9 12127.3 15222.7 15289.6 15551.2 15556.1 15615.0 8839.5 9194.9 9286.3 9298.0 9354.0 7007.5 7782.2 7805.1 9337.2 9385.2 3587.7 4645.9 4725.8 4751.5 4754.2 1874.4 2000.5 2036.8 2094.8 2117.0 881.0 932.6 1029.2 1040.6 1089.6 19928.8 20553.2 20569.8 20702.6 20739.9 1001.9 1006.7 1019.3 1029.4 1039.3 11051.8 11419.1 11507.7 11507.9 11539.9 554434.2 643507.0 643915.0 648713.0 657224.0 135623.0 139305.0 139499.0 140841.0 147451.0 1074.6 1078.2 1117.6 1127.5 1138.2 18230.3 18788.0 18818.3 18933.1 19103.9 49424.1 54496.0 55282.7 56349.2 56499.2 76968.5 81259.2 81591.8 82465.0 82825.0 8295.5 8329.0 8429.9 8623.4 8822.7 11278.0 13171.8 13308.9 13470.8 13629.3 10865.7 11276.5 11513.7 11843.0 11994.7 9976.6 11262.3 11336.5 11343.7 11573.8 10929.3 11634.1 11679.4 11852.8 11936.8 7238.3 8371.2 8388.7 8426.6 8455.3 8633.3 11246.2 11533.9 11627.7 11851.8 01:57:17 INFO - PROCESS | 1962 | 01:57:17 INFO - PROCESS | 1962 | [#3] mootools.html Cycles:180 Average:5815.09 Median:5056.39 stddev:3197.26 (63.2%) stddev-sans-first:3189.39 01:57:17 INFO - PROCESS | 1962 | Values: 1449.5 1668.2 1772.6 1961.8 2044.2 8180.8 8280.2 9026.1 9088.6 9250.9 7858.0 8884.6 9020.7 9048.7 9050.3 2534.5 2544.6 2556.8 2563.3 2565.9 2488.0 2522.4 2528.4 2533.8 2535.9 2512.3 2535.3 2551.5 2552.1 2567.0 2501.5 2515.4 2515.4 2518.2 2539.0 2510.2 2532.6 2533.4 2544.6 2552.9 8713.7 8762.1 8820.7 8830.9 8835.4 5675.9 5677.0 5731.0 5815.1 5848.4 3650.3 3737.6 3784.8 3797.4 3802.5 920.4 1044.7 1071.9 1073.1 1073.2 9727.7 12137.3 12455.1 12462.5 12474.0 4935.8 5032.5 5044.3 5101.4 5120.3 10301.8 10321.5 10516.1 10534.9 10541.3 5563.7 5718.6 5748.0 5752.0 5764.2 4596.7 5037.8 5160.1 5167.2 5173.8 4191.7 4199.9 4269.0 4298.3 4308.6 1375.2 1401.1 1402.2 1406.1 1415.7 769.5 919.1 965.2 991.5 1002.1 5053.4 5818.6 5891.4 6045.1 6106.4 468.9 479.4 481.9 483.7 490.2 3691.8 3958.8 4004.4 4028.8 4036.3 10096.0 10812.2 10964.5 11005.7 11048.0 10611.4 10867.1 10870.5 10884.1 10930.9 8107.9 8476.6 8621.7 8653.7 8687.7 6007.8 6030.9 6059.6 6090.0 6095.5 9352.0 9548.6 9579.2 9597.1 9751.3 9638.5 9737.5 9768.6 9818.3 9839.5 5919.6 7305.1 7471.7 7675.6 7811.8 8205.0 8209.1 8241.8 8286.3 8293.1 7248.6 7327.5 7354.5 7444.3 7521.7 7275.3 7355.0 7505.5 7564.4 7653.7 7172.5 7191.4 7200.0 7220.3 7244.8 4948.3 5002.6 5043.0 5059.4 5116.9 4963.5 5004.5 5032.5 5096.6 5248.9 01:57:17 INFO - PROCESS | 1962 | 01:57:17 INFO - PROCESS | 1962 | [#4] prototype.html Cycles:180 Average:5993.15 Median:6828.49 stddev:1984.33 (29.1%) stddev-sans-first:1943.78 01:57:17 INFO - PROCESS | 1962 | Values: 326.5 333.9 343.7 344.4 346.7 5544.9 6760.8 6819.4 6971.9 6981.7 6815.9 6959.7 6963.0 6968.4 6976.0 5048.6 5056.6 5059.2 5083.4 5098.6 4343.9 5096.6 5097.6 5101.5 5104.5 4803.2 5023.3 5030.1 5031.1 5053.2 4869.2 5007.8 5029.4 5033.8 5043.5 4231.8 4236.8 4275.6 4281.4 4297.1 6584.2 6592.6 6601.7 6615.6 6631.2 4938.4 5899.8 5958.0 5972.6 6000.4 7327.5 7337.6 7360.1 7364.3 7384.9 4517.8 4734.0 4738.8 4801.4 4809.6 7711.7 7765.4 7817.7 7819.5 7827.0 4790.5 4797.1 4811.0 4812.4 4819.7 4883.1 4885.8 4890.7 4898.9 4925.0 4946.4 5884.9 5885.5 5886.6 5932.5 5674.6 6837.6 7362.6 7443.1 7455.4 1440.0 1666.6 1676.2 1693.1 1699.5 994.1 1039.8 1047.8 1060.3 1065.6 5730.6 5935.8 6847.4 6909.0 7052.5 7800.2 7801.3 7813.0 7824.3 7832.0 7004.2 7036.0 7041.1 7046.8 7079.2 2954.7 3962.9 4074.1 4118.0 4141.3 6997.7 7686.4 8133.5 8136.3 8150.8 7983.4 8003.4 8011.1 8030.2 8055.4 8111.3 8129.5 8132.5 8150.0 8177.3 7456.4 7770.0 7771.6 7779.4 7785.5 7622.3 7632.3 7684.7 7689.6 7693.6 6539.3 8124.2 8124.4 8145.7 8160.6 3985.3 4079.8 4671.5 4769.3 4770.2 7372.6 7755.6 7775.1 7778.3 7810.5 5967.6 7484.3 7484.7 7488.9 7533.1 5987.9 7491.2 7509.7 7514.5 7543.7 7274.6 7305.0 7337.7 7338.5 7356.7 5749.3 7409.9 7436.7 7453.6 7472.8 5929.3 7029.7 7167.2 7325.8 7421.9 01:57:17 INFO - PROCESS | 1962 | 01:57:17 INFO - PROCESS | 1962 | [#5] yui.html Cycles:180 Average:17874.21 Median:29982.20 stddev:24720.26 (82.4%) stddev-sans-first:24756.03 01:57:17 INFO - PROCESS | 1962 | Values: 714.7 729.4 757.2 788.2 788.9 15375.8 15379.0 15495.8 15907.4 15934.6 14528.6 14574.3 14592.4 14600.8 14674.2 778.1 934.4 940.2 962.7 965.9 955.7 965.9 967.7 968.8 971.2 982.3 1009.9 1014.2 1016.7 1018.7 1014.4 1015.3 1017.3 1019.3 1020.7 748.7 758.2 760.8 761.9 762.3 15308.7 15449.0 15459.5 15477.1 15528.5 12883.2 13019.3 13052.2 13127.1 13304.5 10023.3 10095.7 10501.9 10586.7 10818.0 3558.1 3567.9 3589.7 3591.6 3691.6 86191.0 86842.1 87219.6 87288.6 87301.7 9776.5 9780.2 9827.7 9874.5 9987.9 21686.2 21992.6 22620.2 23228.0 23307.7 7655.2 7713.7 7852.9 7949.7 8101.6 4152.4 4178.2 4199.2 4213.6 4460.6 3734.9 3802.7 3803.8 3812.5 3813.4 678.1 690.9 692.8 694.6 694.7 604.0 610.7 621.1 622.5 622.9 8315.5 8412.4 8427.6 8636.3 8675.0 546.9 555.8 621.2 628.3 629.1 3402.8 3921.6 3971.7 4002.5 4041.2 67526.0 67703.0 67738.7 68008.7 68028.0 79252.0 79775.6 80030.0 80995.6 81080.6 68504.3 69253.7 69863.0 70305.3 72800.5 7066.7 7837.9 7851.8 8071.7 8296.6 50921.2 51677.2 51736.5 51798.0 52717.2 59360.4 69100.6 69673.0 70527.0 70801.6 10051.7 10090.9 10184.1 10324.3 10388.0 10869.1 10902.2 11011.8 11060.9 11291.5 8978.4 10022.0 10096.8 10122.4 10266.2 10360.6 10458.4 10464.9 10610.1 10837.9 10395.7 10474.1 10499.8 10688.9 10834.0 8563.0 8711.3 8720.3 8939.6 8974.9 8730.1 9104.2 9145.5 9187.2 9198.4 01:57:17 INFO - PROCESS | 1962 | -------- Summary: end -------- 01:57:17 INFO - PROCESS | 1962 | 01:57:18 INFO - TEST-INFO | 1962: exit 0 01:57:18 INFO - TEST-OK | dromaeo_css | took 1110278ms 01:57:18 INFO - TEST-START | kraken 01:57:18 INFO - operating with platform_type : mac_ 01:57:18 INFO - Initialising browser for kraken test... 01:57:18 INFO - TEST-INFO | started process 1969 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/tmpvhDM1N/profile http://localhost:53224/getInfo.html) 01:57:20 INFO - PROCESS | 1969 | __metrics Screen width/height:1600/1200 01:57:20 INFO - PROCESS | 1969 | colorDepth:24 01:57:20 INFO - PROCESS | 1969 | Browser inner width/height: 1024/689 01:57:20 INFO - PROCESS | 1969 | __metrics 01:57:20 ERROR - PROCESS | 1969 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 01:57:21 INFO - TEST-INFO | 1969: exit 0 01:57:21 INFO - Browser initialized. 01:57:21 INFO - Running cycle 1/1 for kraken test... 01:57:21 INFO - TEST-INFO | started process 1973 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/tmpvhDM1N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:57:33 INFO - PROCESS | 1973 | RSS: Main: 170786816 01:57:33 INFO - PROCESS | 1973 | 01:57:36 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:53224/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53224/tests/kraken/driver.html?testName=audio-beat-detection) 01:57:36 INFO - PROCESS | 1973 | RSS: Main: 183742464 01:57:36 INFO - PROCESS | 1973 | 01:57:39 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:53224/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53224/tests/kraken/driver.html?testName=audio-dft) 01:57:40 INFO - PROCESS | 1973 | RSS: Main: 192360448 01:57:40 INFO - PROCESS | 1973 | 01:57:43 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:53224/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53224/tests/kraken/driver.html?testName=audio-fft) 01:57:44 INFO - PROCESS | 1973 | RSS: Main: 195764224 01:57:44 INFO - PROCESS | 1973 | 01:57:46 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:53224/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53224/tests/kraken/driver.html?testName=audio-oscillator) 01:57:46 INFO - PROCESS | 1973 | RSS: Main: 197046272 01:57:46 INFO - PROCESS | 1973 | 01:57:48 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:53224/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53224/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:57:49 INFO - PROCESS | 1973 | RSS: Main: 197648384 01:57:49 INFO - PROCESS | 1973 | 01:57:52 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:53224/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53224/tests/kraken/driver.html?testName=imaging-darkroom) 01:57:52 INFO - PROCESS | 1973 | RSS: Main: 197910528 01:57:52 INFO - PROCESS | 1973 | 01:57:55 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:53224/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53224/tests/kraken/driver.html?testName=imaging-desaturate) 01:57:56 INFO - PROCESS | 1973 | RSS: Main: 198221824 01:57:56 INFO - PROCESS | 1973 | 01:57:59 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:53224/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53224/tests/kraken/driver.html?testName=json-parse-financial) 01:58:00 INFO - PROCESS | 1973 | RSS: Main: 198230016 01:58:00 INFO - PROCESS | 1973 | 01:58:01 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:53224/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53224/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:58:02 INFO - PROCESS | 1973 | RSS: Main: 198111232 01:58:02 INFO - PROCESS | 1973 | 01:58:04 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:53224/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53224/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:58:04 INFO - PROCESS | 1973 | RSS: Main: 197836800 01:58:04 INFO - PROCESS | 1973 | 01:58:06 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:53224/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53224/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:58:07 INFO - PROCESS | 1973 | RSS: Main: 198004736 01:58:07 INFO - PROCESS | 1973 | 01:58:10 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:53224/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53224/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:58:10 INFO - PROCESS | 1973 | RSS: Main: 198209536 01:58:10 INFO - PROCESS | 1973 | 01:58:13 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:53224/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53224/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:58:14 INFO - PROCESS | 1973 | RSS: Main: 198119424 01:58:14 INFO - PROCESS | 1973 | 01:58:15 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:53224/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53224/tests/kraken/driver.html?testName=ai-astar) 01:58:16 INFO - PROCESS | 1973 | RSS: Main: 199987200 01:58:16 INFO - PROCESS | 1973 | 01:58:16 INFO - PROCESS | 1973 | __start_tp_report 01:58:16 INFO - PROCESS | 1973 | _x_x_mozilla_page_load 01:58:16 INFO - PROCESS | 1973 | _x_x_mozilla_page_load_details 01:58:16 INFO - PROCESS | 1973 | |i|pagename|runs| 01:58:16 INFO - PROCESS | 1973 | |0;ai-astar;117;113;116;117;116;133;135;165;162;115 01:58:16 INFO - PROCESS | 1973 | |1;audio-beat-detection;153;121;144;156;132;175;145;175;152;123 01:58:16 INFO - PROCESS | 1973 | |2;audio-dft;195;229;219;194;196;194;196;195;201;194 01:58:16 INFO - PROCESS | 1973 | |3;audio-fft;64;69;76;148;56;59;58;68;130;55 01:58:16 INFO - PROCESS | 1973 | |4;audio-oscillator;77;79;127;76;83;89;119;94;118;104 01:58:16 INFO - PROCESS | 1973 | |5;imaging-gaussian-blur;89;88;89;87;101;117;90;80;136;129 01:58:16 INFO - PROCESS | 1973 | |6;imaging-darkroom;110;98;89;150;149;144;95;94;95;94 01:58:16 INFO - PROCESS | 1973 | |7;imaging-desaturate;90;93;90;98;96;139;143;113;89;91 01:58:16 INFO - PROCESS | 1973 | |8;json-parse-financial;58;63;64;64;62;66;77;79;62;59 01:58:16 INFO - PROCESS | 1973 | |9;json-stringify-tinderbox;63;63;68;64;73;69;70;55;71;96 01:58:16 INFO - PROCESS | 1973 | |10;stanford-crypto-aes;82;81;80;80;82;82;81;82;83;85 01:58:16 INFO - PROCESS | 1973 | |11;stanford-crypto-ccm;135;145;144;137;127;168;137;143;146;135 01:58:16 INFO - PROCESS | 1973 | |12;stanford-crypto-pbkdf2;161;165;167;171;172;169;167;171;164;161 01:58:16 INFO - PROCESS | 1973 | |13;stanford-crypto-sha256-iterative;65;66;67;64;66;68;67;68;66;69 01:58:16 INFO - PROCESS | 1973 | __end_tp_report 01:58:16 INFO - PROCESS | 1973 | __start_cc_report 01:58:16 INFO - PROCESS | 1973 | _x_x_mozilla_cycle_collect,1053 01:58:16 INFO - PROCESS | 1973 | __end_cc_report 01:58:16 INFO - PROCESS | 1973 | __startTimestamp1465289896236__endTimestamp 01:58:16 INFO - PROCESS | 1973 | 01:58:16 INFO - PROCESS | 1973 | ------- Summary: start ------- 01:58:16 INFO - PROCESS | 1973 | Number of tests: 14 01:58:16 INFO - PROCESS | 1973 | 01:58:16 INFO - PROCESS | 1973 | [#0] ai-astar Cycles:10 Average:128.90 Median:125.00 stddev:19.76 (15.8%) stddev-sans-first:20.49 01:58:16 INFO - PROCESS | 1973 | Values: 117.0 113.0 116.0 117.0 116.0 133.0 135.0 165.0 162.0 115.0 01:58:16 INFO - PROCESS | 1973 | 01:58:16 INFO - PROCESS | 1973 | [#1] audio-beat-detection Cycles:10 Average:147.60 Median:152.50 stddev:18.85 (12.4%) stddev-sans-first:19.89 01:58:16 INFO - PROCESS | 1973 | Values: 153.0 121.0 144.0 156.0 132.0 175.0 145.0 175.0 152.0 123.0 01:58:16 INFO - PROCESS | 1973 | 01:58:16 INFO - PROCESS | 1973 | [#2] audio-dft Cycles:10 Average:201.30 Median:196.00 stddev:12.37 (6.3%) stddev-sans-first:12.90 01:58:16 INFO - PROCESS | 1973 | Values: 195.0 229.0 219.0 194.0 196.0 194.0 196.0 195.0 201.0 194.0 01:58:16 INFO - PROCESS | 1973 | 01:58:16 INFO - PROCESS | 1973 | [#3] audio-fft Cycles:10 Average:78.30 Median:61.50 stddev:32.93 (53.5%) stddev-sans-first:34.52 01:58:16 INFO - PROCESS | 1973 | Values: 64.0 69.0 76.0 148.0 56.0 59.0 58.0 68.0 130.0 55.0 01:58:16 INFO - PROCESS | 1973 | 01:58:16 INFO - PROCESS | 1973 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:78.00 stddev:19.17 (24.6%) stddev-sans-first:18.97 01:58:16 INFO - PROCESS | 1973 | Values: 77.0 79.0 127.0 76.0 83.0 89.0 119.0 94.0 118.0 104.0 01:58:16 INFO - PROCESS | 1973 | 01:58:16 INFO - PROCESS | 1973 | [#5] imaging-gaussian-blur Cycles:10 Average:100.60 Median:87.50 stddev:19.66 (22.5%) stddev-sans-first:20.40 01:58:16 INFO - PROCESS | 1973 | Values: 89.0 88.0 89.0 87.0 101.0 117.0 90.0 80.0 136.0 129.0 01:58:16 INFO - PROCESS | 1973 | 01:58:16 INFO - PROCESS | 1973 | [#6] imaging-darkroom Cycles:10 Average:111.80 Median:94.00 stddev:25.37 (27.0%) stddev-sans-first:26.90 01:58:16 INFO - PROCESS | 1973 | Values: 110.0 98.0 89.0 150.0 149.0 144.0 95.0 94.0 95.0 94.0 01:58:16 INFO - PROCESS | 1973 | 01:58:16 INFO - PROCESS | 1973 | [#7] imaging-desaturate Cycles:10 Average:104.20 Median:90.50 stddev:20.64 (22.8%) stddev-sans-first:21.24 01:58:16 INFO - PROCESS | 1973 | Values: 90.0 93.0 90.0 98.0 96.0 139.0 143.0 113.0 89.0 91.0 01:58:16 INFO - PROCESS | 1973 | 01:58:16 INFO - PROCESS | 1973 | [#8] json-parse-financial Cycles:10 Average:65.40 Median:64.00 stddev:7.06 (11.0%) stddev-sans-first:6.96 01:58:16 INFO - PROCESS | 1973 | Values: 58.0 63.0 64.0 64.0 62.0 66.0 77.0 79.0 62.0 59.0 01:58:16 INFO - PROCESS | 1973 | 01:58:16 INFO - PROCESS | 1973 | [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.50 stddev:10.77 (15.5%) stddev-sans-first:11.19 01:58:16 INFO - PROCESS | 1973 | Values: 63.0 63.0 68.0 64.0 73.0 69.0 70.0 55.0 71.0 96.0 01:58:16 INFO - PROCESS | 1973 | 01:58:16 INFO - PROCESS | 1973 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:82.00 stddev:1.48 (1.8%) stddev-sans-first:1.56 01:58:16 INFO - PROCESS | 1973 | Values: 82.0 81.0 80.0 80.0 82.0 82.0 81.0 82.0 83.0 85.0 01:58:16 INFO - PROCESS | 1973 | 01:58:16 INFO - PROCESS | 1973 | [#11] stanford-crypto-ccm Cycles:10 Average:141.70 Median:143.50 stddev:10.94 (7.6%) stddev-sans-first:11.34 01:58:16 INFO - PROCESS | 1973 | Values: 135.0 145.0 144.0 137.0 127.0 168.0 137.0 143.0 146.0 135.0 01:58:16 INFO - PROCESS | 1973 | 01:58:16 INFO - PROCESS | 1973 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.80 Median:168.00 stddev:4.02 (2.4%) stddev-sans-first:3.68 01:58:16 INFO - PROCESS | 1973 | Values: 161.0 165.0 167.0 171.0 172.0 169.0 167.0 171.0 164.0 161.0 01:58:16 INFO - PROCESS | 1973 | 01:58:16 INFO - PROCESS | 1973 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:1.51 (2.2%) stddev-sans-first:1.48 01:58:16 INFO - PROCESS | 1973 | Values: 65.0 66.0 67.0 64.0 66.0 68.0 67.0 68.0 66.0 69.0 01:58:16 INFO - PROCESS | 1973 | -------- Summary: end -------- 01:58:16 INFO - PROCESS | 1973 | 01:58:16 INFO - TEST-INFO | 1973: exit 0 01:58:16 INFO - TEST-OK | kraken | took 58863ms 01:58:16 INFO - SUITE-END | took 1169s 01:58:17 INFO - Completed test suite (00:19:29) 01:58:17 INFO - javascript benchmark 01:58:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3023.410434965182, 3616.2767446510707, 3633.636636336368, 3664.395374763164, 3683.852645894164, 5934.910976335353, 5967.254093238345, 5988.341282458931, 6018.6689732064715, 6065.27216733992, 5948.7620495180245, 5966.8806623867495, 5973.342932277446, 6014.007688731354, 6019.097135429688, 5350.35795704515, 5366.356037275533, 5380.0, 5456.127019676853, 5554.361248456439, 5337.973310133444, 5384.488473595002, 5438.238646589481, 5484.204790305404, 5537.197106419567, 5337.226102215176, 5446.7276636168235, 5488.231647569323, 5498.780048798043, 5503.449655034485, 3720.218754061637, 5167.819126330579, 5381.623286369956, 5456.48163424474, 5467.125259958388, 4426.62373698236, 5196.090684130262, 5342.385625653022, 5343.412224655285, 5353.705546194958, 5705.71471426427, 5808.477237048686, 5854.882902341929, 5856.1508581255475, 5984.910226346608, 6243.250809902841, 6243.282022567418, 6288.528360372945, 6295.811125666238, 6296.464800491964, 6180.134781130645, 6267.780627678009, 6343.302236754, 6376.808695739135, 6407.551471397004, 5999.190109335227, 6086.2087928569445, 6098.237720285008, 6100.145979562864, 6101.267847858286, 6283.340249273851, 6492.513061520405, 6501.577397469244, 6505.577137486048, 6514.869702606016, 5936.910946335808, 6158.7228574714245, 6191.9690401547705, 6219.533534984895, 6220.657863817443, 6306.243250809932, 6328.493720502349, 6363.427291543783, 6390.329015453403, 6399.712012959428, 6132.325444201134, 6205.6586887720705, 6281.309056003836, 6286.748530058747, 6290.654014029273, 6218.595791273553, 6273.1844860167885, 6283.654399008098, 6293.370662933761, 6298.149749783812, 5047.848564543069, 5065.442801291929, 5094.388673359221, 5103.0, 5123.975204959023, 4484.932726009112, 4504.0, 4534.251848445036, 4570.200214962369, 4574.130915126116, 5965.224520812353, 6019.939800602026, 6089.451949324582, 6091.695415229221, 6105.908411373833, 6292.874142517124, 6332.145160403379, 6381.074744162163, 6383.521235907326, 6387.680615969183, 5934.080217566284, 6012.488938440281, 6067.605605635619, 6114.510839132859, 6116.755329786759, 5503.477169668875, 5559.138333558305, 5579.581531385163, 5590.105583106683, 5594.496495315441, 6549.083128362033, 6550.443212327005, 6557.409833115043, 6565.343465653492, 6567.770128045591, 6217.222847144107, 6247.250329960252, 6321.810345689637, 6339.366063393623, 6361.904571431525, 5813.491274794299, 6221.69344437655, 6614.305497922649, 6615.17310336208, 6653.268140504638, 5098.617603679813, 6259.78090766821, 6267.0, 6279.529035322461, 6284.780032698834, 6185.8144255672405, 6231.657258850807, 6271.78048768291, 6322.841928951813, 6346.428821405911, 5100.974495127501, 5126.231065340229, 5453.182022696627, 6152.507799376129, 6207.596506227081, 6126.632402055891, 6252.906206406817, 6263.718132683949, 6267.341929097562, 6272.341404152498, 4999.175136102503, 6128.930927367261, 6131.407250743203, 6225.750969961332, 6236.314005459305, 6182.969085154546, 6269.686515674107, 6270.0, 6281.780137695158, 6285.465735412358, 4940.901181976268, 6124.228368151265, 6257.186565746424, 6277.497800175884, 6280.403361680633], "value": 5814.489135421275, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [530.3688610553442, 532.8294945617404, 561.3908908833915, 566.4562020460357, 603.0833133636874, 32908.17729556759, 39638.60361396385, 39691.20617587647, 39770.0, 40037.0, 40702.59297407025, 40873.18253634925, 41447.79276103615, 41514.58485415145, 41567.0, 9610.519474026289, 9788.216942644607, 9823.263255255884, 9839.803203935917, 9846.704598862045, 9743.805123897519, 9948.502574871227, 9984.201263898907, 9993.650222242222, 10015.19878409729, 8358.122397148303, 9011.0, 9568.23454123672, 9964.750881227956, 9995.650152244672, 9833.606655733762, 9906.653267135616, 9910.90089099107, 9943.502824858728, 9953.452560109192, 9739.90260097397, 9809.264305177068, 9846.212303015813, 9869.654562090293, 9891.752706182331, 39330.41004384936, 39352.0, 39683.80948571547, 39806.40290395646, 39956.80021599903, 2562.7565381288746, 3211.678832116793, 3218.6459489456142, 3237.125975986494, 3401.0817079388426, 29481.0, 29582.0, 29703.25741856449, 30332.0, 31447.52828707571, 2804.1307194769483, 2804.775617950559, 2825.70330115337, 2856.5001124803075, 2875.856207189632, 442023.78988105175, 442481.0, 444571.77714111545, 447744.76127619477, 448732.0, 52348.47651523436, 64685.67657161684, 65137.67431162909, 65147.67426162839, 65246.0, 67234.66382668153, 70730.0, 71958.56082878313, 72171.0, 72235.63882180555, 18211.0, 18357.908210458863, 18397.0, 18403.81596184048, 18485.89084654925, 11998.940005300092, 14006.929965350311, 14217.64455888611, 14266.215358155401, 14272.35774390155, 17681.646367072586, 19345.613087738166, 19668.409947701304, 20093.698594521094, 20142.19431222764, 7433.219511951275, 8354.373421993374, 8450.239478446969, 8463.703770368007, 8491.532965686947, 956.168133723651, 1056.0706578211125, 1059.6344261229863, 1068.2308737708838, 1143.1997601678859, 30140.888559092, 30164.095077147722, 30274.84862575673, 30647.38705225883, 30808.383832323227, 1099.6975831646362, 1100.9449527523752, 1103.6688993301977, 1147.2485521983115, 1154.3074155506797, 14390.568282951528, 14481.637959051108, 14651.853481465261, 14724.484643037442, 15032.62418439526, 525378.0, 573628.0, 584932.0, 624622.0, 625196.0, 58467.415325846196, 59056.704716476146, 59077.0, 59223.815523689285, 59472.70263648654, 1527.3279756906925, 1552.3169805285863, 1561.2271925397001, 1564.7261729197344, 1572.0646215501758, 25979.870100649376, 28575.857120715096, 28759.0, 29450.0, 29692.0, 51754.74122629363, 51948.96102077862, 52481.21278180907, 52750.47249527609, 52754.681132971986, 576601.0, 579537.0, 579801.0, 582167.0, 582301.0, 25909.056895562746, 26850.865745671148, 26989.86505067462, 27020.72979270261, 27393.86303068472, 44743.55256447524, 45826.54173458223, 46273.3059004122, 46715.766421167675, 46953.06093878172, 37278.8136059318, 37865.81067094757, 38033.0, 38636.420453693776, 38804.0, 36374.27251454903, 36870.07824804401, 36885.81557092197, 37198.44202336913, 37609.623903760614, 37070.25859482741, 37421.4386784193, 37596.62403375931, 37868.0, 38162.0, 26847.865760671073, 31825.0, 32807.34385312328, 33076.1730956728, 33249.0, 24891.62662560099, 24893.626595601443, 25168.265752617925, 25412.110576130486, 25615.743842561336], "value": 20120.368522659497, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.7806962309975, 416.4232537934959, 421.7553818785104, 422.9577042295771, 427.7305297662473, 20759.896200518975, 20904.37286881394, 21616.89191554044, 22188.55622887545, 22826.65760013601, 21264.57470850582, 21396.679049814265, 21436.14255429781, 21566.460838479044, 21727.45681357963, 5620.550355971523, 6149.600275982069, 6149.754009839612, 6149.938500614981, 6161.075838624198, 4477.149341625097, 5993.730282137292, 6150.354212807658, 6484.967575162118, 6762.797116086525, 5737.913931291013, 6649.0, 6694.062831203635, 6710.798676039727, 6740.258571557125, 6441.645709485976, 6576.53964222507, 6584.473242140617, 6585.9012114818315, 6612.603243805387, 5682.119271512922, 5765.0, 5770.913436298459, 5778.682172480512, 5793.913091303634, 13034.348282585928, 13645.317734113254, 24883.755812209318, 26035.349116272057, 26043.869780650977, 2283.25794116911, 2343.5312937412587, 2390.6653068570413, 2531.5949448088218, 2557.450148218142, 9871.111599955966, 9889.20886329099, 10147.441890696009, 10212.540435680412, 10333.121684656813, 1618.732909070002, 1772.3176577017812, 1787.731840223964, 1816.1917946513806, 1901.4390754727388, 111864.60949647175, 123793.0, 124662.75337246602, 125961.11058334132, 126856.73143268541, 11857.644270671894, 11996.40017999114, 12041.397930103634, 12062.87937120635, 12127.272363658209, 15222.695546089017, 15289.617759555878, 15551.22243887801, 15556.14441205722, 15615.0, 8839.46963182211, 9194.90805091954, 9286.303527235485, 9297.953510232406, 9353.953230233805, 7007.509474336849, 7782.221777822172, 7805.102413222438, 9337.159655631025, 9385.249180065579, 3587.7488575799443, 4645.907081858344, 4725.787339569728, 4751.52484751529, 4754.191787396151, 1874.3720853513953, 2000.5398758285385, 2036.7861374555755, 2094.7591027032086, 2116.978830211678, 880.9515476648718, 932.5989824375448, 1029.2332212501585, 1040.5837664933936, 1089.5587287148717, 19928.800711992986, 20553.177872884917, 20569.794302057086, 20702.585948281252, 20739.8963005184, 1001.8998100190068, 1006.6778630838207, 1019.2712210769188, 1029.361795686679, 1039.2673165418362, 11051.834222486668, 11419.086473082134, 11507.712307192387, 11507.942460287644, 11539.942300288445, 554434.2278288583, 643507.0, 643915.0, 648713.0, 657224.0, 135623.0, 139305.0, 139499.0, 140841.0, 147451.0, 1074.6023971130733, 1078.2021304234966, 1117.6032508459543, 1127.4531852051748, 1138.174823253135, 18230.270789168284, 18788.0, 18818.341358052403, 18933.148008339384, 19103.904480478064, 49424.139205481166, 54496.0, 55282.72358638181, 56349.154762677776, 56499.15251271152, 76968.46063078595, 81259.18740812753, 81591.77612335938, 82465.0, 82825.0, 8295.460795048302, 8328.958880139982, 8429.873551896604, 8623.353248506513, 8822.735317940473, 11278.0, 13171.802422963472, 13308.866911330762, 13470.79793803074, 13629.25039122818, 10865.674029779118, 11276.492557834754, 11513.654590362303, 11842.993345565379, 11994.700132496757, 9976.60093596277, 11262.267952583055, 11336.546538138382, 11343.659690209306, 11573.826392603949, 10929.344239345664, 11634.069274458192, 11679.357635329798, 11852.76294474123, 11936.761264774483, 7238.348548630438, 8371.16288371158, 8388.748337549883, 8426.620802064044, 8455.28130108923, 8633.30933525329, 11246.156538259827, 11533.942330288295, 11627.709307267385, 11851.762964740828], "value": 9900.470105612243, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1449.4854326714017, 1668.1909274002107, 1772.6100257943249, 1961.7547806524185, 2044.2027609232393, 8180.836383272331, 8280.171982801718, 9026.052264512222, 9088.591013404397, 9250.86123708144, 7857.960710196456, 8884.64461421544, 9020.684276050339, 9048.72853814385, 9050.275977921767, 2534.51844149611, 2544.6437498750142, 2556.75710807473, 2563.3207200091897, 2565.9358516037155, 2488.0, 2522.419843436011, 2528.4184637533376, 2533.809964252679, 2535.9239222823344, 2512.258883629334, 2535.3154648244963, 2551.4897020595863, 2552.0557393764334, 2566.9614955775587, 2501.537215615117, 2515.383730985902, 2515.421453065787, 2518.2193520008764, 2538.9873050634815, 2510.1716433576876, 2532.6074458458784, 2533.3539947313316, 2544.6310285008753, 2552.8978840846344, 8713.738587842312, 8762.079981601904, 8820.735377938672, 8830.911690883073, 8835.425697329718, 5675.858103547403, 5677.0, 5731.025725626611, 5815.069588865761, 5848.356680765112, 3650.2881938022097, 3737.5514938207316, 3784.7539909906045, 3797.373433383488, 3802.543694756647, 920.4385324951774, 1044.738815296176, 1071.9142468602572, 1073.1146803886747, 1073.1843798712957, 9727.65953191635, 12137.271763694207, 12455.065870059781, 12462.501499939992, 12474.0, 4935.802567897315, 5032.496750325012, 5044.344235249468, 5101.413337466165, 5120.308758317579, 10301.793964120676, 10321.535530901128, 10516.053555179917, 10534.894651053544, 10541.31481453703, 5563.666180029211, 5718.571107166979, 5747.994101032303, 5752.0, 5764.221830052973, 4596.747178905125, 5037.79848806051, 5160.071187186342, 5167.199084141964, 5173.844784656466, 4191.685623578243, 4199.874003779892, 4269.018125831076, 4298.26929421999, 4308.633766129851, 1375.2367436073075, 1401.089291960234, 1402.2287741742, 1406.0579411793917, 1415.7239338329132, 769.4959801330137, 919.1360121485782, 965.2471072563412, 991.4893829677721, 1002.0981116994617, 5053.393592768818, 5818.5636077294375, 5891.41085891416, 6045.123457098696, 6106.419890110433, 468.85465505693344, 479.38399157083677, 481.86748644123145, 483.74119845882285, 490.225443798797, 3691.837071322525, 3958.802059896994, 4004.439378487014, 4028.8388464461677, 4036.2734707752297, 10096.040876116756, 10812.243142979916, 10964.451777411097, 11005.724856878482, 11048.005679488884, 10611.363318200933, 10867.076298514714, 10870.456477176109, 10884.129269658408, 10930.945345273381, 8107.878381824277, 8476.618552165044, 8621.741347759576, 8653.6538538459, 8687.653413720884, 6007.759689612367, 6030.879382412415, 6059.6364218147055, 6090.0, 6095.4761309672585, 9352.0, 9548.57031433601, 9579.233661307218, 9597.136257736836, 9751.268654851056, 9638.518074096408, 9737.464439455898, 9768.56041478121, 9818.31271810995, 9839.5080245986, 5919.6152250103605, 7305.086864141982, 7471.701131954661, 7675.61621918913, 7811.843763124592, 8205.0, 8209.096999330188, 8241.79395515117, 8286.337093032422, 8293.129221431664, 7248.565086094851, 7327.487075904635, 7354.485186036926, 7444.330010299099, 7521.736739214101, 7275.272472752682, 7355.0, 7505.512141710771, 7564.357029652541, 7653.6555854985545, 7172.49792514519, 7191.3887319578425, 7200.0, 7220.3140701633265, 7244.818879528054, 4948.307236986897, 5002.6498145130945, 5042.974785126051, 5059.392872855281, 5116.897662046813, 4963.503649635008, 5004.499550044967, 5032.521910418504, 5096.643234973516, 5248.921266181087], "value": 4647.288073018437, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.5330577274498, 333.8831608270336, 343.74219335498384, 344.4282491064831, 346.6550781971935, 5544.916826247604, 6760.763373281936, 6819.386255237027, 6971.930280697192, 6981.650917454126, 6815.897761533581, 6959.686814093366, 6962.96518517408, 6968.372846443832, 6975.9536069589585, 5048.6465947383695, 5056.595472362203, 5059.180318859256, 5083.389993200821, 5098.617603679721, 4343.913121737563, 5096.643234973553, 5097.649122982412, 5101.464346243647, 5104.464031276718, 4803.18345881201, 5023.296738456619, 5030.06943715412, 5031.069252188357, 5053.216751403538, 4869.196582563855, 5007.774650140753, 5029.371328583927, 5033.823816166453, 5043.470435604264, 4231.767252801094, 4236.766977816219, 4275.593818587229, 4281.422008028907, 4297.05464797744, 6584.242812076624, 6592.5714828536475, 6601.70292336846, 6615.636140012298, 6631.171103612049, 4938.432080310774, 5899.820035992819, 5958.046712526018, 5972.581919265654, 6000.36996115406, 7327.450441216877, 7337.559746415232, 7360.07999000125, 7364.263573642593, 7384.852302953965, 4517.774111294455, 4733.95266047342, 4738.8341408050555, 4801.447833499157, 4809.615230781564, 7711.691532338699, 7765.378769698411, 7817.68729250835, 7819.452638315321, 7827.021622297213, 4790.5448982346625, 4797.136515427187, 4810.965642386904, 4812.422509298906, 4819.662623616383, 4883.145449546315, 4885.780139893714, 4890.657653964188, 4898.853034408973, 4924.975375123101, 4946.4064312282035, 5884.94071067212, 5885.529157667376, 5886.646801191942, 5932.495737862244, 5674.574406919498, 6837.589744615339, 7362.631868406558, 7443.106827180773, 7455.4408419368765, 1439.9856001440062, 1666.5833541614597, 1676.2289346900561, 1693.0857337038108, 1699.4731633193749, 994.0953732103751, 1039.8076355874186, 1047.7642530430744, 1060.3213943076437, 1065.5790962569743, 5730.570207234391, 5935.82192534216, 6847.383735463832, 6908.965455172692, 7052.541584796972, 7800.219978002267, 7801.258880406353, 7812.960935195288, 7824.295813376823, 7832.0, 7004.15950085993, 7035.964820175866, 7041.119860017498, 7046.753363632249, 7079.1858936223, 2954.6897575754665, 3962.870581884149, 4074.083331250504, 4117.958820411817, 4141.337386018223, 6997.685104170325, 7686.423518236154, 8133.511989280662, 8136.308413784895, 8150.796230094295, 7983.441159118806, 8003.439759216799, 8011.118776934532, 8030.23712747288, 8055.429191307756, 8111.310538604167, 8129.4715843469985, 8132.512049276944, 8150.021997360236, 8177.345812334999, 7456.440766942609, 7770.0, 7771.572563508835, 7779.416543759127, 7785.532868027936, 7622.31399174077, 7632.274933881273, 7684.6926122954455, 7689.577073260801, 7693.615319233904, 6539.346065393613, 8124.22819832115, 8124.350051995708, 8145.674173033012, 8160.632771525415, 3985.342418501031, 4079.775612341231, 4671.486136524912, 4769.332293478985, 4770.165221086366, 7372.59450730215, 7755.612219388895, 7775.105862825621, 7778.338841198562, 7810.531368117931, 5967.582269241285, 7484.288992545699, 7484.700611975678, 7488.850222995618, 7533.096028476618, 5987.880242395215, 7491.175970643334, 7509.7371591994015, 7514.47398682087, 7543.73596924105, 7274.599897005503, 7305.0, 7337.706491740484, 7338.486305958531, 7356.66894989716, 5749.281339832521, 7409.851802963803, 7436.665350059368, 7453.627318633939, 7472.775816725507, 5929.347771745019, 7029.683664235019, 7167.211606723361, 7325.7802265932105, 7421.888671669822], "value": 5327.127501693894, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.6998260730493, 729.3618084176346, 757.2398607077207, 788.1842293226512, 788.8580055589995, 15375.846241537582, 15379.0, 15495.84504154958, 15907.363705451782, 15934.601634959132, 14528.564143075699, 14574.344154513046, 14592.41630334788, 14600.780988285183, 14674.192919389428, 778.1129512355891, 934.3926447808927, 940.2055263302499, 962.7208109648194, 965.8696076029752, 955.7085089047838, 965.8647789309503, 967.6661551764665, 968.7723385004518, 971.2327261463436, 982.2731178927578, 1009.8535712321709, 1014.2342531388828, 1016.6797458800454, 1018.6689325969089, 1014.3812274512542, 1015.2943704125636, 1017.2523195451338, 1019.3119644240182, 1020.6784862768242, 748.7379417203989, 758.1963119093723, 760.7831767946165, 761.8704820180583, 762.2758379539405, 15308.693826123526, 15448.995815271972, 15459.458918937895, 15477.148756818371, 15528.456504022304, 12883.162594431426, 13019.349032548334, 13052.21686698801, 13127.146735462164, 13304.534341298106, 10023.298369114165, 10095.697129086138, 10501.894981050245, 10586.735331616694, 10817.972292632187, 3558.1104723819044, 3567.8751243706347, 3589.6769290763955, 3591.6408359163875, 3691.6123807000145, 86191.0, 86842.13157868404, 87219.56390218071, 87288.56355718244, 87301.69047464294, 9776.462294573725, 9780.217582593375, 9827.705168844946, 9874.506274686237, 9987.900120998842, 21686.24098156557, 21992.560148797256, 22620.208292709674, 23227.95474203665, 23307.650385244237, 7655.1962043985695, 7713.730019449293, 7852.882206766903, 7949.7217597383815, 8101.6354264058255, 4152.397902304149, 4178.206140833232, 4199.181159673895, 4213.641840443596, 4460.576245256695, 3734.9439758403646, 3802.6767724743154, 3803.8098095095133, 3812.5424949006297, 3813.389857622767, 678.0642713055951, 690.858374033322, 692.8129405060605, 694.5589550635282, 694.6804469943883, 603.9879202416015, 610.7129649064932, 621.1366200980641, 622.4895585619839, 622.9003359462464, 8315.459495132796, 8412.369072319601, 8427.620757065946, 8636.318555985297, 8674.956625216833, 546.9042917489423, 555.7721334252936, 621.2048577820398, 628.3465196195997, 629.1003864473755, 3402.8298585070647, 3921.568627450978, 3971.7219794614675, 4002.519697636244, 4041.1715598302276, 67526.0, 67703.0, 67738.66130669315, 68008.6599567009, 68028.0, 79252.0, 79775.60112199401, 80029.99999999884, 80995.59502202451, 81080.59459702663, 68504.3149568508, 69253.6867277796, 69863.0, 70305.2969470309, 72800.54398911992, 7066.717331306896, 7837.921620783947, 7851.84296314082, 8071.717489887826, 8296.626651800803, 50921.23618145657, 51677.22484162665, 51736.48263517317, 51798.0, 52717.20924186063, 59360.40639593549, 69100.61798763897, 69673.0, 70527.0, 70801.6459917697, 10051.706103104636, 10090.899091008996, 10184.083432490816, 10324.277300589187, 10388.0, 10869.076128529163, 10902.18233632465, 11011.787279332051, 11060.889391105986, 11291.491882865126, 8978.416402933788, 10022.047905448972, 10096.848547271944, 10122.44326562046, 10266.178705703674, 10360.637377692046, 10458.424786636808, 10464.947675261576, 10610.098141658045, 10837.891621083689, 10395.688129356131, 10474.109700675528, 10499.842502362319, 10688.89311106879, 10834.0, 8563.0, 8711.346649001223, 8720.302375809793, 8939.553022348986, 8974.93397119644, 8730.126987301219, 9104.180623743894, 9145.496997665192, 9187.173154416134, 9198.448093114435], "value": 6936.950309310562, "unit": "score"}], "name": "dromaeo_css", "value": 7640.413693037013, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 113.0, 116.0, 117.0, 116.0, 133.0, 135.0, 165.0, 162.0, 115.0], "value": 128.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 121.0, 144.0, 156.0, 132.0, 175.0, 145.0, 175.0, 152.0, 123.0], "value": 147.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 229.0, 219.0, 194.0, 196.0, 194.0, 196.0, 195.0, 201.0, 194.0], "value": 201.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 69.0, 76.0, 148.0, 56.0, 59.0, 58.0, 68.0, 130.0, 55.0], "value": 78.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 127.0, 76.0, 83.0, 89.0, 119.0, 94.0, 118.0, 104.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 89.0, 87.0, 101.0, 117.0, 90.0, 80.0, 136.0, 129.0], "value": 100.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 98.0, 89.0, 150.0, 149.0, 144.0, 95.0, 94.0, 95.0, 94.0], "value": 111.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 93.0, 90.0, 98.0, 96.0, 139.0, 143.0, 113.0, 89.0, 91.0], "value": 104.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 63.0, 64.0, 64.0, 62.0, 66.0, 77.0, 79.0, 62.0, 59.0], "value": 65.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 68.0, 64.0, 73.0, 69.0, 70.0, 55.0, 71.0, 96.0], "value": 69.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 80.0, 80.0, 82.0, 82.0, 81.0, 82.0, 83.0, 85.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 145.0, 144.0, 137.0, 127.0, 168.0, 137.0, 143.0, 146.0, 135.0], "value": 141.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 165.0, 167.0, 171.0, 172.0, 169.0, 167.0, 171.0, 164.0, 161.0], "value": 166.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 67.0, 64.0, 66.0, 68.0, 67.0, 68.0, 66.0, 69.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1560.8, "alertThreshold": 2.0}]} 01:58:17 INFO - Return code: 0 01:58:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:58:17 ERROR - # TBPL SUCCESS # 01:58:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:58:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:58:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:58:17 INFO - 2016-06-07 01:58:17.569 screenresolution[1978:20448] starting screenresolution argv=screenresolution get 01:58:17 INFO - 2016-06-07 01:58:17.572 screenresolution[1978:20448] Display 0: 1600x1200x32@60 01:58:17 INFO - 2016-06-07 01:58:17.578 screenresolution[1979:20451] starting screenresolution argv=screenresolution list 01:58:17 INFO - Available Modes on Display 0 01:58:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:58:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:58:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:58:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:58:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:58:17 INFO - Intel Iris: 01:58:17 INFO - Chipset Model: Intel Iris 01:58:17 INFO - Type: GPU 01:58:17 INFO - Bus: Built-In 01:58:17 INFO - VRAM (Dynamic, Max): 1536 MB 01:58:17 INFO - Vendor: Intel (0x8086) 01:58:17 INFO - Device ID: 0x0a2e 01:58:17 INFO - Revision ID: 0x0009 01:58:17 INFO - Displays: 01:58:17 INFO - Display: 01:58:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:58:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:58:17 INFO - Display Serial Number: 1600x1200 60 01:58:17 INFO - Main Display: Yes 01:58:17 INFO - Mirror: Off 01:58:17 INFO - Online: Yes 01:58:17 INFO - Rotation: Supported 01:58:17 INFO - Return code: 0 01:58:17 INFO - Running post-action listener: _resource_record_post_action 01:58:17 INFO - Running post-run listener: _resource_record_post_run 01:58:18 INFO - Total resource usage - Wall time: 1193s; CPU: 53.0%; Read bytes: 880640; Write bytes: 496154112; Read time: 11; Write time: 1725 01:58:18 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194599424; Write bytes: 196683264; Read time: 17649; Write time: 413 01:58:18 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 880640; Write bytes: 298622976; Read time: 11; Write time: 1310 01:58:18 INFO - Running post-run listener: _upload_blobber_files 01:58:18 INFO - Blob upload gear active. 01:58:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:58:18 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 01:58:18 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:58:18 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:58:19 INFO - (blobuploader) - INFO - Open directory for files ... 01:58:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:58:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:58:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:58:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:58:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:58:20 INFO - (blobuploader) - INFO - Done attempting. 01:58:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:58:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:58:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:58:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:58:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:58:21 INFO - (blobuploader) - INFO - Done attempting. 01:58:21 INFO - (blobuploader) - INFO - Iteration through files over. 01:58:21 INFO - Return code: 0 01:58:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:58:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:58:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c11a7f5bcd90d036a22af76466df1176795164f975baf8deafbf86b38a7b046bb839f741141f7e7fbc53d4d18f0d7f1a97775588c268d157e5786fdd5c71e303", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a9df62000fbddd2f24ab01ff894945191aac88c0a665a00af0fdf8221a159b1ff9444a59d3babe78a0bd2cad6ea43af642826e412daa02549946ca70fd0c12b2"} 01:58:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:58:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:58:21 INFO - Contents: 01:58:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c11a7f5bcd90d036a22af76466df1176795164f975baf8deafbf86b38a7b046bb839f741141f7e7fbc53d4d18f0d7f1a97775588c268d157e5786fdd5c71e303", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a9df62000fbddd2f24ab01ff894945191aac88c0a665a00af0fdf8221a159b1ff9444a59d3babe78a0bd2cad6ea43af642826e412daa02549946ca70fd0c12b2"} 01:58:21 INFO - Running post-run listener: copy_logs_to_upload_dir 01:58:21 INFO - Copying logs to upload dir... 01:58:21 INFO - mkdir: /builds/slave/test/build/upload/logs 01:58:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.955166 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-07 01:58:21.461542) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 01:58:21.464965) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lNduFWahUX/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.IkjwyJLb6P/Listeners TMPDIR=/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c11a7f5bcd90d036a22af76466df1176795164f975baf8deafbf86b38a7b046bb839f741141f7e7fbc53d4d18f0d7f1a97775588c268d157e5786fdd5c71e303", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a9df62000fbddd2f24ab01ff894945191aac88c0a665a00af0fdf8221a159b1ff9444a59d3babe78a0bd2cad6ea43af642826e412daa02549946ca70fd0c12b2"} build_url:https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010968 build_url: 'https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c11a7f5bcd90d036a22af76466df1176795164f975baf8deafbf86b38a7b046bb839f741141f7e7fbc53d4d18f0d7f1a97775588c268d157e5786fdd5c71e303", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a9df62000fbddd2f24ab01ff894945191aac88c0a665a00af0fdf8221a159b1ff9444a59d3babe78a0bd2cad6ea43af642826e412daa02549946ca70fd0c12b2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 01:58:21.496261) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:58:21.496605) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lNduFWahUX/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.IkjwyJLb6P/Listeners TMPDIR=/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005196 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:58:21.545832) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 01:58:21.546199) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 01:58:21.546541) ========= ========= Total master_lag: 0.71 =========