builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0359 starttime: 1485917062.93 results: success (0) buildid: 20170131164508 builduid: f9601fdcd93d4b5a844dffba3207da19 revision: f39a49e249ecea5f35bc096657fc778619ba60fd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-31 18:44:22.932837) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-31 18:44:22.933291) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-31 18:44:22.933582) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-31 18:44:22.964538) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 18:44:22.964934) ========= 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.a9LXjBr8nM/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.gIAp65564H/Listeners TMPDIR=/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 --2017-01-31 18:44:22-- 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: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 153M=0s 2017-01-31 18:44:23 (153 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.095594 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 18:44:23.087411) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 18:44:23.087821) ========= 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.a9LXjBr8nM/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.gIAp65564H/Listeners TMPDIR=/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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.027446 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 18:44:23.136674) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-31 18:44:23.137094) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f39a49e249ecea5f35bc096657fc778619ba60fd --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 f39a49e249ecea5f35bc096657fc778619ba60fd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.a9LXjBr8nM/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.gIAp65564H/Listeners TMPDIR=/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 2017-01-31 18:44:23,246 truncating revision to first 12 chars 2017-01-31 18:44:23,247 Setting DEBUG logging. 2017-01-31 18:44:23,247 attempt 1/10 2017-01-31 18:44:23,247 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f39a49e249ec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-31 18:44:23,946 unpacking tar archive at: mozilla-beta-f39a49e249ec/testing/mozharness/ program finished with exit code 0 elapsedTime=0.951746 ========= master_lag: 1.45 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-31 18:44:25.534000) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-31 18:44:25.534342) ========= script_repo_revision: f39a49e249ecea5f35bc096657fc778619ba60fd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-31 18:44:25.534725) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-31 18:44:25.534989) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-31 18:44:25.568788) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-01-31 18:44:25.569163) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --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', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--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.a9LXjBr8nM/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.gIAp65564H/Listeners TMPDIR=/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 18:44:25 INFO - MultiFileLogger online at 20170131 18:44:25 in /builds/slave/test 18:44:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 18:44:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:44:25 INFO - {'append_to_log': False, 18:44:25 INFO - 'base_work_dir': '/builds/slave/test', 18:44:25 INFO - 'blob_upload_branch': 'Mozilla-Beta', 18:44:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:44:25 INFO - 'branch': 'Mozilla-Beta', 18:44:25 INFO - 'buildbot_json_path': 'buildprops.json', 18:44:25 INFO - 'config_files': ('talos/mac_config.py',), 18:44:25 INFO - 'default_actions': ('clobber', 18:44:25 INFO - 'read-buildbot-config', 18:44:25 INFO - 'download-and-extract', 18:44:25 INFO - 'populate-webroot', 18:44:25 INFO - 'create-virtualenv', 18:44:25 INFO - 'install', 18:44:25 INFO - 'run-tests'), 18:44:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:44:25 INFO - 'download_minidump_stackwalk': True, 18:44:25 INFO - 'download_symbols': 'ondemand', 18:44:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:44:25 INFO - 'tooltool.py': '/tools/tooltool.py', 18:44:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:44:25 INFO - '/tools/misc-python/virtualenv.py')}, 18:44:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:44:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:44:25 INFO - 'installer_path': 'installer.exe', 18:44:25 INFO - 'log_level': 'info', 18:44:25 INFO - 'log_name': 'talos', 18:44:25 INFO - 'log_to_console': True, 18:44:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:44:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:44:25 INFO - 'opt_config_files': (), 18:44:25 INFO - 'pip_index': False, 18:44:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:44:25 INFO - 'cmd': ('bash', 18:44:25 INFO - '-c', 18:44:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:44:25 INFO - 'enabled': True, 18:44:25 INFO - 'halt_on_failure': False, 18:44:25 INFO - 'name': 'check_screen_resolution'},), 18:44:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:44:25 INFO - 'cmd': ('bash', 18:44:25 INFO - '-c', 18:44:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:44:25 INFO - 'enabled': True, 18:44:25 INFO - 'halt_on_failure': False, 18:44:25 INFO - 'name': 'check_screen_resolution'},), 18:44:25 INFO - 'run_cmd_checks_enabled': True, 18:44:25 INFO - 'sps_profile': False, 18:44:25 INFO - 'sps_profile_interval': 0, 18:44:25 INFO - 'suite': 'dromaeojs', 18:44:25 INFO - 'system_bits': '32', 18:44:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:44:25 INFO - 'title': 't-yosemite-r7-0359', 18:44:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:44:25 INFO - 'use_talos_json': True, 18:44:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:44:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:44:25 INFO - 'work_dir': 'build'} 18:44:25 INFO - [mozharness: 2017-02-01 02:44:25.788512Z] Running clobber step. 18:44:25 INFO - Running pre-action listener: _resource_record_pre_action 18:44:25 INFO - Running main action method: clobber 18:44:25 INFO - rmtree: /builds/slave/test/build 18:44:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:44:28 INFO - Running post-action listener: _resource_record_post_action 18:44:28 INFO - [mozharness: 2017-02-01 02:44:28.047741Z] Finished clobber step (success) 18:44:28 INFO - [mozharness: 2017-02-01 02:44:28.047878Z] Running read-buildbot-config step. 18:44:28 INFO - Running pre-action listener: _resource_record_pre_action 18:44:28 INFO - Running main action method: read_buildbot_config 18:44:28 INFO - Using buildbot properties: 18:44:28 INFO - { 18:44:28 INFO - "project": "", 18:44:28 INFO - "product": "firefox", 18:44:28 INFO - "script_repo_revision": "production", 18:44:28 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 18:44:28 INFO - "repository": "", 18:44:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 18:44:28 INFO - "buildid": "20170131164508", 18:44:28 INFO - "pgo_build": "False", 18:44:28 INFO - "basedir": "/builds/slave/test", 18:44:28 INFO - "buildnumber": 26, 18:44:28 INFO - "slavename": "t-yosemite-r7-0359", 18:44:28 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 18:44:28 INFO - "platform": "yosemite_r7", 18:44:28 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 18:44:28 INFO - "branch": "mozilla-beta", 18:44:28 INFO - "repo_path": "releases/mozilla-beta", 18:44:28 INFO - "revision": "f39a49e249ecea5f35bc096657fc778619ba60fd", 18:44:28 INFO - "stage_platform": "macosx64", 18:44:28 INFO - "builduid": "f9601fdcd93d4b5a844dffba3207da19", 18:44:28 INFO - "slavebuilddir": "test" 18:44:28 INFO - } 18:44:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/TrAEAlsxTEenoYCpgNxOAg/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 18:44:28 INFO - Running post-action listener: _resource_record_post_action 18:44:28 INFO - [mozharness: 2017-02-01 02:44:28.051249Z] Finished read-buildbot-config step (success) 18:44:28 INFO - [mozharness: 2017-02-01 02:44:28.051416Z] Running download-and-extract step. 18:44:28 INFO - Running pre-action listener: _resource_record_pre_action 18:44:28 INFO - Running main action method: download_and_extract 18:44:28 INFO - mkdir: /builds/slave/test/build/tests 18:44:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:44:28 INFO - trying https://queue.taskcluster.net/v1/task/TrAEAlsxTEenoYCpgNxOAg/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 18:44:28 INFO - Downloading https://queue.taskcluster.net/v1/task/TrAEAlsxTEenoYCpgNxOAg/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 18:44:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TrAEAlsxTEenoYCpgNxOAg/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 18:44:29 INFO - Downloaded 1165 bytes. 18:44:29 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 18:44:29 INFO - Using the following test package requirements: 18:44:29 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 18:44:29 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 18:44:29 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 18:44:29 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 18:44:29 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 18:44:29 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 18:44:29 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 18:44:29 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 18:44:29 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 18:44:29 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 18:44:29 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 18:44:29 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 18:44:29 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 18:44:29 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 18:44:29 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 18:44:29 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 18:44:29 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 18:44:29 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 18:44:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TrAEAlsxTEenoYCpgNxOAg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 18:44:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TrAEAlsxTEenoYCpgNxOAg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 18:44:29 INFO - Fetch https://queue.taskcluster.net/v1/task/TrAEAlsxTEenoYCpgNxOAg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 18:44:29 INFO - Http code: 200 18:44:29 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 18:44:29 INFO - x-amz-cf-id: vsqwyl-Dtyj7dzPNYRUHQosfGF7OfYI-nG--SIBz-_0ej7NPeQu5tQ== 18:44:29 INFO - x-amz-version-id: NkXmLLmeaSkPrSg3p1bDLsL22yvj698t 18:44:30 INFO - Expected file size: 16090511 18:44:30 INFO - Obtained file size: 16090511 18:44:37 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 18:44:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TrAEAlsxTEenoYCpgNxOAg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 18:44:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TrAEAlsxTEenoYCpgNxOAg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 18:44:37 INFO - Fetch https://queue.taskcluster.net/v1/task/TrAEAlsxTEenoYCpgNxOAg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 18:44:37 INFO - Http code: 200 18:44:37 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 18:44:37 INFO - x-amz-cf-id: EL6EFOrVlQUigE3_1tXFE_KjpXMPlkhcmyFT3KyYEIgXf57iswC9xQ== 18:44:37 INFO - x-amz-version-id: NkXmLLmeaSkPrSg3p1bDLsL22yvj698t 18:44:39 INFO - Expected file size: 16090511 18:44:39 INFO - Obtained file size: 16090511 18:44:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TrAEAlsxTEenoYCpgNxOAg/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 18:44:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TrAEAlsxTEenoYCpgNxOAg/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 18:44:45 INFO - Fetch https://queue.taskcluster.net/v1/task/TrAEAlsxTEenoYCpgNxOAg/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 18:44:46 INFO - Http code: 200 18:44:46 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 18:44:46 INFO - x-amz-cf-id: rZH7YxI_Zlwl5t_UWyfdHVjAbbgxODvB0WJRui3eiDCh7j9heaAc6w== 18:44:46 INFO - x-amz-version-id: wgjUgJs4NjcFvfoH_tkIt0evRc.Osh80 18:44:47 INFO - Expected file size: 14403005 18:44:47 INFO - Obtained file size: 14403005 18:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:44:48 INFO - trying https://queue.taskcluster.net/v1/task/TrAEAlsxTEenoYCpgNxOAg/artifacts/public/build/firefox-52.0.en-US.mac.dmg 18:44:48 INFO - Downloading https://queue.taskcluster.net/v1/task/TrAEAlsxTEenoYCpgNxOAg/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 18:44:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TrAEAlsxTEenoYCpgNxOAg/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 18:44:51 INFO - Downloaded 82143290 bytes. 18:44:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TrAEAlsxTEenoYCpgNxOAg/artifacts/public/build/firefox-52.0.en-US.mac.dmg 18:44:51 INFO - mkdir: /builds/slave/test/properties 18:44:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:44:51 INFO - Writing to file /builds/slave/test/properties/build_url 18:44:51 INFO - Contents: 18:44:51 INFO - build_url:https://queue.taskcluster.net/v1/task/TrAEAlsxTEenoYCpgNxOAg/artifacts/public/build/firefox-52.0.en-US.mac.dmg 18:44:52 INFO - Running post-action listener: _resource_record_post_action 18:44:52 INFO - Running post-action listener: set_extra_try_arguments 18:44:52 INFO - [mozharness: 2017-02-01 02:44:52.482011Z] Finished download-and-extract step (success) 18:44:52 INFO - [mozharness: 2017-02-01 02:44:52.482134Z] Running populate-webroot step. 18:44:52 INFO - Running pre-action listener: _resource_record_pre_action 18:44:52 INFO - Running main action method: populate_webroot 18:44:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:44:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:44:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:44:52 INFO - '--tppagecycles', 18:44:52 INFO - '7'], 18:44:52 INFO - 'tests': ['tsvgm']}}, 18:44:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:44:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:44:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:44:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:44:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:44:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:44:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:52 INFO - 'talos_options': ['--disable-e10s'], 18:44:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:44:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:44:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:52 INFO - 'talos_options': ['--disable-e10s'], 18:44:52 INFO - 'tests': ['damp', 'tps']}, 18:44:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:52 INFO - 'tests': ['damp', 'tps']}, 18:44:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:44:52 INFO - 'tests': ['dromaeo_dom']}, 18:44:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:44:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:44:52 INFO - 'tests': ['basic_compositor_video']}, 18:44:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:44:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:44:52 INFO - 'tests': ['a11yr', 18:44:52 INFO - 'ts_paint', 18:44:52 INFO - 'tpaint', 18:44:52 INFO - 'sessionrestore', 18:44:52 INFO - 'sessionrestore_no_auto_restore', 18:44:52 INFO - 'tabpaint']}, 18:44:52 INFO - 'other-e10s': {'tests': ['a11yr', 18:44:52 INFO - 'ts_paint', 18:44:52 INFO - 'tpaint', 18:44:52 INFO - 'sessionrestore', 18:44:52 INFO - 'sessionrestore_no_auto_restore', 18:44:52 INFO - 'tabpaint']}, 18:44:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:44:52 INFO - 'ts_paint', 18:44:52 INFO - 'tpaint', 18:44:52 INFO - 'sessionrestore', 18:44:52 INFO - 'sessionrestore_no_auto_restore', 18:44:52 INFO - 'tabpaint']}, 18:44:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:44:52 INFO - 'ts_paint', 18:44:52 INFO - 'tpaint', 18:44:52 INFO - 'sessionrestore', 18:44:52 INFO - 'sessionrestore_no_auto_restore', 18:44:52 INFO - 'tabpaint']}, 18:44:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:44:52 INFO - 'tests': ['a11yr', 18:44:52 INFO - 'ts_paint', 18:44:52 INFO - 'tpaint', 18:44:52 INFO - 'sessionrestore', 18:44:52 INFO - 'sessionrestore_no_auto_restore', 18:44:52 INFO - 'tabpaint']}, 18:44:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:44:52 INFO - 'tests': ['a11yr', 18:44:52 INFO - 'ts_paint', 18:44:52 INFO - 'tpaint', 18:44:52 INFO - 'sessionrestore', 18:44:52 INFO - 'sessionrestore_no_auto_restore', 18:44:52 INFO - 'tabpaint']}, 18:44:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:44:52 INFO - 'tests': ['tsvgx', 18:44:52 INFO - 'tsvgr_opacity', 18:44:52 INFO - 'tart', 18:44:52 INFO - 'tscrollx', 18:44:52 INFO - 'cart']}, 18:44:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:44:52 INFO - 'tsvgr_opacity', 18:44:52 INFO - 'tart', 18:44:52 INFO - 'tscrollx', 18:44:52 INFO - 'cart']}, 18:44:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:52 INFO - 'talos_options': ['--disable-e10s'], 18:44:52 INFO - 'tests': ['tp5o']}, 18:44:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:52 INFO - 'tests': ['tp5o']}, 18:44:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:52 INFO - 'talos_options': ['--disable-e10s', 18:44:52 INFO - '--xperf_path', 18:44:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:44:52 INFO - 'tests': ['tp5n']}, 18:44:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:52 INFO - 'talos_options': ['--xperf_path', 18:44:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:44:52 INFO - 'tests': ['tp5n']}}, 18:44:52 INFO - 'talos.zip': {'path': '', 18:44:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:44:52 INFO - Running post-action listener: _resource_record_post_action 18:44:52 INFO - [mozharness: 2017-02-01 02:44:52.500626Z] Finished populate-webroot step (success) 18:44:52 INFO - [mozharness: 2017-02-01 02:44:52.500731Z] Running create-virtualenv step. 18:44:52 INFO - Running pre-action listener: _resource_record_pre_action 18:44:52 INFO - Running main action method: create_virtualenv 18:44:52 INFO - Creating virtualenv /builds/slave/test/build/venv 18:44:52 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 18:44:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:44:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:44:52 INFO - Using real prefix '/tools/python27' 18:44:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:44:53 INFO - Installing distribute.............................................................................................................................................................................................done. 18:44:56 INFO - Installing pip.................done. 18:44:56 INFO - Return code: 0 18:44:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:44:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:44:56 INFO - Reading from file tmpfile_stdout 18:44:56 INFO - Output received: 18:44:56 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:44:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:44:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:44:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:56 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 0x107f0a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e80570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa33d83cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d1ed30>, '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 0x107b84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d16b20>, '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.a9LXjBr8nM/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.gIAp65564H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 18:44:56 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 18:44:56 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 18:44:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a9LXjBr8nM/Render', 18:44:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:44:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:44:56 INFO - 'HOME': '/Users/cltbld', 18:44:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:44:56 INFO - 'LOGNAME': 'cltbld', 18:44:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:56 INFO - 'MOZ_NO_REMOTE': '1', 18:44:56 INFO - 'NO_EM_RESTART': '1', 18:44:56 INFO - 'PAGER': '/bin/cat', 18:44:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:44:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:56 INFO - 'PWD': '/builds/slave/test', 18:44:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:44:56 INFO - 'SHELL': '/bin/bash', 18:44:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIAp65564H/Listeners', 18:44:56 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 18:44:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:44:56 INFO - 'USER': 'cltbld', 18:44:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:44:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:44:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:56 INFO - 'XPC_FLAGS': '0x0', 18:44:56 INFO - 'XPC_SERVICE_NAME': '0', 18:44:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:44:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:56 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 18:44:56 INFO - Cleaning up... 18:44:56 INFO - Return code: 0 18:44:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:44:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:44:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f0a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e80570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa33d83cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d1ed30>, '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 0x107b84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d16b20>, '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.a9LXjBr8nM/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.gIAp65564H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 18:44:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:44:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:44:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a9LXjBr8nM/Render', 18:44:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:44:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:44:56 INFO - 'HOME': '/Users/cltbld', 18:44:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:44:56 INFO - 'LOGNAME': 'cltbld', 18:44:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:56 INFO - 'MOZ_NO_REMOTE': '1', 18:44:56 INFO - 'NO_EM_RESTART': '1', 18:44:56 INFO - 'PAGER': '/bin/cat', 18:44:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:44:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:56 INFO - 'PWD': '/builds/slave/test', 18:44:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:44:56 INFO - 'SHELL': '/bin/bash', 18:44:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIAp65564H/Listeners', 18:44:56 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 18:44:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:44:56 INFO - 'USER': 'cltbld', 18:44:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:44:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:44:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:56 INFO - 'XPC_FLAGS': '0x0', 18:44:56 INFO - 'XPC_SERVICE_NAME': '0', 18:44:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:44:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:57 INFO - Downloading/unpacking psutil>=3.1.1 18:44: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 18:44: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 18:44: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 18:44: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 18:44: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 18:44: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 18:45:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:45:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:45:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:45:00 INFO - Installing collected packages: psutil 18:45:00 INFO - Running setup.py install for psutil 18:45:00 INFO - building 'psutil._psutil_osx' extension 18:45:00 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 18:45:01 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 18:45:01 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 18:45:01 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 18:45:01 INFO - building 'psutil._psutil_posix' extension 18:45:01 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 18:45:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:45:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:45:01 INFO - ^ 18:45:01 INFO - 1 warning generated. 18:45:01 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 18:45:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:45:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:45:01 INFO - Successfully installed psutil 18:45:01 INFO - Cleaning up... 18:45:01 INFO - Return code: 0 18:45:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:45:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:45:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f0a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e80570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa33d83cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d1ed30>, '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 0x107b84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d16b20>, '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.a9LXjBr8nM/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.gIAp65564H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 18:45:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:45:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:45:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a9LXjBr8nM/Render', 18:45:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:45:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:45:01 INFO - 'HOME': '/Users/cltbld', 18:45:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:45:01 INFO - 'LOGNAME': 'cltbld', 18:45:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:01 INFO - 'MOZ_NO_REMOTE': '1', 18:45:01 INFO - 'NO_EM_RESTART': '1', 18:45:01 INFO - 'PAGER': '/bin/cat', 18:45:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:45:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:01 INFO - 'PWD': '/builds/slave/test', 18:45:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:45:01 INFO - 'SHELL': '/bin/bash', 18:45:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIAp65564H/Listeners', 18:45:01 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 18:45:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:45:01 INFO - 'USER': 'cltbld', 18:45:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:45:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:45:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:01 INFO - 'XPC_FLAGS': '0x0', 18:45:01 INFO - 'XPC_SERVICE_NAME': '0', 18:45:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:45:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:45: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 18:45: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 18:45: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 18:45: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 18:45: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 18:45: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 18:45:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:45:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:45:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:45:04 INFO - Installing collected packages: mozsystemmonitor 18:45:04 INFO - Running setup.py install for mozsystemmonitor 18:45:04 INFO - Successfully installed mozsystemmonitor 18:45:04 INFO - Cleaning up... 18:45:04 INFO - Return code: 0 18:45:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:45:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f0a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e80570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa33d83cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d1ed30>, '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 0x107b84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d16b20>, '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.a9LXjBr8nM/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.gIAp65564H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 18:45:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:45:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:45:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a9LXjBr8nM/Render', 18:45:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:45:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:45:04 INFO - 'HOME': '/Users/cltbld', 18:45:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:45:04 INFO - 'LOGNAME': 'cltbld', 18:45:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:04 INFO - 'MOZ_NO_REMOTE': '1', 18:45:04 INFO - 'NO_EM_RESTART': '1', 18:45:04 INFO - 'PAGER': '/bin/cat', 18:45:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:45:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:04 INFO - 'PWD': '/builds/slave/test', 18:45:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:45:04 INFO - 'SHELL': '/bin/bash', 18:45:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIAp65564H/Listeners', 18:45:04 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 18:45:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:45:04 INFO - 'USER': 'cltbld', 18:45:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:45:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:45:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:04 INFO - 'XPC_FLAGS': '0x0', 18:45:04 INFO - 'XPC_SERVICE_NAME': '0', 18:45:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:05 INFO - Downloading/unpacking jsonschema==2.5.1 18:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:45:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:45:07 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 18:45:07 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 18:45:07 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 18:45:07 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 18:45:07 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 18:45:07 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 18:45:08 INFO - Downloading functools32-3.2.3-2.tar.gz 18:45:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:45:08 INFO - warning: no files found matching '*.txt' 18:45:08 INFO - no previously-included directories found matching 'build' 18:45:08 INFO - no previously-included directories found matching 'dist' 18:45:08 INFO - no previously-included directories found matching '.git*' 18:45:08 INFO - Installing collected packages: jsonschema, functools32 18:45:08 INFO - Running setup.py install for functools32 18:45:08 INFO - warning: no files found matching '*.txt' 18:45:08 INFO - no previously-included directories found matching 'build' 18:45:08 INFO - no previously-included directories found matching 'dist' 18:45:08 INFO - no previously-included directories found matching '.git*' 18:45:08 INFO - Successfully installed jsonschema functools32 18:45:08 INFO - Cleaning up... 18:45:08 INFO - Return code: 0 18:45:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:45:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f0a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e80570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa33d83cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d1ed30>, '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 0x107b84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d16b20>, '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.a9LXjBr8nM/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.gIAp65564H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 18:45:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:45:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:45:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a9LXjBr8nM/Render', 18:45:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:45:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:45:08 INFO - 'HOME': '/Users/cltbld', 18:45:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:45:08 INFO - 'LOGNAME': 'cltbld', 18:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:08 INFO - 'MOZ_NO_REMOTE': '1', 18:45:08 INFO - 'NO_EM_RESTART': '1', 18:45:08 INFO - 'PAGER': '/bin/cat', 18:45:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:08 INFO - 'PWD': '/builds/slave/test', 18:45:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:45:08 INFO - 'SHELL': '/bin/bash', 18:45:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIAp65564H/Listeners', 18:45:08 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 18:45:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:45:08 INFO - 'USER': 'cltbld', 18:45:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:45:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:08 INFO - 'XPC_FLAGS': '0x0', 18:45:08 INFO - 'XPC_SERVICE_NAME': '0', 18:45:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:45:08 INFO - Cleaning up... 18:45:08 INFO - Return code: 0 18:45:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:45:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:08 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 0x107f0a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e80570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa33d83cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d1ed30>, '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 0x107b84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d16b20>, '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.a9LXjBr8nM/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.gIAp65564H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 18:45:08 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 18:45:08 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 18:45:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a9LXjBr8nM/Render', 18:45:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:45:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:45:08 INFO - 'HOME': '/Users/cltbld', 18:45:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:45:08 INFO - 'LOGNAME': 'cltbld', 18:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:08 INFO - 'MOZ_NO_REMOTE': '1', 18:45:08 INFO - 'NO_EM_RESTART': '1', 18:45:08 INFO - 'PAGER': '/bin/cat', 18:45:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:08 INFO - 'PWD': '/builds/slave/test', 18:45:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:45:08 INFO - 'SHELL': '/bin/bash', 18:45:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIAp65564H/Listeners', 18:45:08 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 18:45:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:45:08 INFO - 'USER': 'cltbld', 18:45:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:45:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:08 INFO - 'XPC_FLAGS': '0x0', 18:45:08 INFO - 'XPC_SERVICE_NAME': '0', 18:45:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:08 INFO - Downloading/unpacking blobuploader==1.2.4 18:45:08 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 18:45:08 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 18:45:08 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 18:45:08 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 18:45:08 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 18:45:08 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 18:45:11 INFO - Downloading blobuploader-1.2.4.tar.gz 18:45:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:45:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:45: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 18:45: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 18:45: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 18:45: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 18:45: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 18:45: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 18:45:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:45:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:45:12 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 18:45:12 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 18:45:12 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 18:45:12 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 18:45:12 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 18:45:12 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 18:45:12 INFO - Downloading docopt-0.6.1.tar.gz 18:45:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:45:12 INFO - Installing collected packages: blobuploader, requests, docopt 18:45:12 INFO - Running setup.py install for blobuploader 18:45:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:45:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:45:13 INFO - Running setup.py install for requests 18:45:13 INFO - Running setup.py install for docopt 18:45:13 INFO - Successfully installed blobuploader requests docopt 18:45:13 INFO - Cleaning up... 18:45:13 INFO - Return code: 0 18:45:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:45:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:13 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 0x107f0a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e80570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa33d83cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d1ed30>, '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 0x107b84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d16b20>, '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.a9LXjBr8nM/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.gIAp65564H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 18:45:13 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 18:45:13 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 18:45:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a9LXjBr8nM/Render', 18:45:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:45:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:45:13 INFO - 'HOME': '/Users/cltbld', 18:45:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:45:13 INFO - 'LOGNAME': 'cltbld', 18:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:13 INFO - 'MOZ_NO_REMOTE': '1', 18:45:13 INFO - 'NO_EM_RESTART': '1', 18:45:13 INFO - 'PAGER': '/bin/cat', 18:45:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:13 INFO - 'PWD': '/builds/slave/test', 18:45:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:45:13 INFO - 'SHELL': '/bin/bash', 18:45:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIAp65564H/Listeners', 18:45:13 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 18:45:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:45:13 INFO - 'USER': 'cltbld', 18:45:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:45:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:13 INFO - 'XPC_FLAGS': '0x0', 18:45:13 INFO - 'XPC_SERVICE_NAME': '0', 18:45:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:45:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:45:14 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-B3yKVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:45:14 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-UA7xYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:45:14 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-YJafr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:45:14 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-tM1Xy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:45:14 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-EnPyCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:45:14 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-s9icXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:45:14 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-DU1e5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:45:14 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-BuyAin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:45:14 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-UwxNJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:45:14 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-pH1yVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:45:15 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-Bjwv6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:45:15 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-sN3tRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:45:15 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-ZTa5hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:45:15 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-JilstI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:45:15 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-ceFn7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:45:15 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-xGTMNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:45:15 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-Aqvtxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:45:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:45:15 INFO - Running setup.py install for manifestparser 18:45:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:45:15 INFO - Running setup.py install for mozcrash 18:45:16 INFO - Running setup.py install for mozdebug 18:45:16 INFO - Running setup.py install for mozdevice 18:45:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:45:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:45:16 INFO - Running setup.py install for mozfile 18:45:16 INFO - Running setup.py install for mozhttpd 18:45:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:45:16 INFO - Running setup.py install for mozinfo 18:45:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:45:16 INFO - Running setup.py install for mozInstall 18:45:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:45:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:45:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:45:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:45:16 INFO - Running setup.py install for mozleak 18:45:17 INFO - Running setup.py install for mozlog 18:45:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:45:17 INFO - Running setup.py install for moznetwork 18:45:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:45:17 INFO - Running setup.py install for mozprocess 18:45:17 INFO - Running setup.py install for mozprofile 18:45:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:45:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:45:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:45:17 INFO - Running setup.py install for mozrunner 18:45:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:45:17 INFO - Running setup.py install for mozscreenshot 18:45:18 INFO - Running setup.py install for moztest 18:45:18 INFO - Running setup.py install for mozversion 18:45:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:45:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:45:18 INFO - Cleaning up... 18:45:18 INFO - Return code: 0 18:45:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:45:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:19 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 0x107f0a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e80570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa33d83cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d1ed30>, '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 0x107b84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d16b20>, '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.a9LXjBr8nM/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.gIAp65564H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 18:45:19 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 18:45:19 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 18:45:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a9LXjBr8nM/Render', 18:45:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:45:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:45:19 INFO - 'HOME': '/Users/cltbld', 18:45:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:45:19 INFO - 'LOGNAME': 'cltbld', 18:45:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:19 INFO - 'MOZ_NO_REMOTE': '1', 18:45:19 INFO - 'NO_EM_RESTART': '1', 18:45:19 INFO - 'PAGER': '/bin/cat', 18:45:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:45:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:19 INFO - 'PWD': '/builds/slave/test', 18:45:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:45:19 INFO - 'SHELL': '/bin/bash', 18:45:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIAp65564H/Listeners', 18:45:19 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 18:45:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:45:19 INFO - 'USER': 'cltbld', 18:45:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:45:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:45:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:19 INFO - 'XPC_FLAGS': '0x0', 18:45:19 INFO - 'XPC_SERVICE_NAME': '0', 18:45:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:45:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:45:19 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-_cwbVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:45:19 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)) 18:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:45:19 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-TTcy0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:45:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:45:19 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-BIj8hR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:45:19 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)) 18:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:45:19 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-sbaz9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:45:19 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)) 18:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:45:19 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-Bf9BJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:45:19 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)) 18:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:45:19 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-7dYNEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:45:20 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)) 18:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:45:20 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-O9xjtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:45:20 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)) 18:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:45:20 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-ChkB1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:45:20 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)) 18:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:45:20 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-T3IVsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:45:20 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)) 18:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:45:20 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-0CLObw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:45:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:45:20 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-pnHAKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:45:20 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)) 18:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:45:20 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-JtxYj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:45:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:45:20 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-iJ62Sf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:45:20 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)) 18:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:45:20 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-czZFZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:45:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:45:20 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-yaxCPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:45:21 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)) 18:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:45:21 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-rAEZR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:45:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:45:21 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-_QrzEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:45:21 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)) 18:45:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:45:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:45:21 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)) 18:45:21 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)) 18:45:21 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)) 18:45:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:45:21 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 18:45:21 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 18:45:21 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 18:45:21 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 18:45:21 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 18:45:21 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 18:45:24 INFO - Downloading blessings-1.6.tar.gz 18:45:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:45:24 INFO - Installing collected packages: blessings 18:45:24 INFO - Running setup.py install for blessings 18:45:24 INFO - Successfully installed blessings 18:45:24 INFO - Cleaning up... 18:45:24 INFO - Return code: 0 18:45:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:45:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:45:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:45:24 INFO - Reading from file tmpfile_stdout 18:45:24 INFO - Current package versions: 18:45:24 INFO - blessings == 1.6 18:45:24 INFO - blobuploader == 1.2.4 18:45:24 INFO - docopt == 0.6.1 18:45:24 INFO - functools32 == 3.2.3-2 18:45:24 INFO - jsonschema == 2.5.1 18:45:24 INFO - manifestparser == 1.1 18:45:24 INFO - mozInstall == 1.12 18:45:24 INFO - mozcrash == 1.0 18:45:24 INFO - mozdebug == 0.1 18:45:24 INFO - mozdevice == 0.48 18:45:24 INFO - mozfile == 1.2 18:45:24 INFO - mozhttpd == 0.7 18:45:24 INFO - mozinfo == 0.9 18:45:24 INFO - mozleak == 0.1 18:45:24 INFO - mozlog == 3.4 18:45:24 INFO - moznetwork == 0.27 18:45:24 INFO - mozprocess == 0.23 18:45:24 INFO - mozprofile == 0.28 18:45:24 INFO - mozrunner == 6.13 18:45:24 INFO - mozscreenshot == 0.1 18:45:24 INFO - mozsystemmonitor == 0.3 18:45:24 INFO - moztest == 0.8 18:45:24 INFO - mozversion == 1.4 18:45:24 INFO - psutil == 3.1.1 18:45:24 INFO - requests == 1.2.3 18:45:24 INFO - wsgiref == 0.1.2 18:45:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:45:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:45:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:24 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 0x107f0a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e80570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa33d83cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d1ed30>, '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 0x107b84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d16b20>, '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.a9LXjBr8nM/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.gIAp65564H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 18:45:24 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 18:45:24 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 18:45:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a9LXjBr8nM/Render', 18:45:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:45:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:45:24 INFO - 'HOME': '/Users/cltbld', 18:45:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:45:24 INFO - 'LOGNAME': 'cltbld', 18:45:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:24 INFO - 'MOZ_NO_REMOTE': '1', 18:45:24 INFO - 'NO_EM_RESTART': '1', 18:45:24 INFO - 'PAGER': '/bin/cat', 18:45:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:45:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:24 INFO - 'PWD': '/builds/slave/test', 18:45:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:45:24 INFO - 'SHELL': '/bin/bash', 18:45:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIAp65564H/Listeners', 18:45:24 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 18:45:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:45:24 INFO - 'USER': 'cltbld', 18:45:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:45:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:45:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:24 INFO - 'XPC_FLAGS': '0x0', 18:45:24 INFO - 'XPC_SERVICE_NAME': '0', 18:45:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:45:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:25 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)) 18:45:25 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)) 18:45:25 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)) 18:45:25 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)) 18:45:25 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)) 18:45:25 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)) 18:45:25 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)) 18:45:25 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)) 18:45:25 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)) 18:45:25 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)) 18:45:25 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)) 18:45:25 INFO - Cleaning up... 18:45:25 INFO - Return code: 0 18:45:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:45:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:45:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:25 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 0x107f0a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e80570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa33d83cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d1ed30>, '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 0x107b84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d16b20>, '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.a9LXjBr8nM/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.gIAp65564H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 18:45:25 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 18:45:25 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 18:45:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a9LXjBr8nM/Render', 18:45:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:45:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:45:25 INFO - 'HOME': '/Users/cltbld', 18:45:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:45:25 INFO - 'LOGNAME': 'cltbld', 18:45:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:25 INFO - 'MOZ_NO_REMOTE': '1', 18:45:25 INFO - 'NO_EM_RESTART': '1', 18:45:25 INFO - 'PAGER': '/bin/cat', 18:45:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:45:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:25 INFO - 'PWD': '/builds/slave/test', 18:45:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:45:25 INFO - 'SHELL': '/bin/bash', 18:45:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIAp65564H/Listeners', 18:45:25 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 18:45:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:45:25 INFO - 'USER': 'cltbld', 18:45:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:45:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:45:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:25 INFO - 'XPC_FLAGS': '0x0', 18:45:25 INFO - 'XPC_SERVICE_NAME': '0', 18:45:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:45:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:45:25 INFO - Cleaning up... 18:45:25 INFO - Return code: 0 18:45:25 INFO - Running post-action listener: _resource_record_post_action 18:45:25 INFO - Running post-action listener: _start_resource_monitoring 18:45:25 INFO - Starting resource monitoring. 18:45:25 INFO - [mozharness: 2017-02-01 02:45:25.357532Z] Finished create-virtualenv step (success) 18:45:25 INFO - [mozharness: 2017-02-01 02:45:25.358479Z] Running install step. 18:45:25 INFO - Running pre-action listener: _resource_record_pre_action 18:45:25 INFO - Running main action method: install 18:45:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:45:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:45:25 INFO - Reading from file tmpfile_stdout 18:45:25 INFO - Detecting whether we're running mozinstall >=1.0... 18:45:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:45:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:45:25 INFO - Reading from file tmpfile_stdout 18:45:25 INFO - Output received: 18:45:25 INFO - Usage: mozinstall [options] installer 18:45:25 INFO - Options: 18:45:25 INFO - -h, --help show this help message and exit 18:45:25 INFO - -d DEST, --destination=DEST 18:45:25 INFO - Directory to install application into. [default: 18:45:25 INFO - "/builds/slave/test"] 18:45:25 INFO - --app=APP Application being installed. [default: firefox] 18:45:25 INFO - mkdir: /builds/slave/test/build/application 18:45:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:45:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 18:45:47 INFO - Reading from file tmpfile_stdout 18:45:47 INFO - Output received: 18:45:47 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 18:45:47 INFO - Running post-action listener: _resource_record_post_action 18:45:47 INFO - [mozharness: 2017-02-01 02:45:47.244659Z] Finished install step (success) 18:45:47 INFO - [mozharness: 2017-02-01 02:45:47.244779Z] Running run-tests step. 18:45:47 INFO - Running pre-action listener: _resource_record_pre_action 18:45:47 INFO - Running main action method: run_tests 18:45:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:45:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:45:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:45:47 INFO - 2017-01-31 18:45:47.259 screenresolution[1625:7408] starting screenresolution argv=screenresolution get 18:45:47 INFO - 2017-01-31 18:45:47.262 screenresolution[1625:7408] Display 0: 1600x1200x32@60 18:45:47 INFO - 2017-01-31 18:45:47.267 screenresolution[1626:7410] starting screenresolution argv=screenresolution list 18:45:47 INFO - Available Modes on Display 0 18:45:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:45:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:45:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:45:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:45:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:45:47 INFO - Intel Iris: 18:45:47 INFO - Chipset Model: Intel Iris 18:45:47 INFO - Type: GPU 18:45:47 INFO - Bus: Built-In 18:45:47 INFO - VRAM (Dynamic, Max): 1536 MB 18:45:47 INFO - Vendor: Intel (0x8086) 18:45:47 INFO - Device ID: 0x0a2e 18:45:47 INFO - Revision ID: 0x0009 18:45:47 INFO - Displays: 18:45:47 INFO - Display: 18:45:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:45:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:45:47 INFO - Display Serial Number: 1600x1200 60 18:45:47 INFO - Main Display: Yes 18:45:47 INFO - Mirror: Off 18:45:47 INFO - Online: Yes 18:45:47 INFO - Rotation: Supported 18:45:47 INFO - Return code: 0 18:45:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:45:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:45:47 INFO - Python 2.7.3 18:45:47 INFO - Return code: 0 18:45:47 INFO - grabbing minidump binary from tooltool 18:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:45:47 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d1ed30>, '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 0x107b84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d16b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:45:47 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 18:45:47 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 18:45:47 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:45:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:45:47 INFO - Return code: 0 18:45:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:45:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:45:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:45:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:45:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:45: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', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TrAEAlsxTEenoYCpgNxOAg/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0359', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:45: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 --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TrAEAlsxTEenoYCpgNxOAg/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0359 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:45:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a9LXjBr8nM/Render', 18:45:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:45:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:45:47 INFO - 'HOME': '/Users/cltbld', 18:45:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:45:47 INFO - 'LOGNAME': 'cltbld', 18:45:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:45:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:47 INFO - 'MOZ_NO_REMOTE': '1', 18:45:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:45:47 INFO - 'NO_EM_RESTART': '1', 18:45:47 INFO - 'PAGER': '/bin/cat', 18:45:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:47 INFO - 'PWD': '/builds/slave/test', 18:45:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:45:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:45:47 INFO - 'SHELL': '/bin/bash', 18:45:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIAp65564H/Listeners', 18:45:47 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 18:45:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:45:47 INFO - 'USER': 'cltbld', 18:45:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:45:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:47 INFO - 'XPC_FLAGS': '0x0', 18:45:47 INFO - 'XPC_SERVICE_NAME': '0', 18:45:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:45: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', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TrAEAlsxTEenoYCpgNxOAg/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0359', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:45:47 INFO - mozversion application_buildid: 20170131164508 18:45:47 INFO - mozversion application_changeset: f39a49e249ecea5f35bc096657fc778619ba60fd 18:45:47 INFO - mozversion application_display_name: Firefox 18:45:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:45:47 INFO - mozversion application_name: Firefox 18:45:47 INFO - mozversion application_remotingname: firefox 18:45:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 18:45:47 INFO - mozversion application_vendor: Mozilla 18:45:47 INFO - mozversion application_version: 52.0 18:45:47 INFO - mozversion platform_buildid: 20170131164508 18:45:47 INFO - mozversion platform_changeset: f39a49e249ecea5f35bc096657fc778619ba60fd 18:45:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 18:45:47 INFO - mozversion platform_version: 52.0 18:45:47 INFO - using testdate: 1485917147 18:45:47 INFO - actual date: 1485917147 18:45:47 INFO - starting webserver on 'localhost:49243' 18:45:47 INFO - SUITE-START | Running 2 tests 18:45:47 INFO - TEST-START | dromaeo_css 18:45:47 INFO - operating with platform_type : mac_ 18:45:47 INFO - Initialising browser for dromaeo_css test... 18:45:47 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/tmpJPuQkv/profile http://localhost:49243/getInfo.html) 18:45:50 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 18:45:50 INFO - PROCESS | 1636 | colorDepth:24 18:45:50 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 18:45:50 INFO - PROCESS | 1636 | __metrics 18:45:50 INFO - PROCESS | 1636 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:45:50 INFO - PROCESS | 1636 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:45:51 INFO - TEST-INFO | 1636: exit 0 18:45:51 INFO - Browser initialized. 18:45:51 INFO - Running cycle 1/1 for dromaeo_css test... 18:45:51 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/tmpJPuQkv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:46:03 INFO - PROCESS | 1639 | RSS: Main: 168255488 18:46:03 INFO - PROCESS | 1639 | 18:49:07 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 18:49:09 INFO - PROCESS | 1639 | RSS: Main: 328974336 18:49:09 INFO - PROCESS | 1639 | 18:52:11 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 18:52:12 INFO - PROCESS | 1639 | RSS: Main: 298553344 18:52:12 INFO - PROCESS | 1639 | 18:55:14 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 18:55:15 INFO - PROCESS | 1639 | RSS: Main: 270311424 18:55:15 INFO - PROCESS | 1639 | 18:58:17 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 18:58:18 INFO - PROCESS | 1639 | RSS: Main: 284639232 18:58:18 INFO - PROCESS | 1639 | 19:01:21 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 19:01:22 INFO - PROCESS | 1639 | RSS: Main: 256901120 19:01:22 INFO - PROCESS | 1639 | 19:04:25 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 19:04:25 INFO - PROCESS | 1639 | RSS: Main: 343363584 19:04:25 INFO - PROCESS | 1639 | 19:04:25 INFO - PROCESS | 1639 | __start_tp_report 19:04:25 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 19:04:25 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 19:04:25 INFO - PROCESS | 1639 | |i|pagename|runs| 19:04:25 INFO - PROCESS | 1639 | |0;dojo.html;3516.8944931652045;3560.537130173077;3561.430171172613;3580.373434648936;3618.077390265482;5944.524438044957;5962.850928726784;5979.760809567618;5993.970030149843;6034.607750496215;5927.940720592804;5979.491743201822;6018.337982821886;6034.306054803699;6037.852807966483;5127.48725127488;5342.519173274404;5359.7320133993335;5381.300430943972;5465.754041068161;5342.278792363039;5354.866128346784;5359.464053594648;5408.675479471244;5497.175423686439;5413.783448662049;5431.158170483582;5439.184122381635;5443.945560544384;5454.59090568207;5428.891422171554;5440.91838622421;5443.918341224865;5444.863878403032;5446.074167391553;5304.926073995799;5351.919721204185;5365.7853685852515;5372.91940620891;5382.8923421531745;6059.939400605982;6065;6066.545009124334;6067.2719273687;6083.543734219951;5882.999890018707;6273.247210334789;6325.462335701471;6327.335629758901;6357.93642063578;5519.420460851633;6304.401081897213;6306.495480361606;6339.2392912850755;6344.111824344595;6035.245594300713;6041.3354531002;6073.4533891949495;6108.4807791338235;6125.4487096160665;6255.530835187379;6309.936900631027;6321.209848768904;6335;6367.4906007519285;6235.189425374763;6297.622142671455;6312.24253089623;6313.652749098752;6320;6341.207349081365;6348.301686814447;6349.809505714744;6357.396047375492;6373.553851230369;6241.843953901189;6269.435750782452;6288.308286088527;6323.5889667172405;6338.366163383625;6282.937170628326;6297.968510157511;6317.684115794192;6319.8104056878365;6326.68366581669;5090.821821236239;5106.412762532356;5111.080005599028;5119.667221630657;5131.204663277198;4513.638908887281;4521.547845215518;4537.659675524349;4556.65825063115;4563.931541026887;5093.541581257705;6057.515398768088;6106.297775755845;6136.23297087864;6138.6623735694075;6352.6823658816875;6356.650384228819;6359.523035772336;6361.618302901748;6378.681065946684;5884.0585506318785;5937.7921772737745;5958.970205148947;6045.6070355426755;6111.54163437744;5594.916076258859;5606.523445507178;5617.241672374177;5653.208550802891;5676.631018983753;6553.246376666553;6573.3426657333885;6593.6703164841565;6612.272650008592;6643.103181070687;5307.310049693515;5432.864178395572;6234.127222188807;6272.6236425814595;6385.393387628168;6447.2263328400895;6494.512911531559;6512.381323774234;6581.703823327866;6598.208215014229;4856.31610456989;6324.968375158095;6330.651814150266;6350.206224221973;6361.077643741539;6287.695869476633;6289.654069026247;6353.078803573549;6357.841053973688;6366.586171898812;6194.783182588768;6209.937900620936;6242.406971337716;6301.023341382093;6340.080688300263;6119.877602448015;6156.353582873734;6319.58922670025;6344.777932772331;6351.047342898602;6129.540284478593;6221.160143380766;6238.313785483684;6253.530985176221;6267.9657856455;6161.599496032743;6206.968965155326;6226.719797609209;6237.438630523275;6343.460805831556;6257.7184026718;6260.530460215593;6263;6266.122742816101;6271.874562508633 19:04:25 INFO - PROCESS | 1639 | |1;ext.html;475.19217330538095;487.85111063445595;501.83188631808343;526.8761840967372;534.132035442406;31237.531437028436;33135.00594982151;41052.76841694754;42181.7890910545;42288.365674514906;43142.784286078604;43295.78352108235;43524;43581;43630.78184609072;9665.806683866336;9870.161036311922;9874.506274686237;9876.506174691236;9876.950615246913;8943.32925030622;9080.137386948229;9089.863652045224;9191.08089191079;9678.322517423783;10077.496125193748;11866.881331186663;12066.276023438579;12220.38898055098;12227.388630568435;11868.050555955546;11951.103667224992;11952.521899124025;11965.40172991347;11968.52125914958;11641.41792910351;11785.175037747362;11791.174617776673;11858.525658973631;11876.0499160067;41159.765207043834;41398.37902431466;41476.792616037026;41559.58440415618;41571.96070098242;3328.3509715605464;3371.4774209997245;3372.359251742161;3386.6274709781906;3413.675700808419;29315;29868.253293667614;29935.550966735518;30457.543136852964;31816;3216.1477208539754;3289.73682105431;3291.325278317939;3293.423650861114;3371.988403478971;501236;502136;504918;505417.99999999633;505657;34726.82636586801;35285.47071793874;35459.113522161635;63620;64197.35802642007;36218;36221.45667814932;36313.45529817055;36329.45505817415;36445.90662280136;12904.80642790359;15163.393464261526;15323.693526129415;15346.846531534542;15364.924455288023;12845.036622253368;12960.416781244867;12973.221606703628;12973.481060757653;12982.415791289415;7552.207018263003;7688.654010569538;7924.247196516321;7975;8017.719379821679;3349.648286929886;3365.3942290387963;3370.79775213488;3371.780834245766;3407.931841363159;945.177695405002;961.5672947173799;1036.4558606731525;1055.9894401056044;1085.278289937183;29912.850435748118;30212.24469388239;30314.090577282717;30526.847365763027;30741.23146921345;1076.3165389977264;1079.0396547073112;1081.9621313254156;1129.8700649425257;1144.2162118948547;15710.486322188624;16802.663946720997;16870.409535666193;16917.830821691627;17192.570185745455;645523;650035;650104;650411;651801;59815.70092149598;60332;60360.69819650874;60402.395976040556;60540;1158.5771193514474;1259.338847105277;1308.999999999981;1372.4853180057478;1415.7805540141294;30187.396252074395;31190.376192476477;31334.373312534077;31448.213794655316;31960.200994975312;51591.74204128955;52605;52607.94784104373;52644.21033684575;52817.7359113202;473494;560683;560690;561082;561199;24280.392990175387;24780.25659230226;24814.751852481244;27344.31639208956;27744.861275693493;38565.22869542649;41660.37509437421;42108;47730.1361918286;49743.005139896275;38643.613563864004;38652;39543.01142471461;40640.59359406486;40670.59329406668;38760;39120.80439597784;39465.40801888031;40197.397039043855;40286;37101.628983709816;38889;38898;39020;39022.80488597539;30359.241018974702;31254.687453125178;34277;34831.30337393187;34944.65055349414;22575.563943293528;26060.8696956514;26208;26301.605475917495;26465.603015955163 19:04:25 INFO - PROCESS | 1639 | |2;jquery.html;334.80748569572495;349.93876071687464;350.9105178179564;386.8510623409988;399.1697269679068;18767.967761773096;19592;20306.695399569;21143.365699029055;21357.252496162637;19236.90381548094;19871.801281987176;20487.59024819503;21096.472588185305;21150.576988460223;4177.33162693969;5482.2873026506595;5634.3520495143175;5678.034734095214;5691.857703557403;4026.335654616985;5456.672599644015;5557.888842223153;5561.304836895388;5562.582806289524;4208.642265407429;4253.2769429197115;5268.262443257947;5916.171735956969;6166.537509686769;5711.571632127607;5951.375105613892;6247.437730604244;6263.812085637438;6267.4045965633195;5847.56143289255;5865.266841644794;5873.148393482964;5874.060150375919;5885.85285367865;13771.862281377158;13857.099288546313;23126.84365781721;24415.511689766106;25368.61947070777;2190.769969153248;2260.9095636174534;2296.1389478945393;2404.747501512351;2792.176307989148;10398.584056637801;10460.633877814316;10606.363618182933;10806;13689.931550342184;1915.1956178405103;1927.8939658318786;1959.9608007839763;1962.0876292524044;1972.2702600037935;123212;123528;126505;127050.36474817566;131008;9173;10341.586336546454;10523.473826308655;10722.73193170177;10735.51690173944;12624.17942833713;12716.936415317865;12721.491140354283;12736.80894786579;12746.80879786804;8108.797280067927;8274.172582741678;8316.958415207886;8396.07643159252;8475.1524847516;8710.433821801562;8712.998005229352;8737.257333126629;8854.911450885409;8884.200421961925;3986.9202615948097;4036.57615950321;4051.169510250392;4095.5494895561465;4116.958830411658;1960.2551030608277;1981.8315443187203;1990.1442379776545;2005.2981456490404;2032.156654988193;702.4482387143479;781.1797612506845;824.8762685597209;930.6928713524657;932.3194068330157;21400.892995534923;22291.777082229295;22298.44253893633;22466.438339041328;22501.32496025089;755.5919803306153;866.358894418126;950.3110245072405;950.9857352139724;971.1259866120548;11274;11501.654950351503;11649.941750291195;11746.29522228669;11776.470058847372;616469;618801;626022;635236;636864;131163.3441832804;138739;140750;144812;146217;782.2920257167273;1037.7301901505664;1046.0899017854515;1049.7165765243494;1050.3330385205297;14813.703725925205;18101.366452174112;19371.709424358927;19401.835889846654;19408.223671053;42675.93310167271;55537;56406.5898352528;57431.42568574261;58229.12656310074;65478;79342;81292.59353703193;84923;87208;8264.380171487042;8266.545340006358;8325.458845175044;8629.611667474854;8695.608697608497;10093.69718908434;12622.43199056063;13111.475540978636;13522.93238533801;13784.379702913193;11509.424528773696;11579.478923448296;11580.768384632429;11586.76826463483;11885.762284754084;11211.71970700739;11436.1422893285;11515.769684606428;11577.479013444246;11900.285982841056;6011.368806275453;11708.473118709508;11747.355370248342;11774.175807693378;11834.822477663014;8384.41309108381;8450.746477605682;8473.237408633253;8526.147385261424;8541.01778295504;9846.704598862045;10256.12822910061;10884.564617415215;11661.475233614337;11695.473703683185 19:04:25 INFO - PROCESS | 1639 | |3;mootools.html;1251.5807204586463;1490.9478168264109;1633.322171298911;1852.6202128563646;1868.3740946782827;8249.175082491754;8644.135586441353;8670.176333248339;8672.43629164104;8674.956625216873;7683.116441609202;7910.169432209622;8151.184881511846;8392.160783921605;8426.115257897924;2347.7439569830144;2385.1413491143176;2387.3554140382084;2389.8685572293516;2390.988045059781;2393.066703985447;2409.277216834951;2414.915477958272;2431.3070774829175;2436.744141865105;2373.6439534069855;2376.489054853206;2399.700037495313;2402.6636270922086;2403.3631087761755;2224.788645078715;2372.78644921957;2395.3293077938206;2398.5442765874427;2400.4238982644215;2178.433607262107;2391.8804059797117;2396.508715713275;2402.7236867760257;2407.3500154958065;8402.579871006425;8474.406791524596;8494.660213591449;8514.957425212897;8526.957365213197;5131.358580177478;5288.418273989858;5296.761645725952;5297.814576489843;5298.549623282026;3252.6909943555324;3325.401427743005;3555.768875023115;3562.020444377791;3562.1628917204434;1075.3494136047734;1079.5843600213896;1094.261373572843;1111.1000089927186;1123.1464087293716;11006.889931100666;11073.224874258805;11124.110071194285;11125.443727813577;11136.610218642309;4536.841210557614;4620.976895115503;4706.976465117653;4721.055788842245;4805.207140821725;9562.856557151648;9576.090271424204;9594.184494317922;9623.903760962301;9661.951690241503;5269.341332333458;5272.736363181825;5272.815451459181;5295.099833028395;5301.814436494704;4319.4816622005565;4596.908061838744;4836.613070954315;4843.75781210938;4845.515448455127;3858.6720128789366;3867.149227170018;3931.6068393160454;3951.7628942263555;3968.9603103969166;1114.4706264524286;1274.6367285323638;1279.6033229698824;1287.8776516230944;1290.6902343437507;776.2198990014999;868.9023630756334;898.3711402018482;906.1708536688988;917.3624331089828;5557.888842223133;5698.202251684767;5744.971275143681;5894.528437724972;5992.041273396236;958.4536814015944;966.8211380894558;971.8104969531015;974.0940924939874;990.029770824596;3560.732945029133;3869.7678139311734;3902.3951287550476;4011.4183443401125;4032.6169013943627;9861.506924653882;10302;10413.9479302603;10414.010668986433;10431.68704938853;10375.377477351383;10379.221558383151;10387.532561034772;10396.584136634601;10409;7489.588072656056;7997.960010199912;8132.390070744717;8132.552709601029;8136.372725454933;5578.804741834017;5597.944020559742;5638.746256418389;5736.42635736423;5780.3352614448195;9270;9407.81184376295;9446.669366572138;9479.241660666992;9572.090651388107;9571.856422153813;9697.951510242403;9718.805623887341;9719.65981190655;9828.361156524803;6457.160569126171;6538.640374779433;6842.623655698984;6882;7025.894611580932;8074.798130046795;8158.388120891075;8164.795880102807;8176.427650064438;8185.672573097009;7147.53541019832;7206.459515536251;7281.308275713799;7305.1233851938105;7451;7057.117860267466;7166.53417527859;7169.390601798906;7310.59791711461;7338;6770.2891196425635;6792.490563207878;6825.965870170618;6836.658167091725;6868.553544019623;4876.785207250844;4969.428515720739;4976.900461990812;5023.447420783784;5032.194848824171;4770.141374552614;4901.411830580353;4913.680610760289;5021.397432308147;5053.545180933734 19:04:25 INFO - PROCESS | 1639 | |4;prototype.html;297.8153544802224;302.3786119524377;309.6671078590515;315.55506735502945;316.703881870451;4489.595936365727;5314.176302673082;5333.413324534298;5356.250124982505;5386.407495175533;4398.824047038114;4577.109456961581;5150.635081703352;5187.533122019017;5269.86825329367;3041.7870749047465;4071.6131967463193;4088.0786030565737;4098.569650186725;4103.199876024177;3572.6427357264197;3909.6481316681493;3942.6254505821903;4149.3983372410985;4157.875263742078;3925.7055720821054;4033.556308806029;4046.6560342370785;4088.3049881520215;4097.9180416391655;4031.871076098697;4038.4144299076615;4047.291723948297;4052.3516237402023;4057.452243947059;3524.4360902255517;3536.5932917714536;3541.4240662905017;3549.8757543485854;3552.8045957472327;4648.071050514032;4669.719816811003;4973.701577905337;5217.895642087175;5271.262023316739;3882.650561449483;3894.396368562849;4548.474931927783;4601.699150424788;4653.7207767534055;5251.55361794248;5546.611737178399;5562.554995600342;5563.415841336682;5571.609987300891;3339.482380231068;3633.3459977204093;3863.4784304118866;3884.7863367514774;3888.5333759948703;5463.644863083927;5666.49001589863;5811.820567287267;5828.591998560102;5868.735906884201;3731.8320675569666;3861.806909654506;3918.7648741075627;3925.4700615417123;3973.9602603974167;3999.8800035998966;4004.379321205218;4018.9799051004557;4025.396190571379;4025.5169379674626;3846.9997800572055;4170.9582904171175;4507.752073635981;4646.326282689059;4698.671093023524;4895.534924182197;5077.644564880497;5474.850281440942;5513.7794488220825;5691.09348368293;1093.2729734726477;1140.5152810055692;1225.2036176485356;1280.4442602238325;1298.4741179822188;836.7406104107746;896.820635872828;903.9909600904039;908.7137551671202;911.8313112074287;4242.681798865097;4456.487503937024;4921.753912304442;4931.852044438672;4933.703977761345;4581.427321584802;5270.446603106619;5468.343798744176;5502.422245664227;5521.941373090855;4134.896627584334;4399.846005389796;4768;4999.000399840093;5005.524475174852;2357.811375089989;2643.577027675601;2712.7521340183343;2858.3140046389135;2899.3331533747355;5306.575473962073;5409.404965453797;5528.281323427928;5555.694436805934;5646.22144024631;4682.929756053662;4747.121782470254;5580.7164352199225;5606.355269144101;5624.184493248456;4977.875553111129;5017.89964200714;5285.365756109291;5506.2291279221745;5833.912491312633;4287.549807270192;4877.317175595348;5240.71176085319;5499.752511137089;5551.417101204315;4537.886552836074;5034.546890779848;5173.586113111018;5377.768226186089;5526.392096869422;4934.593640812352;5212.661177023481;5456.127019676833;5678.0915053591225;5688;3182.95225571612;3737.8691745788765;3784.6215378461934;3863.4932376372676;3876.7092468064443;4820.807167713392;5087.542121209109;5716.371199168171;5750.712464376681;5752.395998420273;4983.953369792384;5252.242572649389;5407.83776486706;5688.715564221855;5693.772249109989;4951.950480495149;5065.56942659878;5164.922526162036;5645.802396916089;5686.459786320293;4686.992296656235;4799.496052914394;5519.724013799374;5549.528290095387;5569.972150139223;5050.570701490415;5232.901090770981;5339.119045357473;5608.298962629671;5620.803271885465;5543.8101949728825;5554.139363313174;5556.222128902038;5583.21337172101;5606.439356064361 19:04:25 INFO - PROCESS | 1639 | |5;yui.html;709.7444919828861;733.585524178839;781.9609019549025;809.3560770966081;835.4893544897582;14488.855111448882;15340.156291403968;15430.537083887473;15541.300641471133;15546.222688865553;13920.025598208129;14096;14101.929490352559;14121.929390353034;14125.43498260071;677.1501765284561;690.9309069093075;698.3505340033792;700.4711442860633;833.5582141465034;696.9965150174243;701.4633805139073;825.6325934958945;850.0054935725217;856.2550580994543;905.3752910491739;909.995450022749;914.5975770660921;917.6971599372191;918.8254231695956;906.7189171356868;908.7228395339419;912.4434095201922;913.0549880873265;914.0174312613966;676.8477092654163;679.178194384795;679.7315060551105;679.7994591595491;680.0445374249188;14053.016288859784;14230.786538201935;14298.57104286873;14378.85621143796;14936.477223297132;14044.85955140456;14051.297435128203;14604.561863144016;14709.55871323862;14748.336324865406;11169.83245251322;11545.711357216052;11560.364179970098;11571.495705558224;11679;3717.1450566369886;3910.843566257346;3938.6652134568594;3968.444417781513;4044.797760111983;86089.13910860936;86845;87504;87605;89470.552647237;10006.549705263134;10407.375557466576;10732.356058636351;10769.83845242322;10904.890951090547;19806.60386792256;20138.899305503674;20145.697814532792;20152.89923550402;20169;7641.121271053788;7672.347850432664;7673.3477654398885;7743.341815945595;7863.331616812635;4334.523202447728;4453.064856380196;4459.866204013885;4470.105978804252;4622.884427889329;3059.2046068022473;3472.201393679468;3592.317459682652;3594.101474631342;3594.9281014379567;646.5958775765147;669.6049330894796;675.42588799521;680.129434324066;686.289690170671;548.4296331814948;672.9865402691919;674.2650510943096;676.558929480204;706.336044118527;9488.620455181715;9631.759206019906;9632.90367096334;9745.61017559304;9898.455584942898;642.4539141729585;672.9327067293232;683.9863202735918;690.9067275917787;692.4771797293012;3845;4285.186184295979;4622.2835460503675;4718.127146477844;4937.7777999990085;115554;115644.6871062574;118206;118320;123856;68955;69486;104937.47531262295;105465;110992.78014439666;63713.681431592544;64485.35514644887;85756;89854;92706.0729392711;9930.503474826086;10153.593856245667;10190.745231369276;10199.439030853375;10244.436555989492;53229.73385133049;53784.193237102256;54394.45605543894;54766.72616636891;54975;63714.68142659257;78023;78263.82604260827;78771.60614196892;82485;11781.64223196385;12122.696687629323;12764.04269679759;13014.284214367923;13198.868011319764;12671.049671274506;13688.110272832235;14715.926420368258;15459;15624.218789060275;12157.69605759863;13522.18866867991;13755.587332380044;13818.516351928036;13980.650483737987;12775.233485990499;12793.488260469478;13273.66815829612;13678.726425471634;13781.173129612256;12885.677858053623;13306.002049846495;13476.191428514321;13546.93226533861;13976.720465590835;10532.36805791655;10617.416042117758;10852.348859068481;11372.43137843088;11766;11240.775184496428;11298.66104016848;11365.772684546428;11454.82817757751;11576.942115289707 19:04:25 INFO - PROCESS | 1639 | __end_tp_report 19:04:25 INFO - PROCESS | 1639 | __start_cc_report 19:04:25 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,1725 19:04:25 INFO - PROCESS | 1639 | __end_cc_report 19:04:25 INFO - PROCESS | 1639 | __startTimestamp1485918265457__endTimestamp 19:04:25 INFO - PROCESS | 1639 | 19:04:25 INFO - PROCESS | 1639 | ------- Summary: start ------- 19:04:25 INFO - PROCESS | 1639 | Number of tests: 6 19:04:25 INFO - PROCESS | 1639 | 19:04:25 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5903.60 Median:6156.35 stddev:635.18 (10.3%) stddev-sans-first:608.91 19:04:25 INFO - PROCESS | 1639 | Values: 3516.9 3560.5 3561.4 3580.4 3618.1 5944.5 5962.9 5979.8 5994.0 6034.6 5927.9 5979.5 6018.3 6034.3 6037.9 5127.5 5342.5 5359.7 5381.3 5465.8 5342.3 5354.9 5359.5 5408.7 5497.2 5413.8 5431.2 5439.2 5443.9 5454.6 5428.9 5440.9 5443.9 5444.9 5446.1 5304.9 5351.9 5365.8 5372.9 5382.9 6059.9 6065.0 6066.5 6067.3 6083.5 5883.0 6273.2 6325.5 6327.3 6357.9 5519.4 6304.4 6306.5 6339.2 6344.1 6035.2 6041.3 6073.5 6108.5 6125.4 6255.5 6309.9 6321.2 6335.0 6367.5 6235.2 6297.6 6312.2 6313.7 6320.0 6341.2 6348.3 6349.8 6357.4 6373.6 6241.8 6269.4 6288.3 6323.6 6338.4 6282.9 6298.0 6317.7 6319.8 6326.7 5090.8 5106.4 5111.1 5119.7 5131.2 4513.6 4521.5 4537.7 4556.7 4563.9 5093.5 6057.5 6106.3 6136.2 6138.7 6352.7 6356.7 6359.5 6361.6 6378.7 5884.1 5937.8 5959.0 6045.6 6111.5 5594.9 5606.5 5617.2 5653.2 5676.6 6553.2 6573.3 6593.7 6612.3 6643.1 5307.3 5432.9 6234.1 6272.6 6385.4 6447.2 6494.5 6512.4 6581.7 6598.2 4856.3 6325.0 6330.7 6350.2 6361.1 6287.7 6289.7 6353.1 6357.8 6366.6 6194.8 6209.9 6242.4 6301.0 6340.1 6119.9 6156.4 6319.6 6344.8 6351.0 6129.5 6221.2 6238.3 6253.5 6268.0 6161.6 6207.0 6226.7 6237.4 6343.5 6257.7 6260.5 6263.0 6266.1 6271.9 19:04:25 INFO - PROCESS | 1639 | 19:04:25 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:68727.39 Median:35115.06 stddev:152325.12 (433.8%) stddev-sans-first:152666.23 19:04:25 INFO - PROCESS | 1639 | Values: 475.2 487.9 501.8 526.9 534.1 31237.5 33135.0 41052.8 42181.8 42288.4 43142.8 43295.8 43524.0 43581.0 43630.8 9665.8 9870.2 9874.5 9876.5 9877.0 8943.3 9080.1 9089.9 9191.1 9678.3 10077.5 11866.9 12066.3 12220.4 12227.4 11868.1 11951.1 11952.5 11965.4 11968.5 11641.4 11785.2 11791.2 11858.5 11876.0 41159.8 41398.4 41476.8 41559.6 41572.0 3328.4 3371.5 3372.4 3386.6 3413.7 29315.0 29868.3 29935.6 30457.5 31816.0 3216.1 3289.7 3291.3 3293.4 3372.0 501236.0 502136.0 504918.0 505418.0 505657.0 34726.8 35285.5 35459.1 63620.0 64197.4 36218.0 36221.5 36313.5 36329.5 36445.9 12904.8 15163.4 15323.7 15346.8 15364.9 12845.0 12960.4 12973.2 12973.5 12982.4 7552.2 7688.7 7924.2 7975.0 8017.7 3349.6 3365.4 3370.8 3371.8 3407.9 945.2 961.6 1036.5 1056.0 1085.3 29912.9 30212.2 30314.1 30526.8 30741.2 1076.3 1079.0 1082.0 1129.9 1144.2 15710.5 16802.7 16870.4 16917.8 17192.6 645523.0 650035.0 650104.0 650411.0 651801.0 59815.7 60332.0 60360.7 60402.4 60540.0 1158.6 1259.3 1309.0 1372.5 1415.8 30187.4 31190.4 31334.4 31448.2 31960.2 51591.7 52605.0 52607.9 52644.2 52817.7 473494.0 560683.0 560690.0 561082.0 561199.0 24280.4 24780.3 24814.8 27344.3 27744.9 38565.2 41660.4 42108.0 47730.1 49743.0 38643.6 38652.0 39543.0 40640.6 40670.6 38760.0 39120.8 39465.4 40197.4 40286.0 37101.6 38889.0 38898.0 39020.0 39022.8 30359.2 31254.7 34277.0 34831.3 34944.7 22575.6 26060.9 26208.0 26301.6 26465.6 19:04:25 INFO - PROCESS | 1639 | 19:04:25 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:36286.93 Median:12711.49 stddev:104931.25 (825.5%) stddev-sans-first:105190.88 19:04:25 INFO - PROCESS | 1639 | Values: 334.8 349.9 350.9 386.9 399.2 18768.0 19592.0 20306.7 21143.4 21357.3 19236.9 19871.8 20487.6 21096.5 21150.6 4177.3 5482.3 5634.4 5678.0 5691.9 4026.3 5456.7 5557.9 5561.3 5562.6 4208.6 4253.3 5268.3 5916.2 6166.5 5711.6 5951.4 6247.4 6263.8 6267.4 5847.6 5865.3 5873.1 5874.1 5885.9 13771.9 13857.1 23126.8 24415.5 25368.6 2190.8 2260.9 2296.1 2404.7 2792.2 10398.6 10460.6 10606.4 10806.0 13689.9 1915.2 1927.9 1960.0 1962.1 1972.3 123212.0 123528.0 126505.0 127050.4 131008.0 9173.0 10341.6 10523.5 10722.7 10735.5 12624.2 12716.9 12721.5 12736.8 12746.8 8108.8 8274.2 8317.0 8396.1 8475.2 8710.4 8713.0 8737.3 8854.9 8884.2 3986.9 4036.6 4051.2 4095.5 4117.0 1960.3 1981.8 1990.1 2005.3 2032.2 702.4 781.2 824.9 930.7 932.3 21400.9 22291.8 22298.4 22466.4 22501.3 755.6 866.4 950.3 951.0 971.1 11274.0 11501.7 11649.9 11746.3 11776.5 616469.0 618801.0 626022.0 635236.0 636864.0 131163.3 138739.0 140750.0 144812.0 146217.0 782.3 1037.7 1046.1 1049.7 1050.3 14813.7 18101.4 19371.7 19401.8 19408.2 42675.9 55537.0 56406.6 57431.4 58229.1 65478.0 79342.0 81292.6 84923.0 87208.0 8264.4 8266.5 8325.5 8629.6 8695.6 10093.7 12622.4 13111.5 13522.9 13784.4 11509.4 11579.5 11580.8 11586.8 11885.8 11211.7 11436.1 11515.8 11577.5 11900.3 6011.4 11708.5 11747.4 11774.2 11834.8 8384.4 8450.7 8473.2 8526.1 8541.0 9846.7 10256.1 10884.6 11661.5 11695.5 19:04:25 INFO - PROCESS | 1639 | 19:04:25 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5558.19 Median:5271.04 stddev:3040.08 (57.7%) stddev-sans-first:3031.37 19:04:25 INFO - PROCESS | 1639 | Values: 1251.6 1490.9 1633.3 1852.6 1868.4 8249.2 8644.1 8670.2 8672.4 8675.0 7683.1 7910.2 8151.2 8392.2 8426.1 2347.7 2385.1 2387.4 2389.9 2391.0 2393.1 2409.3 2414.9 2431.3 2436.7 2373.6 2376.5 2399.7 2402.7 2403.4 2224.8 2372.8 2395.3 2398.5 2400.4 2178.4 2391.9 2396.5 2402.7 2407.4 8402.6 8474.4 8494.7 8515.0 8527.0 5131.4 5288.4 5296.8 5297.8 5298.5 3252.7 3325.4 3555.8 3562.0 3562.2 1075.3 1079.6 1094.3 1111.1 1123.1 11006.9 11073.2 11124.1 11125.4 11136.6 4536.8 4621.0 4707.0 4721.1 4805.2 9562.9 9576.1 9594.2 9623.9 9662.0 5269.3 5272.7 5272.8 5295.1 5301.8 4319.5 4596.9 4836.6 4843.8 4845.5 3858.7 3867.1 3931.6 3951.8 3969.0 1114.5 1274.6 1279.6 1287.9 1290.7 776.2 868.9 898.4 906.2 917.4 5557.9 5698.2 5745.0 5894.5 5992.0 958.5 966.8 971.8 974.1 990.0 3560.7 3869.8 3902.4 4011.4 4032.6 9861.5 10302.0 10413.9 10414.0 10431.7 10375.4 10379.2 10387.5 10396.6 10409.0 7489.6 7998.0 8132.4 8132.6 8136.4 5578.8 5597.9 5638.7 5736.4 5780.3 9270.0 9407.8 9446.7 9479.2 9572.1 9571.9 9698.0 9718.8 9719.7 9828.4 6457.2 6538.6 6842.6 6882.0 7025.9 8074.8 8158.4 8164.8 8176.4 8185.7 7147.5 7206.5 7281.3 7305.1 7451.0 7057.1 7166.5 7169.4 7310.6 7338.0 6770.3 6792.5 6826.0 6836.7 6868.6 4876.8 4969.4 4976.9 5023.4 5032.2 4770.1 4901.4 4913.7 5021.4 5053.5 19:04:25 INFO - PROCESS | 1639 | 19:04:25 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4410.05 Median:4926.80 stddev:1339.06 (27.2%) stddev-sans-first:1306.76 19:04:25 INFO - PROCESS | 1639 | Values: 297.8 302.4 309.7 315.6 316.7 4489.6 5314.2 5333.4 5356.3 5386.4 4398.8 4577.1 5150.6 5187.5 5269.9 3041.8 4071.6 4088.1 4098.6 4103.2 3572.6 3909.6 3942.6 4149.4 4157.9 3925.7 4033.6 4046.7 4088.3 4097.9 4031.9 4038.4 4047.3 4052.4 4057.5 3524.4 3536.6 3541.4 3549.9 3552.8 4648.1 4669.7 4973.7 5217.9 5271.3 3882.7 3894.4 4548.5 4601.7 4653.7 5251.6 5546.6 5562.6 5563.4 5571.6 3339.5 3633.3 3863.5 3884.8 3888.5 5463.6 5666.5 5811.8 5828.6 5868.7 3731.8 3861.8 3918.8 3925.5 3974.0 3999.9 4004.4 4019.0 4025.4 4025.5 3847.0 4171.0 4507.8 4646.3 4698.7 4895.5 5077.6 5474.9 5513.8 5691.1 1093.3 1140.5 1225.2 1280.4 1298.5 836.7 896.8 904.0 908.7 911.8 4242.7 4456.5 4921.8 4931.9 4933.7 4581.4 5270.4 5468.3 5502.4 5521.9 4134.9 4399.8 4768.0 4999.0 5005.5 2357.8 2643.6 2712.8 2858.3 2899.3 5306.6 5409.4 5528.3 5555.7 5646.2 4682.9 4747.1 5580.7 5606.4 5624.2 4977.9 5017.9 5285.4 5506.2 5833.9 4287.5 4877.3 5240.7 5499.8 5551.4 4537.9 5034.5 5173.6 5377.8 5526.4 4934.6 5212.7 5456.1 5678.1 5688.0 3183.0 3737.9 3784.6 3863.5 3876.7 4820.8 5087.5 5716.4 5750.7 5752.4 4984.0 5252.2 5407.8 5688.7 5693.8 4952.0 5065.6 5164.9 5645.8 5686.5 4687.0 4799.5 5519.7 5549.5 5570.0 5050.6 5232.9 5339.1 5608.3 5620.8 5543.8 5554.1 5556.2 5583.2 5606.4 19:04:25 INFO - PROCESS | 1639 | 19:04:25 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:20780.65 Median:3953.55 stddev:30431.37 (769.7%) stddev-sans-first:30479.42 19:04:25 INFO - PROCESS | 1639 | Values: 709.7 733.6 782.0 809.4 835.5 14488.9 15340.2 15430.5 15541.3 15546.2 13920.0 14096.0 14101.9 14121.9 14125.4 677.2 690.9 698.4 700.5 833.6 697.0 701.5 825.6 850.0 856.3 905.4 910.0 914.6 917.7 918.8 906.7 908.7 912.4 913.1 914.0 676.8 679.2 679.7 679.8 680.0 14053.0 14230.8 14298.6 14378.9 14936.5 14044.9 14051.3 14604.6 14709.6 14748.3 11169.8 11545.7 11560.4 11571.5 11679.0 3717.1 3910.8 3938.7 3968.4 4044.8 86089.1 86845.0 87504.0 87605.0 89470.6 10006.5 10407.4 10732.4 10769.8 10904.9 19806.6 20138.9 20145.7 20152.9 20169.0 7641.1 7672.3 7673.3 7743.3 7863.3 4334.5 4453.1 4459.9 4470.1 4622.9 3059.2 3472.2 3592.3 3594.1 3594.9 646.6 669.6 675.4 680.1 686.3 548.4 673.0 674.3 676.6 706.3 9488.6 9631.8 9632.9 9745.6 9898.5 642.5 672.9 684.0 690.9 692.5 3845.0 4285.2 4622.3 4718.1 4937.8 115554.0 115644.7 118206.0 118320.0 123856.0 68955.0 69486.0 104937.5 105465.0 110992.8 63713.7 64485.4 85756.0 89854.0 92706.1 9930.5 10153.6 10190.7 10199.4 10244.4 53229.7 53784.2 54394.5 54766.7 54975.0 63714.7 78023.0 78263.8 78771.6 82485.0 11781.6 12122.7 12764.0 13014.3 13198.9 12671.0 13688.1 14715.9 15459.0 15624.2 12157.7 13522.2 13755.6 13818.5 13980.7 12775.2 12793.5 13273.7 13678.7 13781.2 12885.7 13306.0 13476.2 13546.9 13976.7 10532.4 10617.4 10852.3 11372.4 11766.0 11240.8 11298.7 11365.8 11454.8 11576.9 19:04:25 INFO - PROCESS | 1639 | -------- Summary: end -------- 19:04:25 INFO - PROCESS | 1639 | 19:04:26 INFO - TEST-INFO | 1639: exit 0 19:04:26 INFO - TEST-OK | dromaeo_css | took 1118229ms 19:04:26 INFO - TEST-START | kraken 19:04:26 INFO - operating with platform_type : mac_ 19:04:26 INFO - Initialising browser for kraken test... 19:04:26 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/tmpFAy1Ty/profile http://localhost:49243/getInfo.html) 19:04:28 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 19:04:28 INFO - PROCESS | 1648 | colorDepth:24 19:04:28 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 19:04:28 INFO - PROCESS | 1648 | __metrics 19:04:28 INFO - PROCESS | 1648 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:04:28 INFO - PROCESS | 1648 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:04:29 INFO - TEST-INFO | 1648: exit 0 19:04:29 INFO - Browser initialized. 19:04:29 INFO - Running cycle 1/1 for kraken test... 19:04:29 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/tmpFAy1Ty/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:04:41 INFO - PROCESS | 1650 | RSS: Main: 168513536 19:04:41 INFO - PROCESS | 1650 | 19:04:44 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 19:04:45 INFO - PROCESS | 1650 | RSS: Main: 218497024 19:04:45 INFO - PROCESS | 1650 | 19:04:47 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 19:04:48 INFO - PROCESS | 1650 | RSS: Main: 232189952 19:04:48 INFO - PROCESS | 1650 | 19:04:51 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 19:04:51 INFO - PROCESS | 1650 | RSS: Main: 329568256 19:04:51 INFO - PROCESS | 1650 | 19:04:53 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 19:04:54 INFO - PROCESS | 1650 | RSS: Main: 232374272 19:04:54 INFO - PROCESS | 1650 | 19:04:56 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:04:57 INFO - PROCESS | 1650 | RSS: Main: 234856448 19:04:57 INFO - PROCESS | 1650 | 19:04:59 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 19:05:00 INFO - PROCESS | 1650 | RSS: Main: 274423808 19:05:00 INFO - PROCESS | 1650 | 19:05:03 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 19:05:03 INFO - PROCESS | 1650 | RSS: Main: 273510400 19:05:03 INFO - PROCESS | 1650 | 19:05:06 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 19:05:07 INFO - PROCESS | 1650 | RSS: Main: 271970304 19:05:07 INFO - PROCESS | 1650 | 19:05:08 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:05:09 INFO - PROCESS | 1650 | RSS: Main: 247300096 19:05:09 INFO - PROCESS | 1650 | 19:05:11 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:05:11 INFO - PROCESS | 1650 | RSS: Main: 249851904 19:05:11 INFO - PROCESS | 1650 | 19:05:14 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:05:14 INFO - PROCESS | 1650 | RSS: Main: 251867136 19:05:14 INFO - PROCESS | 1650 | 19:05:17 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:05:18 INFO - PROCESS | 1650 | RSS: Main: 271028224 19:05:18 INFO - PROCESS | 1650 | 19:05:21 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:05:21 INFO - PROCESS | 1650 | RSS: Main: 264290304 19:05:21 INFO - PROCESS | 1650 | 19:05:23 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 19:05:23 INFO - PROCESS | 1650 | RSS: Main: 308625408 19:05:23 INFO - PROCESS | 1650 | 19:05:23 INFO - PROCESS | 1650 | __start_tp_report 19:05:23 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 19:05:23 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 19:05:23 INFO - PROCESS | 1650 | |i|pagename|runs| 19:05:23 INFO - PROCESS | 1650 | |0;ai-astar;102;113;114;113;114;114;112;114;113;114 19:05:23 INFO - PROCESS | 1650 | |1;audio-beat-detection;148;139;137;144;108;107;107;107;137;107 19:05:23 INFO - PROCESS | 1650 | |2;audio-dft;181;182;185;184;183;180;182;182;183;183 19:05:23 INFO - PROCESS | 1650 | |3;audio-fft;81;59;61;88;61;60;57;58;82;58 19:05:23 INFO - PROCESS | 1650 | |4;audio-oscillator;89;69;93;69;67;69;100;96;98;106 19:05:23 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;91;84;86;85;87;83;88;84;88;84 19:05:23 INFO - PROCESS | 1650 | |6;imaging-darkroom;93;93;94;94;93;92;93;93;92;94 19:05:23 INFO - PROCESS | 1650 | |7;imaging-desaturate;80;83;78;82;81;77;73;127;128;121 19:05:23 INFO - PROCESS | 1650 | |8;json-parse-financial;57;54;55;54;57;56;56;55;55;55 19:05:23 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;71;63;69;78;72;72;68;69;68;70 19:05:23 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;81;91;99;100;81;80;81;84;80;82 19:05:23 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;119;170;120;142;150;153;142;139;184;132 19:05:23 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;163;163;164;162;163;163;160;164;161;161 19:05:23 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;66;66;66;66;64;65;66;68;65;66 19:05:23 INFO - PROCESS | 1650 | __end_tp_report 19:05:23 INFO - PROCESS | 1650 | __start_cc_report 19:05:23 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1844 19:05:23 INFO - PROCESS | 1650 | __end_cc_report 19:05:23 INFO - PROCESS | 1650 | __startTimestamp1485918323627__endTimestamp 19:05:23 INFO - PROCESS | 1650 | 19:05:23 INFO - PROCESS | 1650 | ------- Summary: start ------- 19:05:23 INFO - PROCESS | 1650 | Number of tests: 14 19:05:23 INFO - PROCESS | 1650 | 19:05:23 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:112.30 Median:114.00 stddev:3.68 (3.2%) stddev-sans-first:0.73 19:05:23 INFO - PROCESS | 1650 | Values: 102.0 113.0 114.0 113.0 114.0 114.0 112.0 114.0 113.0 114.0 19:05:23 INFO - PROCESS | 1650 | 19:05:23 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:124.10 Median:137.00 stddev:18.11 (13.2%) stddev-sans-first:17.02 19:05:23 INFO - PROCESS | 1650 | Values: 148.0 139.0 137.0 144.0 108.0 107.0 107.0 107.0 137.0 107.0 19:05:23 INFO - PROCESS | 1650 | 19:05:23 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:182.50 Median:183.00 stddev:1.43 (0.8%) stddev-sans-first:1.41 19:05:23 INFO - PROCESS | 1650 | Values: 181.0 182.0 185.0 184.0 183.0 180.0 182.0 182.0 183.0 183.0 19:05:23 INFO - PROCESS | 1650 | 19:05:23 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:66.50 Median:61.00 stddev:12.05 (19.8%) stddev-sans-first:11.58 19:05:23 INFO - PROCESS | 1650 | Values: 81.0 59.0 61.0 88.0 61.0 60.0 57.0 58.0 82.0 58.0 19:05:23 INFO - PROCESS | 1650 | 19:05:23 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:85.60 Median:79.00 stddev:15.36 (19.4%) stddev-sans-first:16.25 19:05:23 INFO - PROCESS | 1650 | Values: 89.0 69.0 93.0 69.0 67.0 69.0 100.0 96.0 98.0 106.0 19:05:23 INFO - PROCESS | 1650 | 19:05:23 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:86.00 Median:86.50 stddev:2.49 (2.9%) stddev-sans-first:1.88 19:05:23 INFO - PROCESS | 1650 | Values: 91.0 84.0 86.0 85.0 87.0 83.0 88.0 84.0 88.0 84.0 19:05:23 INFO - PROCESS | 1650 | 19:05:23 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:93.10 Median:93.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 19:05:23 INFO - PROCESS | 1650 | Values: 93.0 93.0 94.0 94.0 93.0 92.0 93.0 93.0 92.0 94.0 19:05:23 INFO - PROCESS | 1650 | 19:05:23 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:93.00 Median:79.00 stddev:22.56 (28.6%) stddev-sans-first:23.43 19:05:23 INFO - PROCESS | 1650 | Values: 80.0 83.0 78.0 82.0 81.0 77.0 73.0 127.0 128.0 121.0 19:05:23 INFO - PROCESS | 1650 | 19:05:23 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.50 stddev:1.07 (1.9%) stddev-sans-first:0.97 19:05:23 INFO - PROCESS | 1650 | Values: 57.0 54.0 55.0 54.0 57.0 56.0 56.0 55.0 55.0 55.0 19:05:23 INFO - PROCESS | 1650 | 19:05:23 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:70.50 stddev:3.83 (5.4%) stddev-sans-first:4.04 19:05:23 INFO - PROCESS | 1650 | Values: 71.0 63.0 69.0 78.0 72.0 72.0 68.0 69.0 68.0 70.0 19:05:23 INFO - PROCESS | 1650 | 19:05:23 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:81.50 stddev:7.87 (9.7%) stddev-sans-first:8.14 19:05:23 INFO - PROCESS | 1650 | Values: 81.0 91.0 99.0 100.0 81.0 80.0 81.0 84.0 80.0 82.0 19:05:23 INFO - PROCESS | 1650 | 19:05:23 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:145.10 Median:146.00 stddev:20.44 (14.0%) stddev-sans-first:19.37 19:05:23 INFO - PROCESS | 1650 | Values: 119.0 170.0 120.0 142.0 150.0 153.0 142.0 139.0 184.0 132.0 19:05:23 INFO - PROCESS | 1650 | 19:05:23 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.40 Median:163.00 stddev:1.35 (0.8%) stddev-sans-first:1.41 19:05:23 INFO - PROCESS | 1650 | Values: 163.0 163.0 164.0 162.0 163.0 163.0 160.0 164.0 161.0 161.0 19:05:23 INFO - PROCESS | 1650 | 19:05:23 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:1.03 (1.6%) stddev-sans-first:1.09 19:05:23 INFO - PROCESS | 1650 | Values: 66.0 66.0 66.0 66.0 64.0 65.0 66.0 68.0 65.0 66.0 19:05:23 INFO - PROCESS | 1650 | -------- Summary: end -------- 19:05:23 INFO - PROCESS | 1650 | 19:05:24 INFO - TEST-INFO | 1650: exit 0 19:05:24 INFO - TEST-OK | kraken | took 58610ms 19:05:24 INFO - SUITE-END | took 1176s 19:05:24 INFO - Completed test suite (00:19:36) 19:05:24 INFO - javascript benchmark 19:05:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3516.8944931652045, 3560.537130173077, 3561.430171172613, 3580.373434648936, 3618.077390265482, 5944.524438044957, 5962.850928726784, 5979.760809567618, 5993.970030149843, 6034.607750496215, 5927.940720592804, 5979.491743201822, 6018.337982821886, 6034.306054803699, 6037.852807966483, 5127.48725127488, 5342.519173274404, 5359.7320133993335, 5381.300430943972, 5465.754041068161, 5342.278792363039, 5354.866128346784, 5359.464053594648, 5408.675479471244, 5497.175423686439, 5413.783448662049, 5431.158170483582, 5439.184122381635, 5443.945560544384, 5454.59090568207, 5428.891422171554, 5440.91838622421, 5443.918341224865, 5444.863878403032, 5446.074167391553, 5304.926073995799, 5351.919721204185, 5365.7853685852515, 5372.91940620891, 5382.8923421531745, 6059.939400605982, 6065.0, 6066.545009124334, 6067.2719273687, 6083.543734219951, 5882.999890018707, 6273.247210334789, 6325.462335701471, 6327.335629758901, 6357.93642063578, 5519.420460851633, 6304.401081897213, 6306.495480361606, 6339.2392912850755, 6344.111824344595, 6035.245594300713, 6041.3354531002, 6073.4533891949495, 6108.4807791338235, 6125.4487096160665, 6255.530835187379, 6309.936900631027, 6321.209848768904, 6335.0, 6367.4906007519285, 6235.189425374763, 6297.622142671455, 6312.24253089623, 6313.652749098752, 6320.0, 6341.207349081365, 6348.301686814447, 6349.809505714744, 6357.396047375492, 6373.553851230369, 6241.843953901189, 6269.435750782452, 6288.308286088527, 6323.5889667172405, 6338.366163383625, 6282.937170628326, 6297.968510157511, 6317.684115794192, 6319.8104056878365, 6326.68366581669, 5090.821821236239, 5106.412762532356, 5111.080005599028, 5119.667221630657, 5131.204663277198, 4513.638908887281, 4521.547845215518, 4537.659675524349, 4556.65825063115, 4563.931541026887, 5093.541581257705, 6057.515398768088, 6106.297775755845, 6136.23297087864, 6138.6623735694075, 6352.6823658816875, 6356.650384228819, 6359.523035772336, 6361.618302901748, 6378.681065946684, 5884.0585506318785, 5937.7921772737745, 5958.970205148947, 6045.6070355426755, 6111.54163437744, 5594.916076258859, 5606.523445507178, 5617.241672374177, 5653.208550802891, 5676.631018983753, 6553.246376666553, 6573.3426657333885, 6593.6703164841565, 6612.272650008592, 6643.103181070687, 5307.310049693515, 5432.864178395572, 6234.127222188807, 6272.6236425814595, 6385.393387628168, 6447.2263328400895, 6494.512911531559, 6512.381323774234, 6581.703823327866, 6598.208215014229, 4856.31610456989, 6324.968375158095, 6330.651814150266, 6350.206224221973, 6361.077643741539, 6287.695869476633, 6289.654069026247, 6353.078803573549, 6357.841053973688, 6366.586171898812, 6194.783182588768, 6209.937900620936, 6242.406971337716, 6301.023341382093, 6340.080688300263, 6119.877602448015, 6156.353582873734, 6319.58922670025, 6344.777932772331, 6351.047342898602, 6129.540284478593, 6221.160143380766, 6238.313785483684, 6253.530985176221, 6267.9657856455, 6161.599496032743, 6206.968965155326, 6226.719797609209, 6237.438630523275, 6343.460805831556, 6257.7184026718, 6260.530460215593, 6263.0, 6266.122742816101, 6271.874562508633], "value": 5865.921862853699, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [475.19217330538095, 487.85111063445595, 501.83188631808343, 526.8761840967372, 534.132035442406, 31237.531437028436, 33135.00594982151, 41052.76841694754, 42181.7890910545, 42288.365674514906, 43142.784286078604, 43295.78352108235, 43524.0, 43581.0, 43630.78184609072, 9665.806683866336, 9870.161036311922, 9874.506274686237, 9876.506174691236, 9876.950615246913, 8943.32925030622, 9080.137386948229, 9089.863652045224, 9191.08089191079, 9678.322517423783, 10077.496125193748, 11866.881331186663, 12066.276023438579, 12220.38898055098, 12227.388630568435, 11868.050555955546, 11951.103667224992, 11952.521899124025, 11965.40172991347, 11968.52125914958, 11641.41792910351, 11785.175037747362, 11791.174617776673, 11858.525658973631, 11876.0499160067, 41159.765207043834, 41398.37902431466, 41476.792616037026, 41559.58440415618, 41571.96070098242, 3328.3509715605464, 3371.4774209997245, 3372.359251742161, 3386.6274709781906, 3413.675700808419, 29315.0, 29868.253293667614, 29935.550966735518, 30457.543136852964, 31816.0, 3216.1477208539754, 3289.73682105431, 3291.325278317939, 3293.423650861114, 3371.988403478971, 501236.0, 502136.0, 504918.0, 505417.99999999633, 505657.0, 34726.82636586801, 35285.47071793874, 35459.113522161635, 63620.0, 64197.35802642007, 36218.0, 36221.45667814932, 36313.45529817055, 36329.45505817415, 36445.90662280136, 12904.80642790359, 15163.393464261526, 15323.693526129415, 15346.846531534542, 15364.924455288023, 12845.036622253368, 12960.416781244867, 12973.221606703628, 12973.481060757653, 12982.415791289415, 7552.207018263003, 7688.654010569538, 7924.247196516321, 7975.0, 8017.719379821679, 3349.648286929886, 3365.3942290387963, 3370.79775213488, 3371.780834245766, 3407.931841363159, 945.177695405002, 961.5672947173799, 1036.4558606731525, 1055.9894401056044, 1085.278289937183, 29912.850435748118, 30212.24469388239, 30314.090577282717, 30526.847365763027, 30741.23146921345, 1076.3165389977264, 1079.0396547073112, 1081.9621313254156, 1129.8700649425257, 1144.2162118948547, 15710.486322188624, 16802.663946720997, 16870.409535666193, 16917.830821691627, 17192.570185745455, 645523.0, 650035.0, 650104.0, 650411.0, 651801.0, 59815.70092149598, 60332.0, 60360.69819650874, 60402.395976040556, 60540.0, 1158.5771193514474, 1259.338847105277, 1308.999999999981, 1372.4853180057478, 1415.7805540141294, 30187.396252074395, 31190.376192476477, 31334.373312534077, 31448.213794655316, 31960.200994975312, 51591.74204128955, 52605.0, 52607.94784104373, 52644.21033684575, 52817.7359113202, 473494.0, 560683.0, 560690.0, 561082.0, 561199.0, 24280.392990175387, 24780.25659230226, 24814.751852481244, 27344.31639208956, 27744.861275693493, 38565.22869542649, 41660.37509437421, 42108.0, 47730.1361918286, 49743.005139896275, 38643.613563864004, 38652.0, 39543.01142471461, 40640.59359406486, 40670.59329406668, 38760.0, 39120.80439597784, 39465.40801888031, 40197.397039043855, 40286.0, 37101.628983709816, 38889.0, 38898.0, 39020.0, 39022.80488597539, 30359.241018974702, 31254.687453125178, 34277.0, 34831.30337393187, 34944.65055349414, 22575.563943293528, 26060.8696956514, 26208.0, 26301.605475917495, 26465.603015955163], "value": 19019.454192094567, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.80748569572495, 349.93876071687464, 350.9105178179564, 386.8510623409988, 399.1697269679068, 18767.967761773096, 19592.0, 20306.695399569, 21143.365699029055, 21357.252496162637, 19236.90381548094, 19871.801281987176, 20487.59024819503, 21096.472588185305, 21150.576988460223, 4177.33162693969, 5482.2873026506595, 5634.3520495143175, 5678.034734095214, 5691.857703557403, 4026.335654616985, 5456.672599644015, 5557.888842223153, 5561.304836895388, 5562.582806289524, 4208.642265407429, 4253.2769429197115, 5268.262443257947, 5916.171735956969, 6166.537509686769, 5711.571632127607, 5951.375105613892, 6247.437730604244, 6263.812085637438, 6267.4045965633195, 5847.56143289255, 5865.266841644794, 5873.148393482964, 5874.060150375919, 5885.85285367865, 13771.862281377158, 13857.099288546313, 23126.84365781721, 24415.511689766106, 25368.61947070777, 2190.769969153248, 2260.9095636174534, 2296.1389478945393, 2404.747501512351, 2792.176307989148, 10398.584056637801, 10460.633877814316, 10606.363618182933, 10806.0, 13689.931550342184, 1915.1956178405103, 1927.8939658318786, 1959.9608007839763, 1962.0876292524044, 1972.2702600037935, 123212.0, 123528.0, 126505.0, 127050.36474817566, 131008.0, 9173.0, 10341.586336546454, 10523.473826308655, 10722.73193170177, 10735.51690173944, 12624.17942833713, 12716.936415317865, 12721.491140354283, 12736.80894786579, 12746.80879786804, 8108.797280067927, 8274.172582741678, 8316.958415207886, 8396.07643159252, 8475.1524847516, 8710.433821801562, 8712.998005229352, 8737.257333126629, 8854.911450885409, 8884.200421961925, 3986.9202615948097, 4036.57615950321, 4051.169510250392, 4095.5494895561465, 4116.958830411658, 1960.2551030608277, 1981.8315443187203, 1990.1442379776545, 2005.2981456490404, 2032.156654988193, 702.4482387143479, 781.1797612506845, 824.8762685597209, 930.6928713524657, 932.3194068330157, 21400.892995534923, 22291.777082229295, 22298.44253893633, 22466.438339041328, 22501.32496025089, 755.5919803306153, 866.358894418126, 950.3110245072405, 950.9857352139724, 971.1259866120548, 11274.0, 11501.654950351503, 11649.941750291195, 11746.29522228669, 11776.470058847372, 616469.0, 618801.0, 626022.0, 635236.0, 636864.0, 131163.3441832804, 138739.0, 140750.0, 144812.0, 146217.0, 782.2920257167273, 1037.7301901505664, 1046.0899017854515, 1049.7165765243494, 1050.3330385205297, 14813.703725925205, 18101.366452174112, 19371.709424358927, 19401.835889846654, 19408.223671053, 42675.93310167271, 55537.0, 56406.5898352528, 57431.42568574261, 58229.12656310074, 65478.0, 79342.0, 81292.59353703193, 84923.0, 87208.0, 8264.380171487042, 8266.545340006358, 8325.458845175044, 8629.611667474854, 8695.608697608497, 10093.69718908434, 12622.43199056063, 13111.475540978636, 13522.93238533801, 13784.379702913193, 11509.424528773696, 11579.478923448296, 11580.768384632429, 11586.76826463483, 11885.762284754084, 11211.71970700739, 11436.1422893285, 11515.769684606428, 11577.479013444246, 11900.285982841056, 6011.368806275453, 11708.473118709508, 11747.355370248342, 11774.175807693378, 11834.822477663014, 8384.41309108381, 8450.746477605682, 8473.237408633253, 8526.147385261424, 8541.01778295504, 9846.704598862045, 10256.12822910061, 10884.564617415215, 11661.475233614337, 11695.473703683185], "value": 9480.850423069967, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1251.5807204586463, 1490.9478168264109, 1633.322171298911, 1852.6202128563646, 1868.3740946782827, 8249.175082491754, 8644.135586441353, 8670.176333248339, 8672.43629164104, 8674.956625216873, 7683.116441609202, 7910.169432209622, 8151.184881511846, 8392.160783921605, 8426.115257897924, 2347.7439569830144, 2385.1413491143176, 2387.3554140382084, 2389.8685572293516, 2390.988045059781, 2393.066703985447, 2409.277216834951, 2414.915477958272, 2431.3070774829175, 2436.744141865105, 2373.6439534069855, 2376.489054853206, 2399.700037495313, 2402.6636270922086, 2403.3631087761755, 2224.788645078715, 2372.78644921957, 2395.3293077938206, 2398.5442765874427, 2400.4238982644215, 2178.433607262107, 2391.8804059797117, 2396.508715713275, 2402.7236867760257, 2407.3500154958065, 8402.579871006425, 8474.406791524596, 8494.660213591449, 8514.957425212897, 8526.957365213197, 5131.358580177478, 5288.418273989858, 5296.761645725952, 5297.814576489843, 5298.549623282026, 3252.6909943555324, 3325.401427743005, 3555.768875023115, 3562.020444377791, 3562.1628917204434, 1075.3494136047734, 1079.5843600213896, 1094.261373572843, 1111.1000089927186, 1123.1464087293716, 11006.889931100666, 11073.224874258805, 11124.110071194285, 11125.443727813577, 11136.610218642309, 4536.841210557614, 4620.976895115503, 4706.976465117653, 4721.055788842245, 4805.207140821725, 9562.856557151648, 9576.090271424204, 9594.184494317922, 9623.903760962301, 9661.951690241503, 5269.341332333458, 5272.736363181825, 5272.815451459181, 5295.099833028395, 5301.814436494704, 4319.4816622005565, 4596.908061838744, 4836.613070954315, 4843.75781210938, 4845.515448455127, 3858.6720128789366, 3867.149227170018, 3931.6068393160454, 3951.7628942263555, 3968.9603103969166, 1114.4706264524286, 1274.6367285323638, 1279.6033229698824, 1287.8776516230944, 1290.6902343437507, 776.2198990014999, 868.9023630756334, 898.3711402018482, 906.1708536688988, 917.3624331089828, 5557.888842223133, 5698.202251684767, 5744.971275143681, 5894.528437724972, 5992.041273396236, 958.4536814015944, 966.8211380894558, 971.8104969531015, 974.0940924939874, 990.029770824596, 3560.732945029133, 3869.7678139311734, 3902.3951287550476, 4011.4183443401125, 4032.6169013943627, 9861.506924653882, 10302.0, 10413.9479302603, 10414.010668986433, 10431.68704938853, 10375.377477351383, 10379.221558383151, 10387.532561034772, 10396.584136634601, 10409.0, 7489.588072656056, 7997.960010199912, 8132.390070744717, 8132.552709601029, 8136.372725454933, 5578.804741834017, 5597.944020559742, 5638.746256418389, 5736.42635736423, 5780.3352614448195, 9270.0, 9407.81184376295, 9446.669366572138, 9479.241660666992, 9572.090651388107, 9571.856422153813, 9697.951510242403, 9718.805623887341, 9719.65981190655, 9828.361156524803, 6457.160569126171, 6538.640374779433, 6842.623655698984, 6882.0, 7025.894611580932, 8074.798130046795, 8158.388120891075, 8164.795880102807, 8176.427650064438, 8185.672573097009, 7147.53541019832, 7206.459515536251, 7281.308275713799, 7305.1233851938105, 7451.0, 7057.117860267466, 7166.53417527859, 7169.390601798906, 7310.59791711461, 7338.0, 6770.2891196425635, 6792.490563207878, 6825.965870170618, 6836.658167091725, 6868.553544019623, 4876.785207250844, 4969.428515720739, 4976.900461990812, 5023.447420783784, 5032.194848824171, 4770.141374552614, 4901.411830580353, 4913.680610760289, 5021.397432308147, 5053.545180933734], "value": 4511.09167150496, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.8153544802224, 302.3786119524377, 309.6671078590515, 315.55506735502945, 316.703881870451, 4489.595936365727, 5314.176302673082, 5333.413324534298, 5356.250124982505, 5386.407495175533, 4398.824047038114, 4577.109456961581, 5150.635081703352, 5187.533122019017, 5269.86825329367, 3041.7870749047465, 4071.6131967463193, 4088.0786030565737, 4098.569650186725, 4103.199876024177, 3572.6427357264197, 3909.6481316681493, 3942.6254505821903, 4149.3983372410985, 4157.875263742078, 3925.7055720821054, 4033.556308806029, 4046.6560342370785, 4088.3049881520215, 4097.9180416391655, 4031.871076098697, 4038.4144299076615, 4047.291723948297, 4052.3516237402023, 4057.452243947059, 3524.4360902255517, 3536.5932917714536, 3541.4240662905017, 3549.8757543485854, 3552.8045957472327, 4648.071050514032, 4669.719816811003, 4973.701577905337, 5217.895642087175, 5271.262023316739, 3882.650561449483, 3894.396368562849, 4548.474931927783, 4601.699150424788, 4653.7207767534055, 5251.55361794248, 5546.611737178399, 5562.554995600342, 5563.415841336682, 5571.609987300891, 3339.482380231068, 3633.3459977204093, 3863.4784304118866, 3884.7863367514774, 3888.5333759948703, 5463.644863083927, 5666.49001589863, 5811.820567287267, 5828.591998560102, 5868.735906884201, 3731.8320675569666, 3861.806909654506, 3918.7648741075627, 3925.4700615417123, 3973.9602603974167, 3999.8800035998966, 4004.379321205218, 4018.9799051004557, 4025.396190571379, 4025.5169379674626, 3846.9997800572055, 4170.9582904171175, 4507.752073635981, 4646.326282689059, 4698.671093023524, 4895.534924182197, 5077.644564880497, 5474.850281440942, 5513.7794488220825, 5691.09348368293, 1093.2729734726477, 1140.5152810055692, 1225.2036176485356, 1280.4442602238325, 1298.4741179822188, 836.7406104107746, 896.820635872828, 903.9909600904039, 908.7137551671202, 911.8313112074287, 4242.681798865097, 4456.487503937024, 4921.753912304442, 4931.852044438672, 4933.703977761345, 4581.427321584802, 5270.446603106619, 5468.343798744176, 5502.422245664227, 5521.941373090855, 4134.896627584334, 4399.846005389796, 4768.0, 4999.000399840093, 5005.524475174852, 2357.811375089989, 2643.577027675601, 2712.7521340183343, 2858.3140046389135, 2899.3331533747355, 5306.575473962073, 5409.404965453797, 5528.281323427928, 5555.694436805934, 5646.22144024631, 4682.929756053662, 4747.121782470254, 5580.7164352199225, 5606.355269144101, 5624.184493248456, 4977.875553111129, 5017.89964200714, 5285.365756109291, 5506.2291279221745, 5833.912491312633, 4287.549807270192, 4877.317175595348, 5240.71176085319, 5499.752511137089, 5551.417101204315, 4537.886552836074, 5034.546890779848, 5173.586113111018, 5377.768226186089, 5526.392096869422, 4934.593640812352, 5212.661177023481, 5456.127019676833, 5678.0915053591225, 5688.0, 3182.95225571612, 3737.8691745788765, 3784.6215378461934, 3863.4932376372676, 3876.7092468064443, 4820.807167713392, 5087.542121209109, 5716.371199168171, 5750.712464376681, 5752.395998420273, 4983.953369792384, 5252.242572649389, 5407.83776486706, 5688.715564221855, 5693.772249109989, 4951.950480495149, 5065.56942659878, 5164.922526162036, 5645.802396916089, 5686.459786320293, 4686.992296656235, 4799.496052914394, 5519.724013799374, 5549.528290095387, 5569.972150139223, 5050.570701490415, 5232.901090770981, 5339.119045357473, 5608.298962629671, 5620.803271885465, 5543.8101949728825, 5554.139363313174, 5556.222128902038, 5583.21337172101, 5606.439356064361], "value": 3984.961106427079, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.7444919828861, 733.585524178839, 781.9609019549025, 809.3560770966081, 835.4893544897582, 14488.855111448882, 15340.156291403968, 15430.537083887473, 15541.300641471133, 15546.222688865553, 13920.025598208129, 14096.0, 14101.929490352559, 14121.929390353034, 14125.43498260071, 677.1501765284561, 690.9309069093075, 698.3505340033792, 700.4711442860633, 833.5582141465034, 696.9965150174243, 701.4633805139073, 825.6325934958945, 850.0054935725217, 856.2550580994543, 905.3752910491739, 909.995450022749, 914.5975770660921, 917.6971599372191, 918.8254231695956, 906.7189171356868, 908.7228395339419, 912.4434095201922, 913.0549880873265, 914.0174312613966, 676.8477092654163, 679.178194384795, 679.7315060551105, 679.7994591595491, 680.0445374249188, 14053.016288859784, 14230.786538201935, 14298.57104286873, 14378.85621143796, 14936.477223297132, 14044.85955140456, 14051.297435128203, 14604.561863144016, 14709.55871323862, 14748.336324865406, 11169.83245251322, 11545.711357216052, 11560.364179970098, 11571.495705558224, 11679.0, 3717.1450566369886, 3910.843566257346, 3938.6652134568594, 3968.444417781513, 4044.797760111983, 86089.13910860936, 86845.0, 87504.0, 87605.0, 89470.552647237, 10006.549705263134, 10407.375557466576, 10732.356058636351, 10769.83845242322, 10904.890951090547, 19806.60386792256, 20138.899305503674, 20145.697814532792, 20152.89923550402, 20169.0, 7641.121271053788, 7672.347850432664, 7673.3477654398885, 7743.341815945595, 7863.331616812635, 4334.523202447728, 4453.064856380196, 4459.866204013885, 4470.105978804252, 4622.884427889329, 3059.2046068022473, 3472.201393679468, 3592.317459682652, 3594.101474631342, 3594.9281014379567, 646.5958775765147, 669.6049330894796, 675.42588799521, 680.129434324066, 686.289690170671, 548.4296331814948, 672.9865402691919, 674.2650510943096, 676.558929480204, 706.336044118527, 9488.620455181715, 9631.759206019906, 9632.90367096334, 9745.61017559304, 9898.455584942898, 642.4539141729585, 672.9327067293232, 683.9863202735918, 690.9067275917787, 692.4771797293012, 3845.0, 4285.186184295979, 4622.2835460503675, 4718.127146477844, 4937.7777999990085, 115554.0, 115644.6871062574, 118206.0, 118320.0, 123856.0, 68955.0, 69486.0, 104937.47531262295, 105465.0, 110992.78014439666, 63713.681431592544, 64485.35514644887, 85756.0, 89854.0, 92706.0729392711, 9930.503474826086, 10153.593856245667, 10190.745231369276, 10199.439030853375, 10244.436555989492, 53229.73385133049, 53784.193237102256, 54394.45605543894, 54766.72616636891, 54975.0, 63714.68142659257, 78023.0, 78263.82604260827, 78771.60614196892, 82485.0, 11781.64223196385, 12122.696687629323, 12764.04269679759, 13014.284214367923, 13198.868011319764, 12671.049671274506, 13688.110272832235, 14715.926420368258, 15459.0, 15624.218789060275, 12157.69605759863, 13522.18866867991, 13755.587332380044, 13818.516351928036, 13980.650483737987, 12775.233485990499, 12793.488260469478, 13273.66815829612, 13678.726425471634, 13781.173129612256, 12885.677858053623, 13306.002049846495, 13476.191428514321, 13546.93226533861, 13976.720465590835, 10532.36805791655, 10617.416042117758, 10852.348859068481, 11372.43137843088, 11766.0, 11240.775184496428, 11298.66104016848, 11365.772684546428, 11454.82817757751, 11576.942115289707], "value": 7476.941399664973, "unit": "score"}], "name": "dromaeo_css", "value": 7224.527407487367, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 114.0, 113.0, 114.0, 114.0, 112.0, 114.0, 113.0, 114.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 139.0, 137.0, 144.0, 108.0, 107.0, 107.0, 107.0, 137.0, 107.0], "value": 124.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 182.0, 185.0, 184.0, 183.0, 180.0, 182.0, 182.0, 183.0, 183.0], "value": 182.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 61.0, 88.0, 61.0, 60.0, 57.0, 58.0, 82.0, 58.0], "value": 66.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 69.0, 93.0, 69.0, 67.0, 69.0, 100.0, 96.0, 98.0, 106.0], "value": 85.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 84.0, 86.0, 85.0, 87.0, 83.0, 88.0, 84.0, 88.0, 84.0], "value": 86.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 94.0, 93.0, 92.0, 93.0, 93.0, 92.0, 94.0], "value": 93.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 83.0, 78.0, 82.0, 81.0, 77.0, 73.0, 127.0, 128.0, 121.0], "value": 93.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 55.0, 54.0, 57.0, 56.0, 56.0, 55.0, 55.0, 55.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 63.0, 69.0, 78.0, 72.0, 72.0, 68.0, 69.0, 68.0, 70.0], "value": 70.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 91.0, 99.0, 100.0, 81.0, 80.0, 81.0, 84.0, 80.0, 82.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 170.0, 120.0, 142.0, 150.0, 153.0, 142.0, 139.0, 184.0, 132.0], "value": 145.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 162.0, 163.0, 163.0, 160.0, 164.0, 161.0, 161.0], "value": 162.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 64.0, 65.0, 66.0, 68.0, 65.0, 66.0], "value": 65.8, "unit": "score"}], "name": "kraken", "value": 1427.7, "alertThreshold": 2.0}]} 19:05:24 INFO - Return code: 0 19:05:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:05:24 INFO - # TBPL SUCCESS # 19:05:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:05:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:05:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:05:24 INFO - 2017-01-31 19:05:24.929 screenresolution[1654:9854] starting screenresolution argv=screenresolution get 19:05:24 INFO - 2017-01-31 19:05:24.932 screenresolution[1654:9854] Display 0: 1600x1200x32@60 19:05:24 INFO - 2017-01-31 19:05:24.939 screenresolution[1655:9857] starting screenresolution argv=screenresolution list 19:05:24 INFO - Available Modes on Display 0 19:05:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:05:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:05:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:05:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:05:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:05:25 INFO - Intel Iris: 19:05:25 INFO - Chipset Model: Intel Iris 19:05:25 INFO - Type: GPU 19:05:25 INFO - Bus: Built-In 19:05:25 INFO - VRAM (Dynamic, Max): 1536 MB 19:05:25 INFO - Vendor: Intel (0x8086) 19:05:25 INFO - Device ID: 0x0a2e 19:05:25 INFO - Revision ID: 0x0009 19:05:25 INFO - Displays: 19:05:25 INFO - Display: 19:05:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:05:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:05:25 INFO - Display Serial Number: 1600x1200 60 19:05:25 INFO - Main Display: Yes 19:05:25 INFO - Mirror: Off 19:05:25 INFO - Online: Yes 19:05:25 INFO - Rotation: Supported 19:05:25 INFO - Return code: 0 19:05:25 INFO - Running post-action listener: _resource_record_post_action 19:05:25 INFO - [mozharness: 2017-02-01 03:05:25.179780Z] Finished run-tests step (success) 19:05:25 INFO - Running post-run listener: _resource_record_post_run 19:05:25 INFO - Total resource usage - Wall time: 1199s; CPU: 53.0%; Read bytes: 37893120; Write bytes: 500055040; Read time: 243; Write time: 1595 19:05:25 INFO - TinderboxPrint: CPU usage
53.4% 19:05:25 INFO - TinderboxPrint: I/O read bytes / time
37,893,120 / 243 19:05:25 INFO - TinderboxPrint: I/O write bytes / time
500,055,040 / 1,595 19:05:25 INFO - TinderboxPrint: CPU idle
2,235.7 (46.6%) 19:05:25 INFO - TinderboxPrint: CPU system
964.4 (20.1%) 19:05:25 INFO - TinderboxPrint: CPU user
1,597.6 (33.3%) 19:05:25 INFO - TinderboxPrint: Swap in / out
229,089,280 / 0 19:05:25 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 178985472; Write bytes: 174448640; Read time: 16570; Write time: 380 19:05:25 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 36963328; Write bytes: 307825664; Read time: 231; Write time: 1157 19:05:25 INFO - Running post-run listener: _upload_blobber_files 19:05:25 INFO - Blob upload gear active. 19:05:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:05:25 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 19:05:25 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'] 19:05:25 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 19:05:26 INFO - (blobuploader) - INFO - Open directory for files ... 19:05:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:05:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:05:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:05:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:05:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:05:27 INFO - (blobuploader) - INFO - Done attempting. 19:05:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:05:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:05:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:05:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:05:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:05:28 INFO - (blobuploader) - INFO - Done attempting. 19:05:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:05:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:05:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:05:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:05:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:05:31 INFO - (blobuploader) - INFO - Done attempting. 19:05:31 INFO - (blobuploader) - INFO - Iteration through files over. 19:05:31 INFO - Return code: 0 19:05:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:05:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:05:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/08ccb7f5c069f63b9b161e11a2fb1b6fab847533e0125f62819598af915eebf41bfa4a7fafd47cb8f9315dce6610c8450c35f7f2ca84f0df1c34d6d399684754", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5a3f008b308e0c0a0fcbcf5b3b10f0f856698fe77cb04605b8d997305fa82b7be0ab0460e74835e944a1b531b0d7c52cfffc8cdab7305cd0621e040e5ec4ca7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eaf6bc0c711a217bae349bce8ac1bd765069b9e33b80e48b833a655212577c491dffdee47bbebde9b92dd2a027614c6bb13c5cb91b45e481e448e59fdab98b1f"} 19:05:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:05:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:05:31 INFO - Contents: 19:05:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/08ccb7f5c069f63b9b161e11a2fb1b6fab847533e0125f62819598af915eebf41bfa4a7fafd47cb8f9315dce6610c8450c35f7f2ca84f0df1c34d6d399684754", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5a3f008b308e0c0a0fcbcf5b3b10f0f856698fe77cb04605b8d997305fa82b7be0ab0460e74835e944a1b531b0d7c52cfffc8cdab7305cd0621e040e5ec4ca7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eaf6bc0c711a217bae349bce8ac1bd765069b9e33b80e48b833a655212577c491dffdee47bbebde9b92dd2a027614c6bb13c5cb91b45e481e448e59fdab98b1f"} 19:05:31 INFO - Running post-run listener: copy_logs_to_upload_dir 19:05:31 INFO - Copying logs to upload dir... 19:05:31 INFO - mkdir: /builds/slave/test/build/upload/logs 19:05:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.585180 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-01-31 19:05:31.205300) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-31 19:05:31.212699) ========= 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.a9LXjBr8nM/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.gIAp65564H/Listeners TMPDIR=/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/08ccb7f5c069f63b9b161e11a2fb1b6fab847533e0125f62819598af915eebf41bfa4a7fafd47cb8f9315dce6610c8450c35f7f2ca84f0df1c34d6d399684754", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5a3f008b308e0c0a0fcbcf5b3b10f0f856698fe77cb04605b8d997305fa82b7be0ab0460e74835e944a1b531b0d7c52cfffc8cdab7305cd0621e040e5ec4ca7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eaf6bc0c711a217bae349bce8ac1bd765069b9e33b80e48b833a655212577c491dffdee47bbebde9b92dd2a027614c6bb13c5cb91b45e481e448e59fdab98b1f"} build_url:https://queue.taskcluster.net/v1/task/TrAEAlsxTEenoYCpgNxOAg/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011061 build_url: 'https://queue.taskcluster.net/v1/task/TrAEAlsxTEenoYCpgNxOAg/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/08ccb7f5c069f63b9b161e11a2fb1b6fab847533e0125f62819598af915eebf41bfa4a7fafd47cb8f9315dce6610c8450c35f7f2ca84f0df1c34d6d399684754", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5a3f008b308e0c0a0fcbcf5b3b10f0f856698fe77cb04605b8d997305fa82b7be0ab0460e74835e944a1b531b0d7c52cfffc8cdab7305cd0621e040e5ec4ca7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eaf6bc0c711a217bae349bce8ac1bd765069b9e33b80e48b833a655212577c491dffdee47bbebde9b92dd2a027614c6bb13c5cb91b45e481e448e59fdab98b1f"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-31 19:05:31.255889) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 19:05:31.256411) ========= 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.a9LXjBr8nM/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.gIAp65564H/Listeners TMPDIR=/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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.004653 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 19:05:31.308107) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-31 19:05:31.311457) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-31 19:05:31.311805) ========= ========= Total master_lag: 1.62 =========