builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0020 starttime: 1485810232.16 results: success (0) buildid: 20170130115108 builduid: 19f5cfcb49cd4bb68030b6a2f0254512 revision: 787766dd27b7373797a3fa6ab7115c85f27c04f2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-30 13:03:52.162526) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-30 13:03:52.162948) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-30 13:03:52.163233) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-30 13:03:52.193917) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 13:03:52.194237) ========= 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.BDf7mOOXMx/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.Whdu4VvwWW/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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-30 13:03:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.7M=0.001s 2017-01-30 13:03:52 (14.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132889 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 13:03:52.351142) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 13:03:52.354500) ========= 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.BDf7mOOXMx/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.Whdu4VvwWW/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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.026227 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 13:03:52.402914) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-30 13:03:52.406272) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 787766dd27b7373797a3fa6ab7115c85f27c04f2 --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 787766dd27b7373797a3fa6ab7115c85f27c04f2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BDf7mOOXMx/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.Whdu4VvwWW/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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-30 13:03:52,498 truncating revision to first 12 chars 2017-01-30 13:03:52,498 Setting DEBUG logging. 2017-01-30 13:03:52,498 attempt 1/10 2017-01-30 13:03:52,498 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/787766dd27b7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-30 13:03:53,770 unpacking tar archive at: mozilla-beta-787766dd27b7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.548968 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-30 13:03:53.981264) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-30 13:03:53.981585) ========= script_repo_revision: 787766dd27b7373797a3fa6ab7115c85f27c04f2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-30 13:03:53.981973) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-30 13:03:53.982248) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-30 13:03:54.001948) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-30 13:03:54.002228) ========= /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.BDf7mOOXMx/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.Whdu4VvwWW/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 13:03:54 INFO - MultiFileLogger online at 20170130 13:03:54 in /builds/slave/test 13:03:54 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 13:03:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:03:54 INFO - {'append_to_log': False, 13:03:54 INFO - 'base_work_dir': '/builds/slave/test', 13:03:54 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:03:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:03:54 INFO - 'branch': 'Mozilla-Beta', 13:03:54 INFO - 'buildbot_json_path': 'buildprops.json', 13:03:54 INFO - 'config_files': ('talos/mac_config.py',), 13:03:54 INFO - 'default_actions': ('clobber', 13:03:54 INFO - 'read-buildbot-config', 13:03:54 INFO - 'download-and-extract', 13:03:54 INFO - 'populate-webroot', 13:03:54 INFO - 'create-virtualenv', 13:03:54 INFO - 'install', 13:03:54 INFO - 'run-tests'), 13:03:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:03:54 INFO - 'download_minidump_stackwalk': True, 13:03:54 INFO - 'download_symbols': 'ondemand', 13:03:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:03:54 INFO - 'tooltool.py': '/tools/tooltool.py', 13:03:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:03:54 INFO - '/tools/misc-python/virtualenv.py')}, 13:03:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:03:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:03:54 INFO - 'installer_path': 'installer.exe', 13:03:54 INFO - 'log_level': 'info', 13:03:54 INFO - 'log_name': 'talos', 13:03:54 INFO - 'log_to_console': True, 13:03:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:03:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:03:54 INFO - 'opt_config_files': (), 13:03:54 INFO - 'pip_index': False, 13:03:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:03:54 INFO - 'cmd': ('bash', 13:03:54 INFO - '-c', 13:03:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:03:54 INFO - 'enabled': True, 13:03:54 INFO - 'halt_on_failure': False, 13:03:54 INFO - 'name': 'check_screen_resolution'},), 13:03:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:03:54 INFO - 'cmd': ('bash', 13:03:54 INFO - '-c', 13:03:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:03:54 INFO - 'enabled': True, 13:03:54 INFO - 'halt_on_failure': False, 13:03:54 INFO - 'name': 'check_screen_resolution'},), 13:03:54 INFO - 'run_cmd_checks_enabled': True, 13:03:54 INFO - 'sps_profile': False, 13:03:54 INFO - 'sps_profile_interval': 0, 13:03:54 INFO - 'suite': 'dromaeojs', 13:03:54 INFO - 'system_bits': '32', 13:03:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:03:54 INFO - 'title': 't-yosemite-r7-0020', 13:03:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:03:54 INFO - 'use_talos_json': True, 13:03:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:03:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:03:54 INFO - 'work_dir': 'build'} 13:03:54 INFO - [mozharness: 2017-01-30 21:03:54.207665Z] Running clobber step. 13:03:54 INFO - Running pre-action listener: _resource_record_pre_action 13:03:54 INFO - Running main action method: clobber 13:03:54 INFO - rmtree: /builds/slave/test/build 13:03:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:03:56 INFO - Running post-action listener: _resource_record_post_action 13:03:56 INFO - [mozharness: 2017-01-30 21:03:56.606177Z] Finished clobber step (success) 13:03:56 INFO - [mozharness: 2017-01-30 21:03:56.606442Z] Running read-buildbot-config step. 13:03:56 INFO - Running pre-action listener: _resource_record_pre_action 13:03:56 INFO - Running main action method: read_buildbot_config 13:03:56 INFO - Using buildbot properties: 13:03:56 INFO - { 13:03:56 INFO - "project": "", 13:03:56 INFO - "product": "firefox", 13:03:56 INFO - "script_repo_revision": "production", 13:03:56 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 13:03:56 INFO - "repository": "", 13:03:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 13:03:56 INFO - "buildid": "20170130115108", 13:03:56 INFO - "pgo_build": "False", 13:03:56 INFO - "basedir": "/builds/slave/test", 13:03:56 INFO - "buildnumber": 19, 13:03:56 INFO - "slavename": "t-yosemite-r7-0020", 13:03:56 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 13:03:56 INFO - "platform": "yosemite_r7", 13:03:56 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 13:03:56 INFO - "branch": "mozilla-beta", 13:03:56 INFO - "repo_path": "releases/mozilla-beta", 13:03:56 INFO - "revision": "787766dd27b7373797a3fa6ab7115c85f27c04f2", 13:03:56 INFO - "stage_platform": "macosx64", 13:03:56 INFO - "builduid": "19f5cfcb49cd4bb68030b6a2f0254512", 13:03:56 INFO - "slavebuilddir": "test" 13:03:56 INFO - } 13:03:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 13:03:56 INFO - Running post-action listener: _resource_record_post_action 13:03:56 INFO - [mozharness: 2017-01-30 21:03:56.612154Z] Finished read-buildbot-config step (success) 13:03:56 INFO - [mozharness: 2017-01-30 21:03:56.612331Z] Running download-and-extract step. 13:03:56 INFO - Running pre-action listener: _resource_record_pre_action 13:03:56 INFO - Running main action method: download_and_extract 13:03:56 INFO - mkdir: /builds/slave/test/build/tests 13:03: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')]} 13:03:56 INFO - trying https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 13:03:56 INFO - Downloading https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/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 13:03:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/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 13:03:57 INFO - Downloaded 1165 bytes. 13:03:57 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 13:03:57 INFO - Using the following test package requirements: 13:03:57 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 13:03:57 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:03:57 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 13:03:57 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:03:57 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 13:03:57 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 13:03:57 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:03:57 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 13:03:57 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 13:03:57 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:03:57 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 13:03:57 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:03:57 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 13:03:57 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:03:57 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 13:03:57 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:03:57 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 13:03:57 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 13:03:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 13:03:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 13:03:57 INFO - Fetch https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 13:03:58 INFO - Http code: 200 13:03:58 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 13:03:58 INFO - x-amz-cf-id: j7qUo-Bs8zkPyYE7oNICl02wSxfp2oGaERht26P43oVEh-pH0RQV1w== 13:03:58 INFO - x-amz-version-id: O.QwiRg.DXPM1Xe0GxIJ_eiR_U0VauG9 13:03:58 INFO - Expected file size: 16088018 13:03:58 INFO - Obtained file size: 16088018 13:04:05 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 13:04:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 13:04:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 13:04:05 INFO - Fetch https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 13:04:05 INFO - Http code: 200 13:04:05 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 13:04:05 INFO - x-amz-cf-id: JikvQ07P4zKkY7RGzpnqd6T2YUtYFT-Rq1cU593Eymy_BmMODMOmUw== 13:04:05 INFO - x-amz-version-id: O.QwiRg.DXPM1Xe0GxIJ_eiR_U0VauG9 13:04:05 INFO - Expected file size: 16088018 13:04:05 INFO - Obtained file size: 16088018 13:04:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 13:04:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 13:04:12 INFO - Fetch https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 13:04:12 INFO - Http code: 200 13:04:12 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 13:04:12 INFO - x-amz-cf-id: xocfw8Kg7SAd-Ze7i1D8bZe0ZmYzPl1j4n6YYIjDAIWCQ57WiynH0A== 13:04:12 INFO - x-amz-version-id: 6Z2kMnpiH0ZgKWOgDqJn4PRJdaZ_7SP3 13:04:13 INFO - Expected file size: 14402992 13:04:13 INFO - Obtained file size: 14402992 13:04: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')]} 13:04:13 INFO - trying https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.dmg 13:04:13 INFO - Downloading https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 13:04:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/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 13:04:15 INFO - Downloaded 82138451 bytes. 13:04:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.dmg 13:04:15 INFO - mkdir: /builds/slave/test/properties 13:04:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:04:15 INFO - Writing to file /builds/slave/test/properties/build_url 13:04:15 INFO - Contents: 13:04:15 INFO - build_url:https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.dmg 13:04:16 INFO - Running post-action listener: _resource_record_post_action 13:04:16 INFO - Running post-action listener: set_extra_try_arguments 13:04:16 INFO - [mozharness: 2017-01-30 21:04:16.256336Z] Finished download-and-extract step (success) 13:04:16 INFO - [mozharness: 2017-01-30 21:04:16.256434Z] Running populate-webroot step. 13:04:16 INFO - Running pre-action listener: _resource_record_pre_action 13:04:16 INFO - Running main action method: populate_webroot 13:04:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:04:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:04:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:04:16 INFO - '--tppagecycles', 13:04:16 INFO - '7'], 13:04:16 INFO - 'tests': ['tsvgm']}}, 13:04:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:04:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:04:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:04:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:04:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:04:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:04:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:16 INFO - 'talos_options': ['--disable-e10s'], 13:04:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:04:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:04:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:16 INFO - 'talos_options': ['--disable-e10s'], 13:04:16 INFO - 'tests': ['damp', 'tps']}, 13:04:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:16 INFO - 'tests': ['damp', 'tps']}, 13:04:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:04:16 INFO - 'tests': ['dromaeo_dom']}, 13:04:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:04:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:04:16 INFO - 'tests': ['basic_compositor_video']}, 13:04:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:04:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:04:16 INFO - 'tests': ['a11yr', 13:04:16 INFO - 'ts_paint', 13:04:16 INFO - 'tpaint', 13:04:16 INFO - 'sessionrestore', 13:04:16 INFO - 'sessionrestore_no_auto_restore', 13:04:16 INFO - 'tabpaint']}, 13:04:16 INFO - 'other-e10s': {'tests': ['a11yr', 13:04:16 INFO - 'ts_paint', 13:04:16 INFO - 'tpaint', 13:04:16 INFO - 'sessionrestore', 13:04:16 INFO - 'sessionrestore_no_auto_restore', 13:04:16 INFO - 'tabpaint']}, 13:04:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:04:16 INFO - 'ts_paint', 13:04:16 INFO - 'tpaint', 13:04:16 INFO - 'sessionrestore', 13:04:16 INFO - 'sessionrestore_no_auto_restore', 13:04:16 INFO - 'tabpaint']}, 13:04:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:04:16 INFO - 'ts_paint', 13:04:16 INFO - 'tpaint', 13:04:16 INFO - 'sessionrestore', 13:04:16 INFO - 'sessionrestore_no_auto_restore', 13:04:16 INFO - 'tabpaint']}, 13:04:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:04:16 INFO - 'tests': ['a11yr', 13:04:16 INFO - 'ts_paint', 13:04:16 INFO - 'tpaint', 13:04:16 INFO - 'sessionrestore', 13:04:16 INFO - 'sessionrestore_no_auto_restore', 13:04:16 INFO - 'tabpaint']}, 13:04:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:04:16 INFO - 'tests': ['a11yr', 13:04:16 INFO - 'ts_paint', 13:04:16 INFO - 'tpaint', 13:04:16 INFO - 'sessionrestore', 13:04:16 INFO - 'sessionrestore_no_auto_restore', 13:04:16 INFO - 'tabpaint']}, 13:04:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:04:16 INFO - 'tests': ['tsvgx', 13:04:16 INFO - 'tsvgr_opacity', 13:04:16 INFO - 'tart', 13:04:16 INFO - 'tscrollx', 13:04:16 INFO - 'cart']}, 13:04:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:04:16 INFO - 'tsvgr_opacity', 13:04:16 INFO - 'tart', 13:04:16 INFO - 'tscrollx', 13:04:16 INFO - 'cart']}, 13:04:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:16 INFO - 'talos_options': ['--disable-e10s'], 13:04:16 INFO - 'tests': ['tp5o']}, 13:04:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:16 INFO - 'tests': ['tp5o']}, 13:04:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:16 INFO - 'talos_options': ['--disable-e10s', 13:04:16 INFO - '--xperf_path', 13:04:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:04:16 INFO - 'tests': ['tp5n']}, 13:04:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:16 INFO - 'talos_options': ['--xperf_path', 13:04:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:04:16 INFO - 'tests': ['tp5n']}}, 13:04:16 INFO - 'talos.zip': {'path': '', 13:04:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:04:16 INFO - Running post-action listener: _resource_record_post_action 13:04:16 INFO - [mozharness: 2017-01-30 21:04:16.275136Z] Finished populate-webroot step (success) 13:04:16 INFO - [mozharness: 2017-01-30 21:04:16.275252Z] Running create-virtualenv step. 13:04:16 INFO - Running pre-action listener: _resource_record_pre_action 13:04:16 INFO - Running main action method: create_virtualenv 13:04:16 INFO - Creating virtualenv /builds/slave/test/build/venv 13:04:16 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 13:04:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:04:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:04:16 INFO - Using real prefix '/tools/python27' 13:04:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:04:17 INFO - Installing distribute.............................................................................................................................................................................................done. 13:04:19 INFO - Installing pip.................done. 13:04:19 INFO - Return code: 0 13:04:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:04:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:04:20 INFO - Reading from file tmpfile_stdout 13:04:20 INFO - Output received: 13:04:20 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) 13:04:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:04:20 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')]} 13:04:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:20 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')]} 13:04:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:20 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 0x10d3ef490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d365570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe809d6ccf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d203d30>, '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 0x10d069db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1fbb20>, '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.BDf7mOOXMx/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.Whdu4VvwWW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 13:04:20 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 13:04:20 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 13:04:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BDf7mOOXMx/Render', 13:04:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:04:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:04:20 INFO - 'HOME': '/Users/cltbld', 13:04:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:04:20 INFO - 'LOGNAME': 'cltbld', 13:04:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:20 INFO - 'MOZ_NO_REMOTE': '1', 13:04:20 INFO - 'NO_EM_RESTART': '1', 13:04:20 INFO - 'PAGER': '/bin/cat', 13:04:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:04:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:20 INFO - 'PWD': '/builds/slave/test', 13:04:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:04:20 INFO - 'SHELL': '/bin/bash', 13:04:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Whdu4VvwWW/Listeners', 13:04:20 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 13:04:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:04:20 INFO - 'USER': 'cltbld', 13:04:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:04:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:04:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:20 INFO - 'XPC_FLAGS': '0x0', 13:04:20 INFO - 'XPC_SERVICE_NAME': '0', 13:04:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:04:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:20 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 13:04:20 INFO - Cleaning up... 13:04:20 INFO - Return code: 0 13:04:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:04:20 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')]} 13:04:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:20 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')]} 13:04:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:20 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 0x10d3ef490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d365570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe809d6ccf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d203d30>, '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 0x10d069db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1fbb20>, '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.BDf7mOOXMx/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.Whdu4VvwWW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 13:04:20 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 13:04:20 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 13:04:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BDf7mOOXMx/Render', 13:04:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:04:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:04:20 INFO - 'HOME': '/Users/cltbld', 13:04:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:04:20 INFO - 'LOGNAME': 'cltbld', 13:04:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:20 INFO - 'MOZ_NO_REMOTE': '1', 13:04:20 INFO - 'NO_EM_RESTART': '1', 13:04:20 INFO - 'PAGER': '/bin/cat', 13:04:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:04:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:20 INFO - 'PWD': '/builds/slave/test', 13:04:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:04:20 INFO - 'SHELL': '/bin/bash', 13:04:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Whdu4VvwWW/Listeners', 13:04:20 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 13:04:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:04:20 INFO - 'USER': 'cltbld', 13:04:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:04:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:04:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:20 INFO - 'XPC_FLAGS': '0x0', 13:04:20 INFO - 'XPC_SERVICE_NAME': '0', 13:04:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:04:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:20 INFO - Downloading/unpacking psutil>=3.1.1 13:04:20 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 13:04:20 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 13:04:20 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 13:04:20 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 13:04:20 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 13:04:20 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 13:04:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:04:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:04:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:04:24 INFO - Installing collected packages: psutil 13:04:24 INFO - Running setup.py install for psutil 13:04:24 INFO - building 'psutil._psutil_osx' extension 13:04:24 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 13:04:24 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 13:04:24 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 13:04:25 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 13:04:25 INFO - building 'psutil._psutil_posix' extension 13:04:25 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 13:04:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:04:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:04:25 INFO - ^ 13:04:25 INFO - 1 warning generated. 13:04:25 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 13:04:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:04:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:04:25 INFO - Successfully installed psutil 13:04:25 INFO - Cleaning up... 13:04:25 INFO - Return code: 0 13:04:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:04: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')]} 13:04:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04: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')]} 13:04:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d3ef490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d365570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe809d6ccf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d203d30>, '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 0x10d069db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1fbb20>, '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.BDf7mOOXMx/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.Whdu4VvwWW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 13:04: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:04: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 mozsystemmonitor==0.3 13:04:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BDf7mOOXMx/Render', 13:04:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:04:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:04:25 INFO - 'HOME': '/Users/cltbld', 13:04:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:04:25 INFO - 'LOGNAME': 'cltbld', 13:04:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:25 INFO - 'MOZ_NO_REMOTE': '1', 13:04:25 INFO - 'NO_EM_RESTART': '1', 13:04:25 INFO - 'PAGER': '/bin/cat', 13:04:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:04:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:25 INFO - 'PWD': '/builds/slave/test', 13:04:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:04:25 INFO - 'SHELL': '/bin/bash', 13:04:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Whdu4VvwWW/Listeners', 13:04:25 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 13:04:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:04:25 INFO - 'USER': 'cltbld', 13:04:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:04:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:04:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:25 INFO - 'XPC_FLAGS': '0x0', 13:04:25 INFO - 'XPC_SERVICE_NAME': '0', 13:04:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:04:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:04:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:04:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:04:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:04:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:04:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:04:28 INFO - Installing collected packages: mozsystemmonitor 13:04:28 INFO - Running setup.py install for mozsystemmonitor 13:04:28 INFO - Successfully installed mozsystemmonitor 13:04:28 INFO - Cleaning up... 13:04:28 INFO - Return code: 0 13:04:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:04: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')]} 13:04:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04: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')]} 13:04:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d3ef490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d365570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe809d6ccf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d203d30>, '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 0x10d069db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1fbb20>, '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.BDf7mOOXMx/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.Whdu4VvwWW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 13:04:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:04:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:04:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BDf7mOOXMx/Render', 13:04:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:04:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:04:28 INFO - 'HOME': '/Users/cltbld', 13:04:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:04:28 INFO - 'LOGNAME': 'cltbld', 13:04:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:28 INFO - 'MOZ_NO_REMOTE': '1', 13:04:28 INFO - 'NO_EM_RESTART': '1', 13:04:28 INFO - 'PAGER': '/bin/cat', 13:04:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:04:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:28 INFO - 'PWD': '/builds/slave/test', 13:04:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:04:28 INFO - 'SHELL': '/bin/bash', 13:04:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Whdu4VvwWW/Listeners', 13:04:28 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 13:04:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:04:28 INFO - 'USER': 'cltbld', 13:04:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:04:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:04:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:28 INFO - 'XPC_FLAGS': '0x0', 13:04:28 INFO - 'XPC_SERVICE_NAME': '0', 13:04:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:04:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:29 INFO - Downloading/unpacking jsonschema==2.5.1 13:04:29 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 13:04:29 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 13:04:29 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 13:04:29 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 13:04:29 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 13:04:29 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 13:04:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:04:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:04:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:04:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:04:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:32 INFO - Downloading functools32-3.2.3-2.tar.gz 13:04:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:04:32 INFO - warning: no files found matching '*.txt' 13:04:32 INFO - no previously-included directories found matching 'build' 13:04:32 INFO - no previously-included directories found matching 'dist' 13:04:32 INFO - no previously-included directories found matching '.git*' 13:04:32 INFO - Installing collected packages: jsonschema, functools32 13:04:32 INFO - Running setup.py install for functools32 13:04:32 INFO - warning: no files found matching '*.txt' 13:04:32 INFO - no previously-included directories found matching 'build' 13:04:32 INFO - no previously-included directories found matching 'dist' 13:04:32 INFO - no previously-included directories found matching '.git*' 13:04:32 INFO - Successfully installed jsonschema functools32 13:04:32 INFO - Cleaning up... 13:04:32 INFO - Return code: 0 13:04:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:04:32 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')]} 13:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:32 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')]} 13:04:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:32 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 0x10d3ef490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d365570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe809d6ccf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d203d30>, '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 0x10d069db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1fbb20>, '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.BDf7mOOXMx/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.Whdu4VvwWW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 13:04:32 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 13:04:32 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 13:04:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BDf7mOOXMx/Render', 13:04:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:04:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:04:32 INFO - 'HOME': '/Users/cltbld', 13:04:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:04:32 INFO - 'LOGNAME': 'cltbld', 13:04:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:32 INFO - 'MOZ_NO_REMOTE': '1', 13:04:32 INFO - 'NO_EM_RESTART': '1', 13:04:32 INFO - 'PAGER': '/bin/cat', 13:04:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:04:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:32 INFO - 'PWD': '/builds/slave/test', 13:04:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:04:32 INFO - 'SHELL': '/bin/bash', 13:04:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Whdu4VvwWW/Listeners', 13:04:32 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 13:04:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:04:32 INFO - 'USER': 'cltbld', 13:04:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:04:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:04:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:32 INFO - 'XPC_FLAGS': '0x0', 13:04:32 INFO - 'XPC_SERVICE_NAME': '0', 13:04:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:04:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:04:32 INFO - Cleaning up... 13:04:32 INFO - Return code: 0 13:04:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:04:32 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')]} 13:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:32 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')]} 13:04:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:32 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 0x10d3ef490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d365570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe809d6ccf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d203d30>, '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 0x10d069db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1fbb20>, '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.BDf7mOOXMx/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.Whdu4VvwWW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 13:04:32 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 13:04:32 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 13:04:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BDf7mOOXMx/Render', 13:04:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:04:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:04:32 INFO - 'HOME': '/Users/cltbld', 13:04:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:04:32 INFO - 'LOGNAME': 'cltbld', 13:04:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:32 INFO - 'MOZ_NO_REMOTE': '1', 13:04:32 INFO - 'NO_EM_RESTART': '1', 13:04:32 INFO - 'PAGER': '/bin/cat', 13:04:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:04:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:32 INFO - 'PWD': '/builds/slave/test', 13:04:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:04:32 INFO - 'SHELL': '/bin/bash', 13:04:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Whdu4VvwWW/Listeners', 13:04:32 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 13:04:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:04:32 INFO - 'USER': 'cltbld', 13:04:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:04:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:04:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:32 INFO - 'XPC_FLAGS': '0x0', 13:04:32 INFO - 'XPC_SERVICE_NAME': '0', 13:04:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:04:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:33 INFO - Downloading/unpacking blobuploader==1.2.4 13:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:04:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:35 INFO - Downloading blobuploader-1.2.4.tar.gz 13:04:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:04:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:04:35 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 13:04:35 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 13:04:35 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 13:04:35 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 13:04:35 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 13:04:35 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 13:04:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:04:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:04:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:04:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:04:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:36 INFO - Downloading docopt-0.6.1.tar.gz 13:04:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:04:37 INFO - Installing collected packages: blobuploader, requests, docopt 13:04:37 INFO - Running setup.py install for blobuploader 13:04:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:04:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:04:37 INFO - Running setup.py install for requests 13:04:37 INFO - Running setup.py install for docopt 13:04:37 INFO - Successfully installed blobuploader requests docopt 13:04:37 INFO - Cleaning up... 13:04:37 INFO - Return code: 0 13:04:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:04:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:04:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d3ef490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d365570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe809d6ccf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d203d30>, '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 0x10d069db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1fbb20>, '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.BDf7mOOXMx/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.Whdu4VvwWW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 13:04:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:04:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:04:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BDf7mOOXMx/Render', 13:04:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:04:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:04:37 INFO - 'HOME': '/Users/cltbld', 13:04:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:04:37 INFO - 'LOGNAME': 'cltbld', 13:04:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:37 INFO - 'MOZ_NO_REMOTE': '1', 13:04:37 INFO - 'NO_EM_RESTART': '1', 13:04:37 INFO - 'PAGER': '/bin/cat', 13:04:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:04:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:37 INFO - 'PWD': '/builds/slave/test', 13:04:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:04:37 INFO - 'SHELL': '/bin/bash', 13:04:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Whdu4VvwWW/Listeners', 13:04:37 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 13:04:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:04:37 INFO - 'USER': 'cltbld', 13:04:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:04:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:04:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:37 INFO - 'XPC_FLAGS': '0x0', 13:04:37 INFO - 'XPC_SERVICE_NAME': '0', 13:04:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:04:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:04:38 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-x5X7Ig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:04:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:04:38 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-A_tbYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:04:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:04:38 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-fFxVn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:04:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:04:38 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-Kyf2hj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:04:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:04:38 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-yMckrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:04:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:04:38 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-PXh6aI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:04:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:04:38 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-BiWb1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:04:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:04:38 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-Cza1_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:04:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:04:38 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-DA8dzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:04:39 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-IKpin9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:04:39 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-fceuO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:04:39 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-bTijhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:04:39 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-ikdDXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:04:39 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-VFWHoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:04:39 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-4qplOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:04:39 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-Qc2HTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:04:39 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-plykWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:04:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:04:39 INFO - Running setup.py install for manifestparser 13:04:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:04:40 INFO - Running setup.py install for mozcrash 13:04:40 INFO - Running setup.py install for mozdebug 13:04:40 INFO - Running setup.py install for mozdevice 13:04:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:04:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:04:40 INFO - Running setup.py install for mozfile 13:04:40 INFO - Running setup.py install for mozhttpd 13:04:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:04:40 INFO - Running setup.py install for mozinfo 13:04:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:04:40 INFO - Running setup.py install for mozInstall 13:04:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:04:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:04:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:04:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:04:41 INFO - Running setup.py install for mozleak 13:04:41 INFO - Running setup.py install for mozlog 13:04:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:04:41 INFO - Running setup.py install for moznetwork 13:04:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:04:41 INFO - Running setup.py install for mozprocess 13:04:41 INFO - Running setup.py install for mozprofile 13:04:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:04:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:04:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:04:41 INFO - Running setup.py install for mozrunner 13:04:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:04:42 INFO - Running setup.py install for mozscreenshot 13:04:42 INFO - Running setup.py install for moztest 13:04:42 INFO - Running setup.py install for mozversion 13:04:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:04:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:04:42 INFO - Cleaning up... 13:04:42 INFO - Return code: 0 13:04:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:04:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:04:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:43 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 0x10d3ef490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d365570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe809d6ccf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d203d30>, '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 0x10d069db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1fbb20>, '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.BDf7mOOXMx/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.Whdu4VvwWW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 13:04:43 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 13:04:43 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 13:04:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BDf7mOOXMx/Render', 13:04:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:04:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:04:43 INFO - 'HOME': '/Users/cltbld', 13:04:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:04:43 INFO - 'LOGNAME': 'cltbld', 13:04:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:43 INFO - 'MOZ_NO_REMOTE': '1', 13:04:43 INFO - 'NO_EM_RESTART': '1', 13:04:43 INFO - 'PAGER': '/bin/cat', 13:04:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:04:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:43 INFO - 'PWD': '/builds/slave/test', 13:04:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:04:43 INFO - 'SHELL': '/bin/bash', 13:04:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Whdu4VvwWW/Listeners', 13:04:43 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 13:04:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:04:43 INFO - 'USER': 'cltbld', 13:04:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:04:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:04:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:43 INFO - 'XPC_FLAGS': '0x0', 13:04:43 INFO - 'XPC_SERVICE_NAME': '0', 13:04:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:04:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:04:43 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-YAWTlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:04:43 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)) 13:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:04:43 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-2NzV9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:04:43 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)) 13:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:04:43 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-fHO5Sb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:04:43 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)) 13:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:04:43 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-xKrOEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:04:43 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)) 13:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:04:43 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-RPfVrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:04:44 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)) 13:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:04:44 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-SiiHs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:04:44 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)) 13:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:04:44 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-H8ge4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:04:44 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)) 13:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:04:44 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-Gq0V4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:04:44 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)) 13:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:04:44 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-94ITBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:04:44 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)) 13:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:04:44 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-tsEUhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:04:44 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)) 13:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:04:44 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-V638lU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:04:44 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)) 13:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:04:44 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-szIo1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:04:44 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)) 13:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:04:44 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-HXUZHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:04:44 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)) 13:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:04:44 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-MgmSM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:04:45 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)) 13:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:04:45 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-Ujx4nM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:04:45 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)) 13:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:04:45 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-aZfR3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:04:45 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)) 13:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:04:45 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-gCcOA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:04:45 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)) 13:04:45 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)) 13:04:45 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)) 13:04:45 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)) 13:04:45 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)) 13:04:45 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)) 13:04:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:04:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:48 INFO - Downloading blessings-1.6.tar.gz 13:04:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:04:48 INFO - Installing collected packages: blessings 13:04:48 INFO - Running setup.py install for blessings 13:04:48 INFO - Successfully installed blessings 13:04:48 INFO - Cleaning up... 13:04:48 INFO - Return code: 0 13:04:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:04:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:04:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:04:48 INFO - Reading from file tmpfile_stdout 13:04:48 INFO - Current package versions: 13:04:48 INFO - blessings == 1.6 13:04:48 INFO - blobuploader == 1.2.4 13:04:48 INFO - docopt == 0.6.1 13:04:48 INFO - functools32 == 3.2.3-2 13:04:48 INFO - jsonschema == 2.5.1 13:04:48 INFO - manifestparser == 1.1 13:04:48 INFO - mozInstall == 1.12 13:04:48 INFO - mozcrash == 1.0 13:04:48 INFO - mozdebug == 0.1 13:04:48 INFO - mozdevice == 0.48 13:04:48 INFO - mozfile == 1.2 13:04:48 INFO - mozhttpd == 0.7 13:04:48 INFO - mozinfo == 0.9 13:04:48 INFO - mozleak == 0.1 13:04:48 INFO - mozlog == 3.4 13:04:48 INFO - moznetwork == 0.27 13:04:48 INFO - mozprocess == 0.23 13:04:48 INFO - mozprofile == 0.28 13:04:48 INFO - mozrunner == 6.13 13:04:48 INFO - mozscreenshot == 0.1 13:04:48 INFO - mozsystemmonitor == 0.3 13:04:48 INFO - moztest == 0.8 13:04:48 INFO - mozversion == 1.4 13:04:48 INFO - psutil == 3.1.1 13:04:48 INFO - requests == 1.2.3 13:04:48 INFO - wsgiref == 0.1.2 13:04:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:04: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')]} 13:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04: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')]} 13:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:48 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 0x10d3ef490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d365570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe809d6ccf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d203d30>, '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 0x10d069db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1fbb20>, '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.BDf7mOOXMx/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.Whdu4VvwWW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 13:04:48 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 13:04:48 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 13:04:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BDf7mOOXMx/Render', 13:04:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:04:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:04:48 INFO - 'HOME': '/Users/cltbld', 13:04:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:04:48 INFO - 'LOGNAME': 'cltbld', 13:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:48 INFO - 'MOZ_NO_REMOTE': '1', 13:04:48 INFO - 'NO_EM_RESTART': '1', 13:04:48 INFO - 'PAGER': '/bin/cat', 13:04:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:48 INFO - 'PWD': '/builds/slave/test', 13:04:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:04:48 INFO - 'SHELL': '/bin/bash', 13:04:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Whdu4VvwWW/Listeners', 13:04:48 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 13:04:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:04:48 INFO - 'USER': 'cltbld', 13:04:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:04:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:48 INFO - 'XPC_FLAGS': '0x0', 13:04:48 INFO - 'XPC_SERVICE_NAME': '0', 13:04:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:49 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)) 13:04:49 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)) 13:04:49 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)) 13:04:49 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)) 13:04:49 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)) 13:04:49 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)) 13:04:49 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)) 13:04:49 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)) 13:04:49 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)) 13:04:49 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)) 13:04:49 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)) 13:04:49 INFO - Cleaning up... 13:04:49 INFO - Return code: 0 13:04:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:04:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:49 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 0x10d3ef490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d365570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe809d6ccf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d203d30>, '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 0x10d069db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1fbb20>, '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.BDf7mOOXMx/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.Whdu4VvwWW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 13:04:49 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 13:04:49 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 13:04:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BDf7mOOXMx/Render', 13:04:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:04:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:04:49 INFO - 'HOME': '/Users/cltbld', 13:04:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:04:49 INFO - 'LOGNAME': 'cltbld', 13:04:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:49 INFO - 'MOZ_NO_REMOTE': '1', 13:04:49 INFO - 'NO_EM_RESTART': '1', 13:04:49 INFO - 'PAGER': '/bin/cat', 13:04:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:04:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:49 INFO - 'PWD': '/builds/slave/test', 13:04:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:04:49 INFO - 'SHELL': '/bin/bash', 13:04:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Whdu4VvwWW/Listeners', 13:04:49 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 13:04:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:04:49 INFO - 'USER': 'cltbld', 13:04:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:04:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:04:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:49 INFO - 'XPC_FLAGS': '0x0', 13:04:49 INFO - 'XPC_SERVICE_NAME': '0', 13:04:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:04:49 INFO - Cleaning up... 13:04:49 INFO - Return code: 0 13:04:49 INFO - Running post-action listener: _resource_record_post_action 13:04:49 INFO - Running post-action listener: _start_resource_monitoring 13:04:49 INFO - Starting resource monitoring. 13:04:49 INFO - [mozharness: 2017-01-30 21:04:49.542543Z] Finished create-virtualenv step (success) 13:04:49 INFO - [mozharness: 2017-01-30 21:04:49.543544Z] Running install step. 13:04:49 INFO - Running pre-action listener: _resource_record_pre_action 13:04:49 INFO - Running main action method: install 13:04:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:04:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:04:49 INFO - Reading from file tmpfile_stdout 13:04:49 INFO - Detecting whether we're running mozinstall >=1.0... 13:04:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:04:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:04:49 INFO - Reading from file tmpfile_stdout 13:04:49 INFO - Output received: 13:04:49 INFO - Usage: mozinstall [options] installer 13:04:49 INFO - Options: 13:04:49 INFO - -h, --help show this help message and exit 13:04:49 INFO - -d DEST, --destination=DEST 13:04:49 INFO - Directory to install application into. [default: 13:04:49 INFO - "/builds/slave/test"] 13:04:49 INFO - --app=APP Application being installed. [default: firefox] 13:04:49 INFO - mkdir: /builds/slave/test/build/application 13:04:49 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'] 13:04:49 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 13:05:11 INFO - Reading from file tmpfile_stdout 13:05:11 INFO - Output received: 13:05:11 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 13:05:11 INFO - Running post-action listener: _resource_record_post_action 13:05:11 INFO - [mozharness: 2017-01-30 21:05:11.074819Z] Finished install step (success) 13:05:11 INFO - [mozharness: 2017-01-30 21:05:11.074942Z] Running run-tests step. 13:05:11 INFO - Running pre-action listener: _resource_record_pre_action 13:05:11 INFO - Running main action method: run_tests 13:05:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:05:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:05:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:05:11 INFO - 2017-01-30 13:05:11.089 screenresolution[1619:7388] starting screenresolution argv=screenresolution get 13:05:11 INFO - 2017-01-30 13:05:11.092 screenresolution[1619:7388] Display 0: 1600x1200x32@60 13:05:11 INFO - 2017-01-30 13:05:11.098 screenresolution[1620:7390] starting screenresolution argv=screenresolution list 13:05:11 INFO - Available Modes on Display 0 13:05:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:05:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:05:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:05:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:05:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:05:11 INFO - Intel Iris: 13:05:11 INFO - Chipset Model: Intel Iris 13:05:11 INFO - Type: GPU 13:05:11 INFO - Bus: Built-In 13:05:11 INFO - VRAM (Dynamic, Max): 1536 MB 13:05:11 INFO - Vendor: Intel (0x8086) 13:05:11 INFO - Device ID: 0x0a2e 13:05:11 INFO - Revision ID: 0x0009 13:05:11 INFO - Displays: 13:05:11 INFO - Display: 13:05:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:05:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:05:11 INFO - Display Serial Number: 1600x1200 60 13:05:11 INFO - Main Display: Yes 13:05:11 INFO - Mirror: Off 13:05:11 INFO - Online: Yes 13:05:11 INFO - Rotation: Supported 13:05:11 INFO - Return code: 0 13:05:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:05:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:05:11 INFO - Python 2.7.3 13:05:11 INFO - Return code: 0 13:05:11 INFO - grabbing minidump binary from tooltool 13:05:11 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')]} 13:05:11 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 0x10d203d30>, '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 0x10d069db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1fbb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:05:11 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 13:05:11 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 13:05:11 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 13:05:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:05:11 INFO - Return code: 0 13:05:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:05:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:05:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:05:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:05:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:05:11 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/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0020', '--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 13:05:11 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/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0020 --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 13:05:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BDf7mOOXMx/Render', 13:05:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:05:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:05:11 INFO - 'HOME': '/Users/cltbld', 13:05:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:05:11 INFO - 'LOGNAME': 'cltbld', 13:05:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:05:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:11 INFO - 'MOZ_NO_REMOTE': '1', 13:05:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:05:11 INFO - 'NO_EM_RESTART': '1', 13:05:11 INFO - 'PAGER': '/bin/cat', 13:05:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:05:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:05:11 INFO - 'PWD': '/builds/slave/test', 13:05:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:05:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:05:11 INFO - 'SHELL': '/bin/bash', 13:05:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Whdu4VvwWW/Listeners', 13:05:11 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 13:05:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:05:11 INFO - 'USER': 'cltbld', 13:05:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:05:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:11 INFO - 'XPC_FLAGS': '0x0', 13:05:11 INFO - 'XPC_SERVICE_NAME': '0', 13:05:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:05:11 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/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0020', '--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 13:05:11 INFO - mozversion application_buildid: 20170130115108 13:05:11 INFO - mozversion application_changeset: 787766dd27b7373797a3fa6ab7115c85f27c04f2 13:05:11 INFO - mozversion application_display_name: Firefox 13:05:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:05:11 INFO - mozversion application_name: Firefox 13:05:11 INFO - mozversion application_remotingname: firefox 13:05:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:05:11 INFO - mozversion application_vendor: Mozilla 13:05:11 INFO - mozversion application_version: 52.0 13:05:11 INFO - mozversion platform_buildid: 20170130115108 13:05:11 INFO - mozversion platform_changeset: 787766dd27b7373797a3fa6ab7115c85f27c04f2 13:05:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:05:11 INFO - mozversion platform_version: 52.0 13:05:11 INFO - using testdate: 1485810311 13:05:11 INFO - actual date: 1485810311 13:05:11 INFO - starting webserver on 'localhost:49240' 13:05:11 INFO - SUITE-START | Running 2 tests 13:05:11 INFO - TEST-START | dromaeo_css 13:05:11 INFO - operating with platform_type : mac_ 13:05:11 INFO - Initialising browser for dromaeo_css test... 13:05:11 INFO - TEST-INFO | started process 1630 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmpLnxuFl/profile http://localhost:49240/getInfo.html) 13:05:14 INFO - PROCESS | 1630 | __metrics Screen width/height:1600/1200 13:05:14 INFO - PROCESS | 1630 | colorDepth:24 13:05:14 INFO - PROCESS | 1630 | Browser inner width/height: 1024/689 13:05:14 INFO - PROCESS | 1630 | __metrics 13:05:14 INFO - PROCESS | 1630 | 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" 13:05:14 INFO - PROCESS | 1630 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:05:15 INFO - TEST-INFO | 1630: exit 0 13:05:15 INFO - Browser initialized. 13:05:15 INFO - Running cycle 1/1 for dromaeo_css test... 13:05:15 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmpLnxuFl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:05:27 INFO - PROCESS | 1633 | RSS: Main: 171855872 13:05:27 INFO - PROCESS | 1633 | 13:08:30 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 13:08:31 INFO - PROCESS | 1633 | RSS: Main: 317353984 13:08:31 INFO - PROCESS | 1633 | 13:11:34 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 13:11:35 INFO - PROCESS | 1633 | RSS: Main: 300527616 13:11:35 INFO - PROCESS | 1633 | 13:14:37 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 13:14:37 INFO - PROCESS | 1633 | RSS: Main: 276811776 13:14:37 INFO - PROCESS | 1633 | 13:17:40 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 13:17:40 INFO - PROCESS | 1633 | RSS: Main: 270176256 13:17:40 INFO - PROCESS | 1633 | 13:20:43 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 13:20:44 INFO - PROCESS | 1633 | RSS: Main: 258408448 13:20:44 INFO - PROCESS | 1633 | 13:23:47 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 13:23:47 INFO - PROCESS | 1633 | RSS: Main: 470794240 13:23:47 INFO - PROCESS | 1633 | 13:23:47 INFO - PROCESS | 1633 | __start_tp_report 13:23:47 INFO - PROCESS | 1633 | _x_x_mozilla_page_load 13:23:47 INFO - PROCESS | 1633 | _x_x_mozilla_page_load_details 13:23:47 INFO - PROCESS | 1633 | |i|pagename|runs| 13:23:47 INFO - PROCESS | 1633 | |0;dojo.html;2891.219370769892;3468.479728040795;3489.6335884732102;3495.073805441557;3543.2736289060745;5738.7417566209515;5774.133879918009;5776.075827867542;5792;5804.912926306109;5544.0575102232615;5739.713014349276;5834.124881267812;5852.67810270435;5895.027320492114;5246.658967167141;5262.947370526284;5301.204819277101;5344.091504444254;5354.089804733185;5209.7134657593815;5214.66104703195;5227.111391063529;5339.41266460691;5356.678599284036;5259.31628888244;5288.233206185101;5291.1798671206025;5297.496737809921;5335.946640533603;5222.73886305687;5280.630355875091;5304.92042619361;5340.54605358545;5346.064438723247;5220.582353411718;5288.312519372457;5301.840944771663;5302.893942121136;5349.679019258857;5658.066419040853;5708.971455142698;5711.571632127607;5769.538436925036;5916.378780228057;6227.314995350508;6232.626042437469;6236.469900058501;6243.500519958392;6256.5307601930035;6248.562600617958;6252.624842509464;6259.405356491126;6262.780802671885;6265;5752.827415177551;5813.360530341659;5814.389489103668;5980.671063091529;5999.250093738283;6171.753129874754;6244.2819075806865;6248.50011999039;6257.5932564383165;6263.655498947602;6110.232775507349;6162.907556386658;6164.383561643889;6175.413335733188;6180.66006369645;6208.4722798561725;6213.409726076015;6219.626822390671;6223.408776166257;6223.564350495421;5252.474752524717;6209.037599172136;6240;6246.250449946036;6255;6128.442013630915;6152.046432802923;6191.9690401547705;6219.0982307566055;6260.530460215502;4967.031428871335;4987.950120498748;4991.0267497838295;5014.774335154927;5024.924626130611;4449.577290157495;4462.799174037176;4469.4860091089295;4476.776161191928;4492.820287188541;5719.599628025998;5804.854878627983;5864.560157988168;5892.998190307572;5937.317208520989;6235.438810507076;6253.96873015632;6261.78083767066;6269.780557680459;6270.372962703693;5891.970540147272;5900.203472531153;5920.733566989496;5929.436703513245;6028.065649824284;4723.905521889543;5497.835064947978;5527.778888844482;5536.058869992111;5549;6437.549371543947;6470.611763294218;6476.708548115252;6477.611343319416;6493.935060649333;6170.722317495633;6233.657148856856;6233.719482623203;6239.188905442264;6255.46828519581;5171.9482805171465;6253.187085678833;6318.115463834974;6348.587341822767;6349.269833969152;6148.231471066117;6238.438540531374;6238.656873871799;6250.374962503895;6257.468115210076;6228.03465462854;6238.750449982132;6240.375962403905;6241.095041219089;6264.5301602379095;6047.879042419215;6111.287884814121;6122.204113465221;6224.190855188796;6228.719707613259;5497.285352904097;5891.1457838612305;6238.563300568917;6251.406116419115;6257.342978987141;5968.403159683997;6057.818265452043;6098.26820781509;6110.725017374318;6121.693915304306;6059.969700151471;6131.417515336036;6162.033122793022;6223.222097237845;6247.031710084944;6046.062860256668;6068.544859135671;6110.419510146529;6149.200603921461;6150.138980542817 13:23:47 INFO - PROCESS | 1633 | |1;ext.html;484.721285260975;534.433500489481;538.4077514733793;551.8620344913771;561.6377436553421;25496.87251563742;31749.88875389359;40916.59083409165;41876.74369768904;44330.55669443305;36290;43240;43762.78118609411;43789.34315985263;43798.78100609493;9540.475273859918;9731.464769437678;9732.026797320246;9733.853992190123;9760.804783904317;8917.197452229299;9149.908500914973;11450.656480305604;11709.121815863802;11743;11667.883321166806;11721.941390293037;11724.706882327968;11728;11739.060875130011;10092.343997640204;11749.060075194007;11845.703857403547;11853.992410645105;11855.762884742257;11661.941690291578;11744.58893938708;11775.7056073598;11777.587784427504;11782.528698852035;40995;41115.38326925098;41153.58846411527;41319.7934010331;41333.379999300036;3406.7104296134858;3450.46517789743;3590.407582748843;3629.745917785756;4231.767252801094;31136.221594460094;31218.063458096065;31311;31333.529997050064;31796.72313246324;3131.4519959007084;3219.4687876500348;3253.544503769474;3265.379577880219;3288.8848890288723;509473;511969;512971;514633;516142;53487;62981.74036519244;63701;63760.36239637544;63964.68017659975;37025;37138.62861371352;37328.440073398924;37442.876713698635;37530;16868.409605663743;17050.573735656708;17054.573635659206;17087.658246835243;17096.57258568546;11364.261323013978;11612;13058.738825223443;13151.079424440388;13169;19015.714764278546;19226;19482.318118865773;19541.316053938044;19558.5110372239;6736.494762892705;6827.317268273133;7831.765047048598;7903;7971.123176450586;862.9654813807377;940.0646356874817;1008.8839783424853;1027.8715160604925;1056.6618682021679;28979.420411592073;29002.03424057488;30509.694903051128;31035.68964310373;31966.680333196837;1038.3873514626255;1056.10758908722;1067.9107310543202;1093.6117678224275;1102.404701461202;14990.775138372934;15525.534233973;15561.610959725871;15710.293036813371;15926.442574510069;703764;704525;704677;705463;708578.4571077111;57451;57851.421485785446;57964.71017644969;58067.70966145142;58147.4185258142;1305.3212329588562;1342.8724271194417;1423.5408706075941;1425.5153247895764;1449.159487497249;29312.97404590829;30713;30986.380272394876;31087.844560777958;31281.374372512877;45568.31647525356;46048.53951460576;46097.53902460932;46140;46143.307850382946;593205;598759;600369;601026;602013;23608.17371391993;23671;26650.733492664825;26654.466910662068;27241.046563370186;45271;45303.54696452993;45312.320315194636;45538.77230613826;45918;37686.2462750738;38202.808985956006;38533.807330963165;38709.80645096869;38808;37336.6266337344;38245.80877095597;38331.808340958116;39036.41445378265;39333.2133357337;37439;38220.80889595534;38228.42657360086;38396.42405363978;38461.615383845805;28592.714072859006;33111.83444082764;33503;34403.65596344005;34522.48216276808;25571.488570228863;25823.0961916332;25989.74010259873;26004.156508532924;26078.60882086732 13:23:47 INFO - PROCESS | 1633 | |2;jquery.html;327.9852406641701;391.9333713268744;395.4858683711176;406.8270984831446;417.1989779623123;19641.01794910254;20337.49156271094;21113.57772844544;21117.894410527944;21638.783612163872;11855.288682679045;12226.327551984637;12352.814707779367;12380;20010.399688009384;5394.02907476654;5655.971720141414;5664.688442135681;5665.23519324892;5675.943240567603;5456.590755693319;5549.250851135085;5887.322957859858;6070.998285282945;6199.69001549923;6232.3144454110015;6232.781852635158;6262.655553944532;6265.404786545294;6267.122602835607;6676.3657452542175;6796.150481189851;6862.593168400466;6866.141732283465;6870.553414028072;5193.454687257859;5428.104362780136;5495.340559132889;6084.847878803021;6101.816945491642;13526.458941642322;13831;13885.166889986633;18033.639327213514;25709.35726606831;2156.482444213393;2238.6530087836413;2315.3285547191294;2371.229350461107;2625.4617803350266;10243.078122968895;10392;10654.520546575346;10821.296615719953;12802.551910683174;1834.715619079045;1837.8345948864667;1839.0528877628033;1888.830005299516;1934;121182;124076;127217;127461.36269318686;129792;11482.138839586898;11622.360770157553;11626.651200463999;11688.532458701557;11842.822357664641;15110.471133510495;15121.16833574164;15171.468998584996;15171.772423413657;15179.544613661608;7831.942687737082;8522.232999030117;8580.14198580137;8634.740957771277;8719.302455803521;8468.882779305173;8512.659493620185;8527.40308178434;8643.91356086431;8710.564471776386;4607.516210797885;4623.838165664186;4645;4723.48041715411;4774.522547745198;1909.5226193451638;1950.8439324853978;1986.9403917882487;1991.0940522062426;1992.6512860249397;863.7408777366765;897.5063714956748;907.9546022698838;920.5673333533229;1012.6708819633649;19772.90113549423;21039.05324260412;21209.469763255733;21269.36191914245;21300.893495532422;781.3318564864056;855.5508358112041;965.830979578585;966.4394651102484;997.9322125325832;10478.37129772216;11112.333260004263;11140.442977851075;11144.387058711849;11150.832737508943;591842;598381;610913;621486;625373;83921.58039209765;101082.49458752807;105733.97464623358;120206;135717;958.4201558057275;989.8119357322086;994.597188138805;1005.5022763732;1006.3559322033905;19169.32907348236;19444.902775486597;19884.70172947436;19896.60206795885;19905.900470497556;54509.454905452025;54704.45295547153;55882.76468941197;56905;56972.57568560819;79971.60014199892;81407.59296203482;81722.59138704269;82592.58703706443;84944;7844.058712954482;8108.675652973815;8108.83782324362;8321.043080045873;8370.330373569977;9950.601975920883;11159.553617855196;11912.702182445508;12579.685507862378;13148.868511315148;10562.207834412604;10703.678889633324;10754.300970436896;10992.835107473235;11436.62760468749;11054.778904421706;11096.833547496633;11206.663800086011;11294.548218071184;11541.942290288494;11167.944160279472;11476.655700329004;11488.942555287504;11515.424228788695;11561.537538498702;7971;8040.39697022714;8188.2630563249595;8263.669453222044;8425.620847061775;8217.260446559838;10544.84182737275;10941.835872461761;11561.595344162914;11761.705957351134 13:23:47 INFO - PROCESS | 1633 | |3;mootools.html;1364.249662685523;1526.854948779866;1728.5073753980118;1908.4847091285344;1932.6134773045394;8240.711575094872;8649.437786543871;8670.653173873054;8674.132586741323;8684.609192586333;7698.6535605897725;7894.881576776339;7915.564643944581;8150.184981501847;8507.829843403128;2352.564775516535;2410.3251089694913;2411.553862535428;2412.1316326122583;2416.0698131219433;2411.2043025801445;2418.322869596516;2430.793382562484;2444.64552639868;2446.987765061172;2389.8924548395275;2396;2419.830611857171;2426.102342133413;2428.5142971405703;2250.381145185079;2282.109977108929;2304.7119110111234;2305.4582173189287;2308.0767692922796;2410.9397265068337;2428.81783866209;2429.7205821330595;2430.453148041694;2437.4150203951103;8464.280536154434;8507.574621268912;8582.656693732306;8587.141285871363;8588.785280367978;5179.274901513753;5319.707416092114;5330.973345133289;5335.6798592084215;5339.6262261641705;3324.7506437017078;3519.6304388039143;3619.0952261934517;3687.815609219528;3691.427828686558;1081.0810810810765;1081.4430568257353;1108.6230681568225;1111.3831823338044;1127.1039523578775;10825;10942.4528773561;11033.724156896142;11049.944750276198;11082.335059896352;4258.467691538558;4365.410669559632;4723.315119307681;4767.547083027107;4790.329353890388;9647.179989700813;9649;9651.565679544437;9655;9661.516924153764;5330.680159190383;5331.893362132736;5335;5342.519173274424;5344.43883392246;4350.390945267665;4634.837780677727;4818.445878723992;4847.079054979543;4921.655484116149;3944.3294639911283;3973.344398174269;4019.7789121598007;4069.877903662895;4075.409065685459;1117.6423544465856;1260.3068312428127;1269.853966793812;1277.7763891318982;1277.7827769279245;832.9333653307721;839.4795226959325;853.4068822168657;897.7306807957586;926.0878035135386;5626.521745651666;5703.543716502752;5720.170575266647;5841.357450680422;5985.46130848217;435.5318033114415;454.94540655121597;465.3322482237999;465.3415417184713;466.04693401993006;3844.1927195289304;3930.449737036817;3992.5807790182193;4067.654249388835;4072.75563466193;9802.705918822447;10188.337758045704;10213.846792298122;10278.743031424274;10291.33106348085;9613.51932403377;10015.849762253572;10134.645287414905;10134.645287414905;10183.032611901857;7750.651220694969;7969.282764551218;7970.123286438487;7974;7976.601169941479;5473.698946557818;5492.862678432912;5868.589198756046;5910.172575839472;6012.068129439944;9530.904690953003;9601.567929443332;9612.51937403113;9649.662261820802;9651.565679544578;9494.240460762985;9686.370385924893;9836.409815411098;9836.60653573849;9845.45849978258;6771.932280677327;6967.65161741921;7119.572825630479;7257.709691612487;7394.630268486661;7833.960830195812;8138.959305203436;8139.064007639197;8149.388795840454;8166.469179503313;7026.367626913602;7142.357187853118;7307.671154798153;7368.59472729005;7387.150477695134;6856.897146542706;7076.681549330396;7112.182099058675;7186.676599552928;7224.638768061681;6700.597964122168;6706.5640733352175;6791.592504449749;6792.72829086831;6798.558093723892;4856.028794241237;4865.221564549655;4890.902181956412;4914.238293064581;4935.703857768545;4821.855344339676;4825.445073816556;4833.782479788489;4991.675541089818;4997.525235102659 13:23:47 INFO - PROCESS | 1633 | |4;prototype.html;279.3992915232249;313.2435169066704;315.91786135604735;321.70081823903774;326.8855900434847;4788.784504697288;5285.207218917164;5402.29770129883;5421.647592906464;5470.671759694421;4465.263231566788;5306.92039619406;5325.467453254672;5390.73046347683;5414.269073675053;4208.663306935453;4214.578542145776;4219;4226.056014233464;4244.962418039343;3895.9805200973956;4218.789060546976;4221.641160501361;4226.978865105685;4231.894202644928;4095.5290141633795;4111.259973204822;4126.669866410695;4129.442525259096;4140.896477588054;4084.1627466369323;4101.364288535282;4104.056067104582;4107.7535347879075;4138.420621113047;3291.062047316503;3320.535125082466;3570.357335679577;3581.3016461789703;3603.4414665726854;5117.974410127926;5221.530062294411;5340.866478338034;5344.5724342052545;5363.785448582052;4427.601515863587;4719.905601887977;4729.787159577827;4741.170295198326;4744.620430365562;4898.681585696918;5713.600407757378;5716.742746576372;5719.628224165416;5731.627444216154;3431.4509678451327;3683.950074228832;3850.403187505941;3941.2314598653275;3952.32810422226;5180.171172612401;6007.939920600826;6023.951856368855;6052.848678783022;6055.909161362583;3453.9827300863335;3754.1553150541454;3999.6004395165087;4017.517897852218;4023.637872591481;3569.678728914358;3725.068732816796;3761.435784632327;3916.5691773904846;4055.2497787909333;3806.676432503268;3997.84008639657;4084.387341898739;4327.32926396409;4724.267738500538;5085.567726743194;5636.8298205191295;5697.914531282034;5737.627054241461;5768.855778605568;1075.3279200499687;1183.5798291606527;1248.4382028087398;1254.5922575163108;1297.6236891301605;872.1757938747822;890.0743227043802;893.6648756716231;894.6779159502574;901.963921443148;4787.994521150527;5016.724080175552;5064.873378165576;5205.583553315726;5208.7916483341;5289.497497737709;5581.944180558143;5623.381428042912;5681.403452637496;5719.799807006735;4714.528547145258;4959.429665588504;5114.820981265638;5119.283300337956;5162.308949101411;2530.443302473453;2537.7191451158237;2799.3981294021883;2921.21127295629;2935.8109965464023;5139.743012849342;5633.69014704187;5719.569183097167;5824.11706205431;6097.810926869218;5815.82552523425;5859.44335288147;6097.298810636834;6108.969455152695;6127.938720612737;5153.510416510426;5400.837974860682;5458.61789674719;6183.505319574513;6192.659403732838;5220.216967454912;5516.282883225155;5936.703164841827;5972.671503067373;5981.282246130492;4894.486078961658;4905.1416002200185;5181.445471478507;5887.4406931341455;5904.468597826216;5893.616914900518;5989.490893274121;6137;6207.193064901715;6236.534414412518;3523.978046366525;3717.7173875013077;3751.3247615429486;4023.6781057515914;4038.8990275243355;4874.6344024197615;5069.569086627531;5653.915191272052;5776.682282474504;6053.606515576474;5106.642535022513;5655.632383895034;5759.481646651821;5803.767849285981;5810.738516766671;5077.593792496666;5750.856228594319;5790.478856902899;5797.913031304618;5834.94165058361;4538.387317712067;4718.952810471851;5417.7832886685665;5446.455354464521;5571.749271282721;4870.853874383774;5263.184206448007;5458.77177635029;5740.68426236561;5752.309722833287;5153.922691159711;5362.65142765719;5602.551795856403;5637.238972738628;5659.26429564154 13:23:47 INFO - PROCESS | 1633 | |5;yui.html;672.7678950761987;711.7935798618398;715.5670819154408;724.3878922310647;752.6312107067539;14060.086094403869;14693.92653036736;15074.6985060299;15105.471308504204;15268.618284542892;13736.24450655216;13910.930445347785;13911.721765564682;13912.791308130387;13936.58190254294;687.1959807025792;707;822.440740296598;829.1749709039484;843.3885433061027;700.1772916822738;704.8449341144966;813.2558708781487;853.4751128056232;858.0432817408607;859.6647307550061;876.5836227791812;906.4017748286133;907.4872696926249;910.8406028944942;896.6727144592177;897.1835629577054;899.9640014399416;900.7477906186278;900.75679566517;667.4893706314673;667.9980029955068;670.0418401685588;671.0940230688581;672.3310306245318;13468.191908485522;13747.656308592264;13786.034977551575;13797.517086902011;14477.493287734984;13838.100523466042;14163.15021098727;14224.502142424966;14302.356393962296;14359.282035898163;11163.106951443864;11187.216894817366;11271.26736762116;11332.263402878869;11548.307101573933;3716.7955762433057;3749.737518373715;3781.6785573226034;3786.7917264550438;3887.5140607424073;78984;82732;85759.57120214359;93493.06506934912;100464;10403.427811470441;10842.158095342127;10904.291221070605;10909.563617455371;11064.612738554111;21324.466888327606;21637.567248654937;21654.783452165277;21674.24140155087;21705.891470542545;7886.211378862183;7971.960140199262;8180;8254.504729716236;8304.875426868603;4381.6932814703305;4463.107378524308;4492.887677808081;4540.228161212536;4572.222722137245;3440.1571614954496;3570.696490798259;3571.178628915312;3573.160307327776;3574.338747331752;643.6427782580619;646.8544577470032;656.1076935367896;656.7241758461457;671.0906721392442;587.524105474567;609.387565496673;648.5330561995356;664.0534017869962;712.9536580122275;9079.409838360618;9334.673286435078;9383.155516003593;9459.858102128474;9622.422654640744;590.5629833922866;637.5951270942892;639.9616023038633;647.970841312142;680.0143580744239;4420.336949457607;4591.609713174351;4608.239640459354;4609.95390046102;4657.347971284023;116444;117440.8255917447;123233;126660;127634;104847;109223.36164957532;109502.45248773706;109542.45228773965;110570.44714776374;94444.58333125009;95265;95662.52168739111;95773;97879.51060244796;8756.387052906235;8943.508107054175;9035.954820225857;9039.322050846082;9058.275337973078;60865;61307.69346153419;61655.69172154111;61737.765244693954;62618;72930.63534682292;84409;87643;91788.5410572943;91898.54050729703;11402.486888090221;11615.303081815118;11651.941740291244;11874.287542747463;12036.578719745117;12305.630831075083;12561.062790420545;12586.24482531051;12613.180143290656;12714.936425318185;11378.715532111764;11577.6526704199;11592.304461732323;11878.821817672915;12163.878361216275;11626.53493860236;12336.444859981142;12348.444320005441;12350.938245308716;12446.502139914664;11438.542458301908;12028.639140825439;12060.276383417024;12322.445489952794;12438.689032773891;9981;10228.795424091626;10287.279890407599;10688.572457101629;10842.512086955949;9139.223166030695;10222.846657300295;10268.743281418025;10353.689389318333;10446.529906154394 13:23:47 INFO - PROCESS | 1633 | __end_tp_report 13:23:47 INFO - PROCESS | 1633 | __start_cc_report 13:23:47 INFO - PROCESS | 1633 | _x_x_mozilla_cycle_collect,1491 13:23:47 INFO - PROCESS | 1633 | __end_cc_report 13:23:47 INFO - PROCESS | 1633 | __startTimestamp1485811427618__endTimestamp 13:23:47 INFO - PROCESS | 1633 | 13:23:47 INFO - PROCESS | 1633 | ------- Summary: start ------- 13:23:47 INFO - PROCESS | 1633 | Number of tests: 6 13:23:47 INFO - PROCESS | 1633 | 13:23:47 INFO - PROCESS | 1633 | [#0] dojo.html Cycles:165 Average:5787.65 Median:6057.82 stddev:638.25 (10.5%) stddev-sans-first:598.40 13:23:47 INFO - PROCESS | 1633 | Values: 2891.2 3468.5 3489.6 3495.1 3543.3 5738.7 5774.1 5776.1 5792.0 5804.9 5544.1 5739.7 5834.1 5852.7 5895.0 5246.7 5262.9 5301.2 5344.1 5354.1 5209.7 5214.7 5227.1 5339.4 5356.7 5259.3 5288.2 5291.2 5297.5 5335.9 5222.7 5280.6 5304.9 5340.5 5346.1 5220.6 5288.3 5301.8 5302.9 5349.7 5658.1 5709.0 5711.6 5769.5 5916.4 6227.3 6232.6 6236.5 6243.5 6256.5 6248.6 6252.6 6259.4 6262.8 6265.0 5752.8 5813.4 5814.4 5980.7 5999.3 6171.8 6244.3 6248.5 6257.6 6263.7 6110.2 6162.9 6164.4 6175.4 6180.7 6208.5 6213.4 6219.6 6223.4 6223.6 5252.5 6209.0 6240.0 6246.3 6255.0 6128.4 6152.0 6192.0 6219.1 6260.5 4967.0 4988.0 4991.0 5014.8 5024.9 4449.6 4462.8 4469.5 4476.8 4492.8 5719.6 5804.9 5864.6 5893.0 5937.3 6235.4 6254.0 6261.8 6269.8 6270.4 5892.0 5900.2 5920.7 5929.4 6028.1 4723.9 5497.8 5527.8 5536.1 5549.0 6437.5 6470.6 6476.7 6477.6 6493.9 6170.7 6233.7 6233.7 6239.2 6255.5 5171.9 6253.2 6318.1 6348.6 6349.3 6148.2 6238.4 6238.7 6250.4 6257.5 6228.0 6238.8 6240.4 6241.1 6264.5 6047.9 6111.3 6122.2 6224.2 6228.7 5497.3 5891.1 6238.6 6251.4 6257.3 5968.4 6057.8 6098.3 6110.7 6121.7 6060.0 6131.4 6162.0 6223.2 6247.0 6046.1 6068.5 6110.4 6149.2 6150.1 13:23:47 INFO - PROCESS | 1633 | 13:23:47 INFO - PROCESS | 1633 | [#1] ext.html Cycles:180 Average:72654.65 Median:3610.08 stddev:163646.21 (4533.0%) stddev-sans-first:164015.57 13:23:47 INFO - PROCESS | 1633 | Values: 484.7 534.4 538.4 551.9 561.6 25496.9 31749.9 40916.6 41876.7 44330.6 36290.0 43240.0 43762.8 43789.3 43798.8 9540.5 9731.5 9732.0 9733.9 9760.8 8917.2 9149.9 11450.7 11709.1 11743.0 11667.9 11721.9 11724.7 11728.0 11739.1 10092.3 11749.1 11845.7 11854.0 11855.8 11661.9 11744.6 11775.7 11777.6 11782.5 40995.0 41115.4 41153.6 41319.8 41333.4 3406.7 3450.5 3590.4 3629.7 4231.8 31136.2 31218.1 31311.0 31333.5 31796.7 3131.5 3219.5 3253.5 3265.4 3288.9 509473.0 511969.0 512971.0 514633.0 516142.0 53487.0 62981.7 63701.0 63760.4 63964.7 37025.0 37138.6 37328.4 37442.9 37530.0 16868.4 17050.6 17054.6 17087.7 17096.6 11364.3 11612.0 13058.7 13151.1 13169.0 19015.7 19226.0 19482.3 19541.3 19558.5 6736.5 6827.3 7831.8 7903.0 7971.1 863.0 940.1 1008.9 1027.9 1056.7 28979.4 29002.0 30509.7 31035.7 31966.7 1038.4 1056.1 1067.9 1093.6 1102.4 14990.8 15525.5 15561.6 15710.3 15926.4 703764.0 704525.0 704677.0 705463.0 708578.5 57451.0 57851.4 57964.7 58067.7 58147.4 1305.3 1342.9 1423.5 1425.5 1449.2 29313.0 30713.0 30986.4 31087.8 31281.4 45568.3 46048.5 46097.5 46140.0 46143.3 593205.0 598759.0 600369.0 601026.0 602013.0 23608.2 23671.0 26650.7 26654.5 27241.0 45271.0 45303.5 45312.3 45538.8 45918.0 37686.2 38202.8 38533.8 38709.8 38808.0 37336.6 38245.8 38331.8 39036.4 39333.2 37439.0 38220.8 38228.4 38396.4 38461.6 28592.7 33111.8 33503.0 34403.7 34522.5 25571.5 25823.1 25989.7 26004.2 26078.6 13:23:47 INFO - PROCESS | 1633 | 13:23:47 INFO - PROCESS | 1633 | [#2] jquery.html Cycles:180 Average:34922.77 Median:2276.99 stddev:101575.56 (4461.0%) stddev-sans-first:101827.29 13:23:47 INFO - PROCESS | 1633 | Values: 328.0 391.9 395.5 406.8 417.2 19641.0 20337.5 21113.6 21117.9 21638.8 11855.3 12226.3 12352.8 12380.0 20010.4 5394.0 5656.0 5664.7 5665.2 5675.9 5456.6 5549.3 5887.3 6071.0 6199.7 6232.3 6232.8 6262.7 6265.4 6267.1 6676.4 6796.2 6862.6 6866.1 6870.6 5193.5 5428.1 5495.3 6084.8 6101.8 13526.5 13831.0 13885.2 18033.6 25709.4 2156.5 2238.7 2315.3 2371.2 2625.5 10243.1 10392.0 10654.5 10821.3 12802.6 1834.7 1837.8 1839.1 1888.8 1934.0 121182.0 124076.0 127217.0 127461.4 129792.0 11482.1 11622.4 11626.7 11688.5 11842.8 15110.5 15121.2 15171.5 15171.8 15179.5 7831.9 8522.2 8580.1 8634.7 8719.3 8468.9 8512.7 8527.4 8643.9 8710.6 4607.5 4623.8 4645.0 4723.5 4774.5 1909.5 1950.8 1986.9 1991.1 1992.7 863.7 897.5 908.0 920.6 1012.7 19772.9 21039.1 21209.5 21269.4 21300.9 781.3 855.6 965.8 966.4 997.9 10478.4 11112.3 11140.4 11144.4 11150.8 591842.0 598381.0 610913.0 621486.0 625373.0 83921.6 101082.5 105734.0 120206.0 135717.0 958.4 989.8 994.6 1005.5 1006.4 19169.3 19444.9 19884.7 19896.6 19905.9 54509.5 54704.5 55882.8 56905.0 56972.6 79971.6 81407.6 81722.6 82592.6 84944.0 7844.1 8108.7 8108.8 8321.0 8370.3 9950.6 11159.6 11912.7 12579.7 13148.9 10562.2 10703.7 10754.3 10992.8 11436.6 11054.8 11096.8 11206.7 11294.5 11541.9 11167.9 11476.7 11488.9 11515.4 11561.5 7971.0 8040.4 8188.3 8263.7 8425.6 8217.3 10544.8 10941.8 11561.6 11761.7 13:23:47 INFO - PROCESS | 1633 | 13:23:47 INFO - PROCESS | 1633 | [#3] mootools.html Cycles:180 Average:5546.43 Median:4963.69 stddev:3036.54 (61.2%) stddev-sans-first:3028.79 13:23:47 INFO - PROCESS | 1633 | Values: 1364.2 1526.9 1728.5 1908.5 1932.6 8240.7 8649.4 8670.7 8674.1 8684.6 7698.7 7894.9 7915.6 8150.2 8507.8 2352.6 2410.3 2411.6 2412.1 2416.1 2411.2 2418.3 2430.8 2444.6 2447.0 2389.9 2396.0 2419.8 2426.1 2428.5 2250.4 2282.1 2304.7 2305.5 2308.1 2410.9 2428.8 2429.7 2430.5 2437.4 8464.3 8507.6 8582.7 8587.1 8588.8 5179.3 5319.7 5331.0 5335.7 5339.6 3324.8 3519.6 3619.1 3687.8 3691.4 1081.1 1081.4 1108.6 1111.4 1127.1 10825.0 10942.5 11033.7 11049.9 11082.3 4258.5 4365.4 4723.3 4767.5 4790.3 9647.2 9649.0 9651.6 9655.0 9661.5 5330.7 5331.9 5335.0 5342.5 5344.4 4350.4 4634.8 4818.4 4847.1 4921.7 3944.3 3973.3 4019.8 4069.9 4075.4 1117.6 1260.3 1269.9 1277.8 1277.8 832.9 839.5 853.4 897.7 926.1 5626.5 5703.5 5720.2 5841.4 5985.5 435.5 454.9 465.3 465.3 466.0 3844.2 3930.4 3992.6 4067.7 4072.8 9802.7 10188.3 10213.8 10278.7 10291.3 9613.5 10015.8 10134.6 10134.6 10183.0 7750.7 7969.3 7970.1 7974.0 7976.6 5473.7 5492.9 5868.6 5910.2 6012.1 9530.9 9601.6 9612.5 9649.7 9651.6 9494.2 9686.4 9836.4 9836.6 9845.5 6771.9 6967.7 7119.6 7257.7 7394.6 7834.0 8139.0 8139.1 8149.4 8166.5 7026.4 7142.4 7307.7 7368.6 7387.2 6856.9 7076.7 7112.2 7186.7 7224.6 6700.6 6706.6 6791.6 6792.7 6798.6 4856.0 4865.2 4890.9 4914.2 4935.7 4821.9 4825.4 4833.8 4991.7 4997.5 13:23:47 INFO - PROCESS | 1633 | 13:23:47 INFO - PROCESS | 1633 | [#4] prototype.html Cycles:180 Average:4585.17 Median:5129.51 stddev:1429.34 (27.9%) stddev-sans-first:1396.34 13:23:47 INFO - PROCESS | 1633 | Values: 279.4 313.2 315.9 321.7 326.9 4788.8 5285.2 5402.3 5421.6 5470.7 4465.3 5306.9 5325.5 5390.7 5414.3 4208.7 4214.6 4219.0 4226.1 4245.0 3896.0 4218.8 4221.6 4227.0 4231.9 4095.5 4111.3 4126.7 4129.4 4140.9 4084.2 4101.4 4104.1 4107.8 4138.4 3291.1 3320.5 3570.4 3581.3 3603.4 5118.0 5221.5 5340.9 5344.6 5363.8 4427.6 4719.9 4729.8 4741.2 4744.6 4898.7 5713.6 5716.7 5719.6 5731.6 3431.5 3684.0 3850.4 3941.2 3952.3 5180.2 6007.9 6024.0 6052.8 6055.9 3454.0 3754.2 3999.6 4017.5 4023.6 3569.7 3725.1 3761.4 3916.6 4055.2 3806.7 3997.8 4084.4 4327.3 4724.3 5085.6 5636.8 5697.9 5737.6 5768.9 1075.3 1183.6 1248.4 1254.6 1297.6 872.2 890.1 893.7 894.7 902.0 4788.0 5016.7 5064.9 5205.6 5208.8 5289.5 5581.9 5623.4 5681.4 5719.8 4714.5 4959.4 5114.8 5119.3 5162.3 2530.4 2537.7 2799.4 2921.2 2935.8 5139.7 5633.7 5719.6 5824.1 6097.8 5815.8 5859.4 6097.3 6109.0 6127.9 5153.5 5400.8 5458.6 6183.5 6192.7 5220.2 5516.3 5936.7 5972.7 5981.3 4894.5 4905.1 5181.4 5887.4 5904.5 5893.6 5989.5 6137.0 6207.2 6236.5 3524.0 3717.7 3751.3 4023.7 4038.9 4874.6 5069.6 5653.9 5776.7 6053.6 5106.6 5655.6 5759.5 5803.8 5810.7 5077.6 5750.9 5790.5 5797.9 5834.9 4538.4 4719.0 5417.8 5446.5 5571.7 4870.9 5263.2 5458.8 5740.7 5752.3 5153.9 5362.7 5602.6 5637.2 5659.3 13:23:47 INFO - PROCESS | 1633 | 13:23:47 INFO - PROCESS | 1633 | [#5] yui.html Cycles:180 Average:22035.06 Median:4441.72 stddev:33558.92 (755.5%) stddev-sans-first:33614.73 13:23:47 INFO - PROCESS | 1633 | Values: 672.8 711.8 715.6 724.4 752.6 14060.1 14693.9 15074.7 15105.5 15268.6 13736.2 13910.9 13911.7 13912.8 13936.6 687.2 707.0 822.4 829.2 843.4 700.2 704.8 813.3 853.5 858.0 859.7 876.6 906.4 907.5 910.8 896.7 897.2 900.0 900.7 900.8 667.5 668.0 670.0 671.1 672.3 13468.2 13747.7 13786.0 13797.5 14477.5 13838.1 14163.2 14224.5 14302.4 14359.3 11163.1 11187.2 11271.3 11332.3 11548.3 3716.8 3749.7 3781.7 3786.8 3887.5 78984.0 82732.0 85759.6 93493.1 100464.0 10403.4 10842.2 10904.3 10909.6 11064.6 21324.5 21637.6 21654.8 21674.2 21705.9 7886.2 7972.0 8180.0 8254.5 8304.9 4381.7 4463.1 4492.9 4540.2 4572.2 3440.2 3570.7 3571.2 3573.2 3574.3 643.6 646.9 656.1 656.7 671.1 587.5 609.4 648.5 664.1 713.0 9079.4 9334.7 9383.2 9459.9 9622.4 590.6 637.6 640.0 648.0 680.0 4420.3 4591.6 4608.2 4610.0 4657.3 116444.0 117440.8 123233.0 126660.0 127634.0 104847.0 109223.4 109502.5 109542.5 110570.4 94444.6 95265.0 95662.5 95773.0 97879.5 8756.4 8943.5 9036.0 9039.3 9058.3 60865.0 61307.7 61655.7 61737.8 62618.0 72930.6 84409.0 87643.0 91788.5 91898.5 11402.5 11615.3 11651.9 11874.3 12036.6 12305.6 12561.1 12586.2 12613.2 12714.9 11378.7 11577.7 11592.3 11878.8 12163.9 11626.5 12336.4 12348.4 12350.9 12446.5 11438.5 12028.6 12060.3 12322.4 12438.7 9981.0 10228.8 10287.3 10688.6 10842.5 9139.2 10222.8 10268.7 10353.7 10446.5 13:23:47 INFO - PROCESS | 1633 | -------- Summary: end -------- 13:23:47 INFO - PROCESS | 1633 | 13:23:48 INFO - TEST-INFO | 1633: exit 0 13:23:48 INFO - TEST-OK | dromaeo_css | took 1116543ms 13:23:48 INFO - TEST-START | kraken 13:23:48 INFO - operating with platform_type : mac_ 13:23:48 INFO - Initialising browser for kraken test... 13:23:48 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmpL5ox8T/profile http://localhost:49240/getInfo.html) 13:23:50 INFO - PROCESS | 1642 | __metrics Screen width/height:1600/1200 13:23:50 INFO - PROCESS | 1642 | colorDepth:24 13:23:50 INFO - PROCESS | 1642 | Browser inner width/height: 1024/689 13:23:50 INFO - PROCESS | 1642 | __metrics 13:23:50 INFO - PROCESS | 1642 | 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" 13:23:50 INFO - PROCESS | 1642 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:23:51 INFO - TEST-INFO | 1642: exit 0 13:23:51 INFO - Browser initialized. 13:23:51 INFO - Running cycle 1/1 for kraken test... 13:23:51 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmpL5ox8T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:24:03 INFO - PROCESS | 1644 | RSS: Main: 167555072 13:24:03 INFO - PROCESS | 1644 | 13:24:06 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 13:24:07 INFO - PROCESS | 1644 | RSS: Main: 217731072 13:24:07 INFO - PROCESS | 1644 | 13:24:09 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 13:24:10 INFO - PROCESS | 1644 | RSS: Main: 231096320 13:24:10 INFO - PROCESS | 1644 | 13:24:13 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 13:24:14 INFO - PROCESS | 1644 | RSS: Main: 328372224 13:24:14 INFO - PROCESS | 1644 | 13:24:16 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 13:24:16 INFO - PROCESS | 1644 | RSS: Main: 231137280 13:24:16 INFO - PROCESS | 1644 | 13:24:18 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:24:19 INFO - PROCESS | 1644 | RSS: Main: 233336832 13:24:19 INFO - PROCESS | 1644 | 13:24:22 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 13:24:22 INFO - PROCESS | 1644 | RSS: Main: 272179200 13:24:22 INFO - PROCESS | 1644 | 13:24:25 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 13:24:26 INFO - PROCESS | 1644 | RSS: Main: 272502784 13:24:26 INFO - PROCESS | 1644 | 13:24:29 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 13:24:29 INFO - PROCESS | 1644 | RSS: Main: 269512704 13:24:29 INFO - PROCESS | 1644 | 13:24:31 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:24:31 INFO - PROCESS | 1644 | RSS: Main: 247971840 13:24:31 INFO - PROCESS | 1644 | 13:24:33 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:24:34 INFO - PROCESS | 1644 | RSS: Main: 250884096 13:24:34 INFO - PROCESS | 1644 | 13:24:36 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:24:37 INFO - PROCESS | 1644 | RSS: Main: 252506112 13:24:37 INFO - PROCESS | 1644 | 13:24:39 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:24:40 INFO - PROCESS | 1644 | RSS: Main: 272900096 13:24:40 INFO - PROCESS | 1644 | 13:24:43 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:24:44 INFO - PROCESS | 1644 | RSS: Main: 266366976 13:24:44 INFO - PROCESS | 1644 | 13:24:46 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 13:24:46 INFO - PROCESS | 1644 | RSS: Main: 310104064 13:24:46 INFO - PROCESS | 1644 | 13:24:46 INFO - PROCESS | 1644 | __start_tp_report 13:24:46 INFO - PROCESS | 1644 | _x_x_mozilla_page_load 13:24:46 INFO - PROCESS | 1644 | _x_x_mozilla_page_load_details 13:24:46 INFO - PROCESS | 1644 | |i|pagename|runs| 13:24:46 INFO - PROCESS | 1644 | |0;ai-astar;103;114;113;113;113;113;112;113;113;113 13:24:46 INFO - PROCESS | 1644 | |1;audio-beat-detection;143;107;109;139;107;106;110;107;137;107 13:24:46 INFO - PROCESS | 1644 | |2;audio-dft;182;183;181;183;180;181;183;181;185;183 13:24:46 INFO - PROCESS | 1644 | |3;audio-fft;80;57;57;88;61;59;58;59;79;58 13:24:46 INFO - PROCESS | 1644 | |4;audio-oscillator;85;70;94;68;67;69;87;68;69;90 13:24:46 INFO - PROCESS | 1644 | |5;imaging-gaussian-blur;87;85;82;113;134;112;89;86;89;85 13:24:46 INFO - PROCESS | 1644 | |6;imaging-darkroom;96;99;96;95;95;113;159;166;105;155 13:24:46 INFO - PROCESS | 1644 | |7;imaging-desaturate;80;81;79;78;82;80;84;83;82;81 13:24:46 INFO - PROCESS | 1644 | |8;json-parse-financial;57;56;55;57;58;58;56;57;54;57 13:24:46 INFO - PROCESS | 1644 | |9;json-stringify-tinderbox;62;67;67;75;71;67;69;69;72;71 13:24:46 INFO - PROCESS | 1644 | |10;stanford-crypto-aes;82;80;82;92;97;71;89;90;99;99 13:24:46 INFO - PROCESS | 1644 | |11;stanford-crypto-ccm;139;136;136;132;133;141;139;155;197;172 13:24:46 INFO - PROCESS | 1644 | |12;stanford-crypto-pbkdf2;161;160;159;182;219;193;160;211;207;158 13:24:46 INFO - PROCESS | 1644 | |13;stanford-crypto-sha256-iterative;65;66;65;66;64;64;67;66;67;80 13:24:46 INFO - PROCESS | 1644 | __end_tp_report 13:24:46 INFO - PROCESS | 1644 | __start_cc_report 13:24:46 INFO - PROCESS | 1644 | _x_x_mozilla_cycle_collect,1892 13:24:46 INFO - PROCESS | 1644 | __end_cc_report 13:24:46 INFO - PROCESS | 1644 | __startTimestamp1485811486271__endTimestamp 13:24:46 INFO - PROCESS | 1644 | 13:24:46 INFO - PROCESS | 1644 | ------- Summary: start ------- 13:24:46 INFO - PROCESS | 1644 | Number of tests: 14 13:24:46 INFO - PROCESS | 1644 | 13:24:46 INFO - PROCESS | 1644 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:3.20 (2.8%) stddev-sans-first:0.50 13:24:46 INFO - PROCESS | 1644 | Values: 103.0 114.0 113.0 113.0 113.0 113.0 112.0 113.0 113.0 113.0 13:24:46 INFO - PROCESS | 1644 | 13:24:46 INFO - PROCESS | 1644 | [#1] audio-beat-detection Cycles:10 Average:117.20 Median:109.50 stddev:15.61 (14.3%) stddev-sans-first:13.48 13:24:46 INFO - PROCESS | 1644 | Values: 143.0 107.0 109.0 139.0 107.0 106.0 110.0 107.0 137.0 107.0 13:24:46 INFO - PROCESS | 1644 | 13:24:46 INFO - PROCESS | 1644 | [#2] audio-dft Cycles:10 Average:182.20 Median:183.00 stddev:1.48 (0.8%) stddev-sans-first:1.56 13:24:46 INFO - PROCESS | 1644 | Values: 182.0 183.0 181.0 183.0 180.0 181.0 183.0 181.0 185.0 183.0 13:24:46 INFO - PROCESS | 1644 | 13:24:46 INFO - PROCESS | 1644 | [#3] audio-fft Cycles:10 Average:65.60 Median:60.00 stddev:11.83 (19.7%) stddev-sans-first:11.35 13:24:46 INFO - PROCESS | 1644 | Values: 80.0 57.0 57.0 88.0 61.0 59.0 58.0 59.0 79.0 58.0 13:24:46 INFO - PROCESS | 1644 | 13:24:46 INFO - PROCESS | 1644 | [#4] audio-oscillator Cycles:10 Average:76.70 Median:77.50 stddev:10.85 (14.0%) stddev-sans-first:11.09 13:24:46 INFO - PROCESS | 1644 | Values: 85.0 70.0 94.0 68.0 67.0 69.0 87.0 68.0 69.0 90.0 13:24:46 INFO - PROCESS | 1644 | 13:24:46 INFO - PROCESS | 1644 | [#5] imaging-gaussian-blur Cycles:10 Average:96.20 Median:85.50 stddev:17.34 (20.3%) stddev-sans-first:18.07 13:24:46 INFO - PROCESS | 1644 | Values: 87.0 85.0 82.0 113.0 134.0 112.0 89.0 86.0 89.0 85.0 13:24:46 INFO - PROCESS | 1644 | 13:24:46 INFO - PROCESS | 1644 | [#6] imaging-darkroom Cycles:10 Average:117.90 Median:95.00 stddev:29.69 (31.3%) stddev-sans-first:30.42 13:24:46 INFO - PROCESS | 1644 | Values: 96.0 99.0 96.0 95.0 95.0 113.0 159.0 166.0 105.0 155.0 13:24:46 INFO - PROCESS | 1644 | 13:24:46 INFO - PROCESS | 1644 | [#7] imaging-desaturate Cycles:10 Average:81.00 Median:81.50 stddev:1.83 (2.2%) stddev-sans-first:1.90 13:24:46 INFO - PROCESS | 1644 | Values: 80.0 81.0 79.0 78.0 82.0 80.0 84.0 83.0 82.0 81.0 13:24:46 INFO - PROCESS | 1644 | 13:24:46 INFO - PROCESS | 1644 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:57.00 stddev:1.27 (2.2%) stddev-sans-first:1.33 13:24:46 INFO - PROCESS | 1644 | Values: 57.0 56.0 55.0 57.0 58.0 58.0 56.0 57.0 54.0 57.0 13:24:46 INFO - PROCESS | 1644 | 13:24:46 INFO - PROCESS | 1644 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:70.00 stddev:3.56 (5.1%) stddev-sans-first:2.73 13:24:46 INFO - PROCESS | 1644 | Values: 62.0 67.0 67.0 75.0 71.0 67.0 69.0 69.0 72.0 71.0 13:24:46 INFO - PROCESS | 1644 | 13:24:46 INFO - PROCESS | 1644 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:91.00 stddev:9.24 (10.2%) stddev-sans-first:9.54 13:24:46 INFO - PROCESS | 1644 | Values: 82.0 80.0 82.0 92.0 97.0 71.0 89.0 90.0 99.0 99.0 13:24:46 INFO - PROCESS | 1644 | 13:24:46 INFO - PROCESS | 1644 | [#11] stanford-crypto-ccm Cycles:10 Average:148.00 Median:140.00 stddev:21.10 (15.1%) stddev-sans-first:22.12 13:24:46 INFO - PROCESS | 1644 | Values: 139.0 136.0 136.0 132.0 133.0 141.0 139.0 155.0 197.0 172.0 13:24:46 INFO - PROCESS | 1644 | 13:24:46 INFO - PROCESS | 1644 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.00 Median:187.50 stddev:24.63 (13.1%) stddev-sans-first:25.04 13:24:46 INFO - PROCESS | 1644 | Values: 161.0 160.0 159.0 182.0 219.0 193.0 160.0 211.0 207.0 158.0 13:24:46 INFO - PROCESS | 1644 | 13:24:46 INFO - PROCESS | 1644 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:66.00 stddev:4.69 (7.1%) stddev-sans-first:4.92 13:24:46 INFO - PROCESS | 1644 | Values: 65.0 66.0 65.0 66.0 64.0 64.0 67.0 66.0 67.0 80.0 13:24:46 INFO - PROCESS | 1644 | -------- Summary: end -------- 13:24:46 INFO - PROCESS | 1644 | 13:24:47 INFO - TEST-INFO | 1644: exit 0 13:24:47 INFO - TEST-OK | kraken | took 59192ms 13:24:47 INFO - SUITE-END | took 1175s 13:24:47 INFO - Completed test suite (00:19:36) 13:24:47 INFO - javascript benchmark 13:24:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2891.219370769892, 3468.479728040795, 3489.6335884732102, 3495.073805441557, 3543.2736289060745, 5738.7417566209515, 5774.133879918009, 5776.075827867542, 5792.0, 5804.912926306109, 5544.0575102232615, 5739.713014349276, 5834.124881267812, 5852.67810270435, 5895.027320492114, 5246.658967167141, 5262.947370526284, 5301.204819277101, 5344.091504444254, 5354.089804733185, 5209.7134657593815, 5214.66104703195, 5227.111391063529, 5339.41266460691, 5356.678599284036, 5259.31628888244, 5288.233206185101, 5291.1798671206025, 5297.496737809921, 5335.946640533603, 5222.73886305687, 5280.630355875091, 5304.92042619361, 5340.54605358545, 5346.064438723247, 5220.582353411718, 5288.312519372457, 5301.840944771663, 5302.893942121136, 5349.679019258857, 5658.066419040853, 5708.971455142698, 5711.571632127607, 5769.538436925036, 5916.378780228057, 6227.314995350508, 6232.626042437469, 6236.469900058501, 6243.500519958392, 6256.5307601930035, 6248.562600617958, 6252.624842509464, 6259.405356491126, 6262.780802671885, 6265.0, 5752.827415177551, 5813.360530341659, 5814.389489103668, 5980.671063091529, 5999.250093738283, 6171.753129874754, 6244.2819075806865, 6248.50011999039, 6257.5932564383165, 6263.655498947602, 6110.232775507349, 6162.907556386658, 6164.383561643889, 6175.413335733188, 6180.66006369645, 6208.4722798561725, 6213.409726076015, 6219.626822390671, 6223.408776166257, 6223.564350495421, 5252.474752524717, 6209.037599172136, 6240.0, 6246.250449946036, 6255.0, 6128.442013630915, 6152.046432802923, 6191.9690401547705, 6219.0982307566055, 6260.530460215502, 4967.031428871335, 4987.950120498748, 4991.0267497838295, 5014.774335154927, 5024.924626130611, 4449.577290157495, 4462.799174037176, 4469.4860091089295, 4476.776161191928, 4492.820287188541, 5719.599628025998, 5804.854878627983, 5864.560157988168, 5892.998190307572, 5937.317208520989, 6235.438810507076, 6253.96873015632, 6261.78083767066, 6269.780557680459, 6270.372962703693, 5891.970540147272, 5900.203472531153, 5920.733566989496, 5929.436703513245, 6028.065649824284, 4723.905521889543, 5497.835064947978, 5527.778888844482, 5536.058869992111, 5549.0, 6437.549371543947, 6470.611763294218, 6476.708548115252, 6477.611343319416, 6493.935060649333, 6170.722317495633, 6233.657148856856, 6233.719482623203, 6239.188905442264, 6255.46828519581, 5171.9482805171465, 6253.187085678833, 6318.115463834974, 6348.587341822767, 6349.269833969152, 6148.231471066117, 6238.438540531374, 6238.656873871799, 6250.374962503895, 6257.468115210076, 6228.03465462854, 6238.750449982132, 6240.375962403905, 6241.095041219089, 6264.5301602379095, 6047.879042419215, 6111.287884814121, 6122.204113465221, 6224.190855188796, 6228.719707613259, 5497.285352904097, 5891.1457838612305, 6238.563300568917, 6251.406116419115, 6257.342978987141, 5968.403159683997, 6057.818265452043, 6098.26820781509, 6110.725017374318, 6121.693915304306, 6059.969700151471, 6131.417515336036, 6162.033122793022, 6223.222097237845, 6247.031710084944, 6046.062860256668, 6068.544859135671, 6110.419510146529, 6149.200603921461, 6150.138980542817], "value": 5747.592672116161, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [484.721285260975, 534.433500489481, 538.4077514733793, 551.8620344913771, 561.6377436553421, 25496.87251563742, 31749.88875389359, 40916.59083409165, 41876.74369768904, 44330.55669443305, 36290.0, 43240.0, 43762.78118609411, 43789.34315985263, 43798.78100609493, 9540.475273859918, 9731.464769437678, 9732.026797320246, 9733.853992190123, 9760.804783904317, 8917.197452229299, 9149.908500914973, 11450.656480305604, 11709.121815863802, 11743.0, 11667.883321166806, 11721.941390293037, 11724.706882327968, 11728.0, 11739.060875130011, 10092.343997640204, 11749.060075194007, 11845.703857403547, 11853.992410645105, 11855.762884742257, 11661.941690291578, 11744.58893938708, 11775.7056073598, 11777.587784427504, 11782.528698852035, 40995.0, 41115.38326925098, 41153.58846411527, 41319.7934010331, 41333.379999300036, 3406.7104296134858, 3450.46517789743, 3590.407582748843, 3629.745917785756, 4231.767252801094, 31136.221594460094, 31218.063458096065, 31311.0, 31333.529997050064, 31796.72313246324, 3131.4519959007084, 3219.4687876500348, 3253.544503769474, 3265.379577880219, 3288.8848890288723, 509473.0, 511969.0, 512971.0, 514633.0, 516142.0, 53487.0, 62981.74036519244, 63701.0, 63760.36239637544, 63964.68017659975, 37025.0, 37138.62861371352, 37328.440073398924, 37442.876713698635, 37530.0, 16868.409605663743, 17050.573735656708, 17054.573635659206, 17087.658246835243, 17096.57258568546, 11364.261323013978, 11612.0, 13058.738825223443, 13151.079424440388, 13169.0, 19015.714764278546, 19226.0, 19482.318118865773, 19541.316053938044, 19558.5110372239, 6736.494762892705, 6827.317268273133, 7831.765047048598, 7903.0, 7971.123176450586, 862.9654813807377, 940.0646356874817, 1008.8839783424853, 1027.8715160604925, 1056.6618682021679, 28979.420411592073, 29002.03424057488, 30509.694903051128, 31035.68964310373, 31966.680333196837, 1038.3873514626255, 1056.10758908722, 1067.9107310543202, 1093.6117678224275, 1102.404701461202, 14990.775138372934, 15525.534233973, 15561.610959725871, 15710.293036813371, 15926.442574510069, 703764.0, 704525.0, 704677.0, 705463.0, 708578.4571077111, 57451.0, 57851.421485785446, 57964.71017644969, 58067.70966145142, 58147.4185258142, 1305.3212329588562, 1342.8724271194417, 1423.5408706075941, 1425.5153247895764, 1449.159487497249, 29312.97404590829, 30713.0, 30986.380272394876, 31087.844560777958, 31281.374372512877, 45568.31647525356, 46048.53951460576, 46097.53902460932, 46140.0, 46143.307850382946, 593205.0, 598759.0, 600369.0, 601026.0, 602013.0, 23608.17371391993, 23671.0, 26650.733492664825, 26654.466910662068, 27241.046563370186, 45271.0, 45303.54696452993, 45312.320315194636, 45538.77230613826, 45918.0, 37686.2462750738, 38202.808985956006, 38533.807330963165, 38709.80645096869, 38808.0, 37336.6266337344, 38245.80877095597, 38331.808340958116, 39036.41445378265, 39333.2133357337, 37439.0, 38220.80889595534, 38228.42657360086, 38396.42405363978, 38461.615383845805, 28592.714072859006, 33111.83444082764, 33503.0, 34403.65596344005, 34522.48216276808, 25571.488570228863, 25823.0961916332, 25989.74010259873, 26004.156508532924, 26078.60882086732], "value": 20202.135152042858, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.9852406641701, 391.9333713268744, 395.4858683711176, 406.8270984831446, 417.1989779623123, 19641.01794910254, 20337.49156271094, 21113.57772844544, 21117.894410527944, 21638.783612163872, 11855.288682679045, 12226.327551984637, 12352.814707779367, 12380.0, 20010.399688009384, 5394.02907476654, 5655.971720141414, 5664.688442135681, 5665.23519324892, 5675.943240567603, 5456.590755693319, 5549.250851135085, 5887.322957859858, 6070.998285282945, 6199.69001549923, 6232.3144454110015, 6232.781852635158, 6262.655553944532, 6265.404786545294, 6267.122602835607, 6676.3657452542175, 6796.150481189851, 6862.593168400466, 6866.141732283465, 6870.553414028072, 5193.454687257859, 5428.104362780136, 5495.340559132889, 6084.847878803021, 6101.816945491642, 13526.458941642322, 13831.0, 13885.166889986633, 18033.639327213514, 25709.35726606831, 2156.482444213393, 2238.6530087836413, 2315.3285547191294, 2371.229350461107, 2625.4617803350266, 10243.078122968895, 10392.0, 10654.520546575346, 10821.296615719953, 12802.551910683174, 1834.715619079045, 1837.8345948864667, 1839.0528877628033, 1888.830005299516, 1934.0, 121182.0, 124076.0, 127217.0, 127461.36269318686, 129792.0, 11482.138839586898, 11622.360770157553, 11626.651200463999, 11688.532458701557, 11842.822357664641, 15110.471133510495, 15121.16833574164, 15171.468998584996, 15171.772423413657, 15179.544613661608, 7831.942687737082, 8522.232999030117, 8580.14198580137, 8634.740957771277, 8719.302455803521, 8468.882779305173, 8512.659493620185, 8527.40308178434, 8643.91356086431, 8710.564471776386, 4607.516210797885, 4623.838165664186, 4645.0, 4723.48041715411, 4774.522547745198, 1909.5226193451638, 1950.8439324853978, 1986.9403917882487, 1991.0940522062426, 1992.6512860249397, 863.7408777366765, 897.5063714956748, 907.9546022698838, 920.5673333533229, 1012.6708819633649, 19772.90113549423, 21039.05324260412, 21209.469763255733, 21269.36191914245, 21300.893495532422, 781.3318564864056, 855.5508358112041, 965.830979578585, 966.4394651102484, 997.9322125325832, 10478.37129772216, 11112.333260004263, 11140.442977851075, 11144.387058711849, 11150.832737508943, 591842.0, 598381.0, 610913.0, 621486.0, 625373.0, 83921.58039209765, 101082.49458752807, 105733.97464623358, 120206.0, 135717.0, 958.4201558057275, 989.8119357322086, 994.597188138805, 1005.5022763732, 1006.3559322033905, 19169.32907348236, 19444.902775486597, 19884.70172947436, 19896.60206795885, 19905.900470497556, 54509.454905452025, 54704.45295547153, 55882.76468941197, 56905.0, 56972.57568560819, 79971.60014199892, 81407.59296203482, 81722.59138704269, 82592.58703706443, 84944.0, 7844.058712954482, 8108.675652973815, 8108.83782324362, 8321.043080045873, 8370.330373569977, 9950.601975920883, 11159.553617855196, 11912.702182445508, 12579.685507862378, 13148.868511315148, 10562.207834412604, 10703.678889633324, 10754.300970436896, 10992.835107473235, 11436.62760468749, 11054.778904421706, 11096.833547496633, 11206.663800086011, 11294.548218071184, 11541.942290288494, 11167.944160279472, 11476.655700329004, 11488.942555287504, 11515.424228788695, 11561.537538498702, 7971.0, 8040.39697022714, 8188.2630563249595, 8263.669453222044, 8425.620847061775, 8217.260446559838, 10544.84182737275, 10941.835872461761, 11561.595344162914, 11761.705957351134], "value": 9473.436653066412, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1364.249662685523, 1526.854948779866, 1728.5073753980118, 1908.4847091285344, 1932.6134773045394, 8240.711575094872, 8649.437786543871, 8670.653173873054, 8674.132586741323, 8684.609192586333, 7698.6535605897725, 7894.881576776339, 7915.564643944581, 8150.184981501847, 8507.829843403128, 2352.564775516535, 2410.3251089694913, 2411.553862535428, 2412.1316326122583, 2416.0698131219433, 2411.2043025801445, 2418.322869596516, 2430.793382562484, 2444.64552639868, 2446.987765061172, 2389.8924548395275, 2396.0, 2419.830611857171, 2426.102342133413, 2428.5142971405703, 2250.381145185079, 2282.109977108929, 2304.7119110111234, 2305.4582173189287, 2308.0767692922796, 2410.9397265068337, 2428.81783866209, 2429.7205821330595, 2430.453148041694, 2437.4150203951103, 8464.280536154434, 8507.574621268912, 8582.656693732306, 8587.141285871363, 8588.785280367978, 5179.274901513753, 5319.707416092114, 5330.973345133289, 5335.6798592084215, 5339.6262261641705, 3324.7506437017078, 3519.6304388039143, 3619.0952261934517, 3687.815609219528, 3691.427828686558, 1081.0810810810765, 1081.4430568257353, 1108.6230681568225, 1111.3831823338044, 1127.1039523578775, 10825.0, 10942.4528773561, 11033.724156896142, 11049.944750276198, 11082.335059896352, 4258.467691538558, 4365.410669559632, 4723.315119307681, 4767.547083027107, 4790.329353890388, 9647.179989700813, 9649.0, 9651.565679544437, 9655.0, 9661.516924153764, 5330.680159190383, 5331.893362132736, 5335.0, 5342.519173274424, 5344.43883392246, 4350.390945267665, 4634.837780677727, 4818.445878723992, 4847.079054979543, 4921.655484116149, 3944.3294639911283, 3973.344398174269, 4019.7789121598007, 4069.877903662895, 4075.409065685459, 1117.6423544465856, 1260.3068312428127, 1269.853966793812, 1277.7763891318982, 1277.7827769279245, 832.9333653307721, 839.4795226959325, 853.4068822168657, 897.7306807957586, 926.0878035135386, 5626.521745651666, 5703.543716502752, 5720.170575266647, 5841.357450680422, 5985.46130848217, 435.5318033114415, 454.94540655121597, 465.3322482237999, 465.3415417184713, 466.04693401993006, 3844.1927195289304, 3930.449737036817, 3992.5807790182193, 4067.654249388835, 4072.75563466193, 9802.705918822447, 10188.337758045704, 10213.846792298122, 10278.743031424274, 10291.33106348085, 9613.51932403377, 10015.849762253572, 10134.645287414905, 10134.645287414905, 10183.032611901857, 7750.651220694969, 7969.282764551218, 7970.123286438487, 7974.0, 7976.601169941479, 5473.698946557818, 5492.862678432912, 5868.589198756046, 5910.172575839472, 6012.068129439944, 9530.904690953003, 9601.567929443332, 9612.51937403113, 9649.662261820802, 9651.565679544578, 9494.240460762985, 9686.370385924893, 9836.409815411098, 9836.60653573849, 9845.45849978258, 6771.932280677327, 6967.65161741921, 7119.572825630479, 7257.709691612487, 7394.630268486661, 7833.960830195812, 8138.959305203436, 8139.064007639197, 8149.388795840454, 8166.469179503313, 7026.367626913602, 7142.357187853118, 7307.671154798153, 7368.59472729005, 7387.150477695134, 6856.897146542706, 7076.681549330396, 7112.182099058675, 7186.676599552928, 7224.638768061681, 6700.597964122168, 6706.5640733352175, 6791.592504449749, 6792.72829086831, 6798.558093723892, 4856.028794241237, 4865.221564549655, 4890.902181956412, 4914.238293064581, 4935.703857768545, 4821.855344339676, 4825.445073816556, 4833.782479788489, 4991.675541089818, 4997.525235102659], "value": 4431.414603003545, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.3992915232249, 313.2435169066704, 315.91786135604735, 321.70081823903774, 326.8855900434847, 4788.784504697288, 5285.207218917164, 5402.29770129883, 5421.647592906464, 5470.671759694421, 4465.263231566788, 5306.92039619406, 5325.467453254672, 5390.73046347683, 5414.269073675053, 4208.663306935453, 4214.578542145776, 4219.0, 4226.056014233464, 4244.962418039343, 3895.9805200973956, 4218.789060546976, 4221.641160501361, 4226.978865105685, 4231.894202644928, 4095.5290141633795, 4111.259973204822, 4126.669866410695, 4129.442525259096, 4140.896477588054, 4084.1627466369323, 4101.364288535282, 4104.056067104582, 4107.7535347879075, 4138.420621113047, 3291.062047316503, 3320.535125082466, 3570.357335679577, 3581.3016461789703, 3603.4414665726854, 5117.974410127926, 5221.530062294411, 5340.866478338034, 5344.5724342052545, 5363.785448582052, 4427.601515863587, 4719.905601887977, 4729.787159577827, 4741.170295198326, 4744.620430365562, 4898.681585696918, 5713.600407757378, 5716.742746576372, 5719.628224165416, 5731.627444216154, 3431.4509678451327, 3683.950074228832, 3850.403187505941, 3941.2314598653275, 3952.32810422226, 5180.171172612401, 6007.939920600826, 6023.951856368855, 6052.848678783022, 6055.909161362583, 3453.9827300863335, 3754.1553150541454, 3999.6004395165087, 4017.517897852218, 4023.637872591481, 3569.678728914358, 3725.068732816796, 3761.435784632327, 3916.5691773904846, 4055.2497787909333, 3806.676432503268, 3997.84008639657, 4084.387341898739, 4327.32926396409, 4724.267738500538, 5085.567726743194, 5636.8298205191295, 5697.914531282034, 5737.627054241461, 5768.855778605568, 1075.3279200499687, 1183.5798291606527, 1248.4382028087398, 1254.5922575163108, 1297.6236891301605, 872.1757938747822, 890.0743227043802, 893.6648756716231, 894.6779159502574, 901.963921443148, 4787.994521150527, 5016.724080175552, 5064.873378165576, 5205.583553315726, 5208.7916483341, 5289.497497737709, 5581.944180558143, 5623.381428042912, 5681.403452637496, 5719.799807006735, 4714.528547145258, 4959.429665588504, 5114.820981265638, 5119.283300337956, 5162.308949101411, 2530.443302473453, 2537.7191451158237, 2799.3981294021883, 2921.21127295629, 2935.8109965464023, 5139.743012849342, 5633.69014704187, 5719.569183097167, 5824.11706205431, 6097.810926869218, 5815.82552523425, 5859.44335288147, 6097.298810636834, 6108.969455152695, 6127.938720612737, 5153.510416510426, 5400.837974860682, 5458.61789674719, 6183.505319574513, 6192.659403732838, 5220.216967454912, 5516.282883225155, 5936.703164841827, 5972.671503067373, 5981.282246130492, 4894.486078961658, 4905.1416002200185, 5181.445471478507, 5887.4406931341455, 5904.468597826216, 5893.616914900518, 5989.490893274121, 6137.0, 6207.193064901715, 6236.534414412518, 3523.978046366525, 3717.7173875013077, 3751.3247615429486, 4023.6781057515914, 4038.8990275243355, 4874.6344024197615, 5069.569086627531, 5653.915191272052, 5776.682282474504, 6053.606515576474, 5106.642535022513, 5655.632383895034, 5759.481646651821, 5803.767849285981, 5810.738516766671, 5077.593792496666, 5750.856228594319, 5790.478856902899, 5797.913031304618, 5834.94165058361, 4538.387317712067, 4718.952810471851, 5417.7832886685665, 5446.455354464521, 5571.749271282721, 4870.853874383774, 5263.184206448007, 5458.77177635029, 5740.68426236561, 5752.309722833287, 5153.922691159711, 5362.65142765719, 5602.551795856403, 5637.238972738628, 5659.26429564154], "value": 4123.243243814555, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.7678950761987, 711.7935798618398, 715.5670819154408, 724.3878922310647, 752.6312107067539, 14060.086094403869, 14693.92653036736, 15074.6985060299, 15105.471308504204, 15268.618284542892, 13736.24450655216, 13910.930445347785, 13911.721765564682, 13912.791308130387, 13936.58190254294, 687.1959807025792, 707.0, 822.440740296598, 829.1749709039484, 843.3885433061027, 700.1772916822738, 704.8449341144966, 813.2558708781487, 853.4751128056232, 858.0432817408607, 859.6647307550061, 876.5836227791812, 906.4017748286133, 907.4872696926249, 910.8406028944942, 896.6727144592177, 897.1835629577054, 899.9640014399416, 900.7477906186278, 900.75679566517, 667.4893706314673, 667.9980029955068, 670.0418401685588, 671.0940230688581, 672.3310306245318, 13468.191908485522, 13747.656308592264, 13786.034977551575, 13797.517086902011, 14477.493287734984, 13838.100523466042, 14163.15021098727, 14224.502142424966, 14302.356393962296, 14359.282035898163, 11163.106951443864, 11187.216894817366, 11271.26736762116, 11332.263402878869, 11548.307101573933, 3716.7955762433057, 3749.737518373715, 3781.6785573226034, 3786.7917264550438, 3887.5140607424073, 78984.0, 82732.0, 85759.57120214359, 93493.06506934912, 100464.0, 10403.427811470441, 10842.158095342127, 10904.291221070605, 10909.563617455371, 11064.612738554111, 21324.466888327606, 21637.567248654937, 21654.783452165277, 21674.24140155087, 21705.891470542545, 7886.211378862183, 7971.960140199262, 8180.0, 8254.504729716236, 8304.875426868603, 4381.6932814703305, 4463.107378524308, 4492.887677808081, 4540.228161212536, 4572.222722137245, 3440.1571614954496, 3570.696490798259, 3571.178628915312, 3573.160307327776, 3574.338747331752, 643.6427782580619, 646.8544577470032, 656.1076935367896, 656.7241758461457, 671.0906721392442, 587.524105474567, 609.387565496673, 648.5330561995356, 664.0534017869962, 712.9536580122275, 9079.409838360618, 9334.673286435078, 9383.155516003593, 9459.858102128474, 9622.422654640744, 590.5629833922866, 637.5951270942892, 639.9616023038633, 647.970841312142, 680.0143580744239, 4420.336949457607, 4591.609713174351, 4608.239640459354, 4609.95390046102, 4657.347971284023, 116444.0, 117440.8255917447, 123233.0, 126660.0, 127634.0, 104847.0, 109223.36164957532, 109502.45248773706, 109542.45228773965, 110570.44714776374, 94444.58333125009, 95265.0, 95662.52168739111, 95773.0, 97879.51060244796, 8756.387052906235, 8943.508107054175, 9035.954820225857, 9039.322050846082, 9058.275337973078, 60865.0, 61307.69346153419, 61655.69172154111, 61737.765244693954, 62618.0, 72930.63534682292, 84409.0, 87643.0, 91788.5410572943, 91898.54050729703, 11402.486888090221, 11615.303081815118, 11651.941740291244, 11874.287542747463, 12036.578719745117, 12305.630831075083, 12561.062790420545, 12586.24482531051, 12613.180143290656, 12714.936425318185, 11378.715532111764, 11577.6526704199, 11592.304461732323, 11878.821817672915, 12163.878361216275, 11626.53493860236, 12336.444859981142, 12348.444320005441, 12350.938245308716, 12446.502139914664, 11438.542458301908, 12028.639140825439, 12060.276383417024, 12322.445489952794, 12438.689032773891, 9981.0, 10228.795424091626, 10287.279890407599, 10688.572457101629, 10842.512086955949, 9139.223166030695, 10222.846657300295, 10268.743281418025, 10353.689389318333, 10446.529906154394], "value": 7408.449370807438, "unit": "score"}], "name": "dromaeo_css", "value": 7280.441773365246, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 113.0, 113.0, 113.0, 113.0, 112.0, 113.0, 113.0, 113.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 107.0, 109.0, 139.0, 107.0, 106.0, 110.0, 107.0, 137.0, 107.0], "value": 117.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 181.0, 183.0, 180.0, 181.0, 183.0, 181.0, 185.0, 183.0], "value": 182.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 57.0, 57.0, 88.0, 61.0, 59.0, 58.0, 59.0, 79.0, 58.0], "value": 65.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 70.0, 94.0, 68.0, 67.0, 69.0, 87.0, 68.0, 69.0, 90.0], "value": 76.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 82.0, 113.0, 134.0, 112.0, 89.0, 86.0, 89.0, 85.0], "value": 96.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 99.0, 96.0, 95.0, 95.0, 113.0, 159.0, 166.0, 105.0, 155.0], "value": 117.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 79.0, 78.0, 82.0, 80.0, 84.0, 83.0, 82.0, 81.0], "value": 81.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 55.0, 57.0, 58.0, 58.0, 56.0, 57.0, 54.0, 57.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 67.0, 67.0, 75.0, 71.0, 67.0, 69.0, 69.0, 72.0, 71.0], "value": 69.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 82.0, 92.0, 97.0, 71.0, 89.0, 90.0, 99.0, 99.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 136.0, 136.0, 132.0, 133.0, 141.0, 139.0, 155.0, 197.0, 172.0], "value": 148.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 159.0, 182.0, 219.0, 193.0, 160.0, 211.0, 207.0, 158.0], "value": 181.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 64.0, 64.0, 67.0, 66.0, 67.0, 80.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1458.4, "alertThreshold": 2.0}]} 13:24:47 INFO - Return code: 0 13:24:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:24:48 INFO - # TBPL SUCCESS # 13:24:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:24:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:24:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:24:48 INFO - 2017-01-30 13:24:48.064 screenresolution[1648:9658] starting screenresolution argv=screenresolution get 13:24:48 INFO - 2017-01-30 13:24:48.066 screenresolution[1648:9658] Display 0: 1600x1200x32@60 13:24:48 INFO - 2017-01-30 13:24:48.072 screenresolution[1649:9661] starting screenresolution argv=screenresolution list 13:24:48 INFO - Available Modes on Display 0 13:24:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:24:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:24:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:24:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:24:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:24:48 INFO - Intel Iris: 13:24:48 INFO - Chipset Model: Intel Iris 13:24:48 INFO - Type: GPU 13:24:48 INFO - Bus: Built-In 13:24:48 INFO - VRAM (Dynamic, Max): 1536 MB 13:24:48 INFO - Vendor: Intel (0x8086) 13:24:48 INFO - Device ID: 0x0a2e 13:24:48 INFO - Revision ID: 0x0009 13:24:48 INFO - Displays: 13:24:48 INFO - Display: 13:24:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:24:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:24:48 INFO - Display Serial Number: 1600x1200 60 13:24:48 INFO - Main Display: Yes 13:24:48 INFO - Mirror: Off 13:24:48 INFO - Online: Yes 13:24:48 INFO - Rotation: Supported 13:24:48 INFO - Return code: 0 13:24:48 INFO - Running post-action listener: _resource_record_post_action 13:24:48 INFO - [mozharness: 2017-01-30 21:24:48.309251Z] Finished run-tests step (success) 13:24:48 INFO - Running post-run listener: _resource_record_post_run 13:24:48 INFO - Total resource usage - Wall time: 1198s; CPU: 53.0%; Read bytes: 39113728; Write bytes: 497835008; Read time: 377; Write time: 1643 13:24:48 INFO - TinderboxPrint: CPU usage
53.4% 13:24:48 INFO - TinderboxPrint: I/O read bytes / time
39,113,728 / 377 13:24:48 INFO - TinderboxPrint: I/O write bytes / time
497,835,008 / 1,643 13:24:48 INFO - TinderboxPrint: CPU idle
2,234.1 (46.6%) 13:24:48 INFO - TinderboxPrint: CPU system
961.2 (20.1%) 13:24:48 INFO - TinderboxPrint: CPU user
1,598.4 (33.3%) 13:24:48 INFO - TinderboxPrint: Swap in / out
230,301,696 / 0 13:24:48 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 186993152; Write bytes: 186163200; Read time: 16799; Write time: 360 13:24:48 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 37151744; Write bytes: 304757760; Read time: 356; Write time: 1246 13:24:48 INFO - Running post-run listener: _upload_blobber_files 13:24:48 INFO - Blob upload gear active. 13:24:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:24:48 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 13:24:48 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'] 13:24:48 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 13:24:49 INFO - (blobuploader) - INFO - Open directory for files ... 13:24:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:24:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:24:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:24:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:24:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:24:50 INFO - (blobuploader) - INFO - Done attempting. 13:24:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:24:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:24:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:24:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:24:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:24:51 INFO - (blobuploader) - INFO - Done attempting. 13:24:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:24:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:24:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:24:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:24:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:24:54 INFO - (blobuploader) - INFO - Done attempting. 13:24:54 INFO - (blobuploader) - INFO - Iteration through files over. 13:24:54 INFO - Return code: 0 13:24:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:24:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:24:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ab06014e255aaa4f6111665bbe478d0e254e53b31c12d365a76a97c6ef362e90727429b6eab2e188761882c3f0edb841b28c4a4a570b2374c34bf7987136feb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b843a3b4e84db969f481b4a17d82f956b9a6f298e5648649ae9adf33a70de80c819cafa1b02d43eec00499ebf032322d69e5fd53f85e37887994fc9c8cfa4336", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e6690e30b9dffa3d21df89d93ffb92f8303629a9e73c07ae6177dbec45cb6dc40c646c0639ba6fc9ff259b1f610b3b236c171795374767b66c2b501ce2cca77c"} 13:24:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:24:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:24:54 INFO - Contents: 13:24:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ab06014e255aaa4f6111665bbe478d0e254e53b31c12d365a76a97c6ef362e90727429b6eab2e188761882c3f0edb841b28c4a4a570b2374c34bf7987136feb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b843a3b4e84db969f481b4a17d82f956b9a6f298e5648649ae9adf33a70de80c819cafa1b02d43eec00499ebf032322d69e5fd53f85e37887994fc9c8cfa4336", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e6690e30b9dffa3d21df89d93ffb92f8303629a9e73c07ae6177dbec45cb6dc40c646c0639ba6fc9ff259b1f610b3b236c171795374767b66c2b501ce2cca77c"} 13:24:54 INFO - Running post-run listener: copy_logs_to_upload_dir 13:24:54 INFO - Copying logs to upload dir... 13:24:54 INFO - mkdir: /builds/slave/test/build/upload/logs 13:24:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.181801 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-30 13:24:54.234328) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-30 13:24:54.241610) ========= 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.BDf7mOOXMx/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.Whdu4VvwWW/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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/2ab06014e255aaa4f6111665bbe478d0e254e53b31c12d365a76a97c6ef362e90727429b6eab2e188761882c3f0edb841b28c4a4a570b2374c34bf7987136feb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b843a3b4e84db969f481b4a17d82f956b9a6f298e5648649ae9adf33a70de80c819cafa1b02d43eec00499ebf032322d69e5fd53f85e37887994fc9c8cfa4336", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e6690e30b9dffa3d21df89d93ffb92f8303629a9e73c07ae6177dbec45cb6dc40c646c0639ba6fc9ff259b1f610b3b236c171795374767b66c2b501ce2cca77c"} build_url:https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011157 build_url: 'https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/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/2ab06014e255aaa4f6111665bbe478d0e254e53b31c12d365a76a97c6ef362e90727429b6eab2e188761882c3f0edb841b28c4a4a570b2374c34bf7987136feb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b843a3b4e84db969f481b4a17d82f956b9a6f298e5648649ae9adf33a70de80c819cafa1b02d43eec00499ebf032322d69e5fd53f85e37887994fc9c8cfa4336", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e6690e30b9dffa3d21df89d93ffb92f8303629a9e73c07ae6177dbec45cb6dc40c646c0639ba6fc9ff259b1f610b3b236c171795374767b66c2b501ce2cca77c"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-30 13:24:54.278763) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 13:24:54.279060) ========= 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.BDf7mOOXMx/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.Whdu4VvwWW/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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.005159 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 13:24:54.327653) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-30 13:24:54.327935) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-30 13:24:54.331236) ========= ========= Total master_lag: 0.19 =========