builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0184 starttime: 1482431154.69 results: success (0) buildid: 20161222075153 builduid: d1811395cf6d4ac19a01e019e50ba300 revision: af6633c41d46a6183d9173cd6aa13532ed6a733b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 10:25:54.694448) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 10:25:54.694881) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 10:25:54.695192) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 10:25:54.725380) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 10:25:54.725729) ========= 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.hHhUgHbhn6/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.nyEJQ9NKaa/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-22 10:25:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 17.8M=0.001s 2016-12-22 10:25:54 (17.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.148727 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 10:25:54.901799) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 10:25:54.902121) ========= 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.hHhUgHbhn6/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.nyEJQ9NKaa/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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.025681 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 10:25:54.950459) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-22 10:25:54.953827) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev af6633c41d46a6183d9173cd6aa13532ed6a733b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev af6633c41d46a6183d9173cd6aa13532ed6a733b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hHhUgHbhn6/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.nyEJQ9NKaa/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-22 10:25:55,162 truncating revision to first 12 chars 2016-12-22 10:25:55,163 Setting DEBUG logging. 2016-12-22 10:25:55,163 attempt 1/10 2016-12-22 10:25:55,163 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/af6633c41d46?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-22 10:25:56,477 unpacking tar archive at: mozilla-aurora-af6633c41d46/testing/mozharness/ program finished with exit code 0 elapsedTime=1.586179 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-22 10:25:56.561063) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 10:25:56.561382) ========= script_repo_revision: af6633c41d46a6183d9173cd6aa13532ed6a733b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 10:25:56.564783) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 10:25:56.565055) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 10:25:56.584598) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-12-22 10:25:56.584932) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hHhUgHbhn6/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.nyEJQ9NKaa/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 10:25:56 INFO - MultiFileLogger online at 20161222 10:25:56 in /builds/slave/test 10:25:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 10:25:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:25:56 INFO - {'append_to_log': False, 10:25:56 INFO - 'base_work_dir': '/builds/slave/test', 10:25:56 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:25:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:25:56 INFO - 'branch': 'Mozilla-Aurora', 10:25:56 INFO - 'buildbot_json_path': 'buildprops.json', 10:25:56 INFO - 'config_files': ('talos/mac_config.py',), 10:25:56 INFO - 'default_actions': ('clobber', 10:25:56 INFO - 'read-buildbot-config', 10:25:56 INFO - 'download-and-extract', 10:25:56 INFO - 'populate-webroot', 10:25:56 INFO - 'create-virtualenv', 10:25:56 INFO - 'install', 10:25:56 INFO - 'run-tests'), 10:25:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:25:56 INFO - 'download_minidump_stackwalk': True, 10:25:56 INFO - 'download_symbols': 'ondemand', 10:25:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:25:56 INFO - 'tooltool.py': '/tools/tooltool.py', 10:25:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:25:56 INFO - '/tools/misc-python/virtualenv.py')}, 10:25:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:25:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:25:56 INFO - 'installer_path': 'installer.exe', 10:25:56 INFO - 'log_level': 'info', 10:25:56 INFO - 'log_name': 'talos', 10:25:56 INFO - 'log_to_console': True, 10:25:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:25:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:25:56 INFO - 'opt_config_files': (), 10:25:56 INFO - 'pip_index': False, 10:25:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:25:56 INFO - 'cmd': ('bash', 10:25:56 INFO - '-c', 10:25:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:25:56 INFO - 'enabled': True, 10:25:56 INFO - 'halt_on_failure': False, 10:25:56 INFO - 'name': 'check_screen_resolution'},), 10:25:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:25:56 INFO - 'cmd': ('bash', 10:25:56 INFO - '-c', 10:25:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:25:56 INFO - 'enabled': True, 10:25:56 INFO - 'halt_on_failure': False, 10:25:56 INFO - 'name': 'check_screen_resolution'},), 10:25:56 INFO - 'run_cmd_checks_enabled': True, 10:25:56 INFO - 'sps_profile': False, 10:25:56 INFO - 'sps_profile_interval': 0, 10:25:56 INFO - 'suite': 'dromaeojs-e10s', 10:25:56 INFO - 'system_bits': '32', 10:25:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:25:56 INFO - 'title': 't-yosemite-r7-0184', 10:25:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:25:56 INFO - 'use_talos_json': True, 10:25:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:25:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:25:56 INFO - 'work_dir': 'build'} 10:25:56 INFO - [mozharness: 2016-12-22 18:25:56.901388Z] Running clobber step. 10:25:56 INFO - Running pre-action listener: _resource_record_pre_action 10:25:56 INFO - Running main action method: clobber 10:25:56 INFO - rmtree: /builds/slave/test/build 10:25:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:25:59 INFO - Running post-action listener: _resource_record_post_action 10:25:59 INFO - [mozharness: 2016-12-22 18:25:59.268535Z] Finished clobber step (success) 10:25:59 INFO - [mozharness: 2016-12-22 18:25:59.268720Z] Running read-buildbot-config step. 10:25:59 INFO - Running pre-action listener: _resource_record_pre_action 10:25:59 INFO - Running main action method: read_buildbot_config 10:25:59 INFO - Using buildbot properties: 10:25:59 INFO - { 10:25:59 INFO - "project": "", 10:25:59 INFO - "product": "firefox", 10:25:59 INFO - "script_repo_revision": "production", 10:25:59 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 10:25:59 INFO - "repository": "", 10:25:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 10:25:59 INFO - "buildid": "20161222075153", 10:25:59 INFO - "pgo_build": "False", 10:25:59 INFO - "basedir": "/builds/slave/test", 10:25:59 INFO - "buildnumber": 15, 10:25:59 INFO - "slavename": "t-yosemite-r7-0184", 10:25:59 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 10:25:59 INFO - "platform": "yosemite_r7", 10:25:59 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 10:25:59 INFO - "branch": "mozilla-aurora", 10:25:59 INFO - "repo_path": "releases/mozilla-aurora", 10:25:59 INFO - "revision": "af6633c41d46a6183d9173cd6aa13532ed6a733b", 10:25:59 INFO - "stage_platform": "macosx64", 10:25:59 INFO - "builduid": "d1811395cf6d4ac19a01e019e50ba300", 10:25:59 INFO - "slavebuilddir": "test" 10:25:59 INFO - } 10:25:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/X-WoevjwTyuzeF-sak0Saw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 10:25:59 INFO - Running post-action listener: _resource_record_post_action 10:25:59 INFO - [mozharness: 2016-12-22 18:25:59.272228Z] Finished read-buildbot-config step (success) 10:25:59 INFO - [mozharness: 2016-12-22 18:25:59.272339Z] Running download-and-extract step. 10:25:59 INFO - Running pre-action listener: _resource_record_pre_action 10:25:59 INFO - Running main action method: download_and_extract 10:25:59 INFO - mkdir: /builds/slave/test/build/tests 10:25:59 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')]} 10:25:59 INFO - trying https://queue.taskcluster.net/v1/task/X-WoevjwTyuzeF-sak0Saw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 10:25:59 INFO - Downloading https://queue.taskcluster.net/v1/task/X-WoevjwTyuzeF-sak0Saw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 10:25:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X-WoevjwTyuzeF-sak0Saw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 10:26:00 INFO - Downloaded 1199 bytes. 10:26:00 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 10:26:00 INFO - Using the following test package requirements: 10:26:00 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 10:26:00 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:26:00 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 10:26:00 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:26:00 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 10:26:00 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:26:00 INFO - u'jsshell-mac.zip'], 10:26:00 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:26:00 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 10:26:00 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 10:26:00 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:26:00 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 10:26:00 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:26:00 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 10:26:00 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:26:00 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 10:26:00 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:26:00 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 10:26:00 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 10:26:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X-WoevjwTyuzeF-sak0Saw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 10:26:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X-WoevjwTyuzeF-sak0Saw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:26:00 INFO - Fetch https://queue.taskcluster.net/v1/task/X-WoevjwTyuzeF-sak0Saw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 10:26:01 INFO - Http code: 200 10:26:01 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 10:26:01 INFO - x-amz-cf-id: 8fRsydzsRbXDS9wb9wpSKnnoZNHaYzGNVu2yaxT0lhRhU8x7IUN_8g== 10:26:01 INFO - x-amz-version-id: JIk5SIc4XBtbzqi62XeIPn9kBOnAexJb 10:26:01 INFO - Expected file size: 16271208 10:26:01 INFO - Obtained file size: 16271208 10:26:08 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 10:26:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X-WoevjwTyuzeF-sak0Saw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 10:26:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X-WoevjwTyuzeF-sak0Saw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:26:08 INFO - Fetch https://queue.taskcluster.net/v1/task/X-WoevjwTyuzeF-sak0Saw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 10:26:08 INFO - Http code: 200 10:26:08 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 10:26:08 INFO - x-amz-cf-id: l4Dee14kKfe0-vOXlfuTTy_bw7vWuMSs5soO0JRSvcNq-5lFUA7SPg== 10:26:08 INFO - x-amz-version-id: JIk5SIc4XBtbzqi62XeIPn9kBOnAexJb 10:26:09 INFO - Expected file size: 16271208 10:26:09 INFO - Obtained file size: 16271208 10:26:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X-WoevjwTyuzeF-sak0Saw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 10:26:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X-WoevjwTyuzeF-sak0Saw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 10:26:15 INFO - Fetch https://queue.taskcluster.net/v1/task/X-WoevjwTyuzeF-sak0Saw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 10:26:16 INFO - Http code: 200 10:26:16 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 10:26:16 INFO - x-amz-cf-id: W-l4SOx7NnTtK66uihaGuIGCgrqXysvpDMB6uIcjqPq9HYSQPqq3Zg== 10:26:16 INFO - x-amz-version-id: CnAtaNTbyL5ElVSM_zlYj2QZcxgFilqF 10:26:17 INFO - Expected file size: 14409038 10:26:17 INFO - Obtained file size: 14409038 10:26:17 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')]} 10:26:17 INFO - trying https://queue.taskcluster.net/v1/task/X-WoevjwTyuzeF-sak0Saw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 10:26:17 INFO - Downloading https://queue.taskcluster.net/v1/task/X-WoevjwTyuzeF-sak0Saw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 10:26:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X-WoevjwTyuzeF-sak0Saw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 10:26:20 INFO - Downloaded 109787876 bytes. 10:26:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X-WoevjwTyuzeF-sak0Saw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 10:26:20 INFO - mkdir: /builds/slave/test/properties 10:26:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:26:20 INFO - Writing to file /builds/slave/test/properties/build_url 10:26:20 INFO - Contents: 10:26:20 INFO - build_url:https://queue.taskcluster.net/v1/task/X-WoevjwTyuzeF-sak0Saw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 10:26:21 INFO - Running post-action listener: _resource_record_post_action 10:26:21 INFO - Running post-action listener: set_extra_try_arguments 10:26:21 INFO - [mozharness: 2016-12-22 18:26:21.402041Z] Finished download-and-extract step (success) 10:26:21 INFO - [mozharness: 2016-12-22 18:26:21.402206Z] Running populate-webroot step. 10:26:21 INFO - Running pre-action listener: _resource_record_pre_action 10:26:21 INFO - Running main action method: populate_webroot 10:26:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:26:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:26:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:26:21 INFO - '--tppagecycles', 10:26:21 INFO - '7'], 10:26:21 INFO - 'tests': ['tsvgm']}}, 10:26:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:26:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:26:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:26:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:26:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:26:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:26:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:26:21 INFO - 'talos_options': ['--disable-e10s'], 10:26:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:26:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:26:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:26:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:26:21 INFO - 'talos_options': ['--disable-e10s'], 10:26:21 INFO - 'tests': ['damp', 'tps']}, 10:26:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:26:21 INFO - 'tests': ['damp', 'tps']}, 10:26:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:26:21 INFO - 'tests': ['dromaeo_dom']}, 10:26:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:26:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:26:21 INFO - 'tests': ['basic_compositor_video']}, 10:26:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:26:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:26:21 INFO - 'tests': ['a11yr', 10:26:21 INFO - 'ts_paint', 10:26:21 INFO - 'tpaint', 10:26:21 INFO - 'sessionrestore', 10:26:21 INFO - 'sessionrestore_no_auto_restore', 10:26:21 INFO - 'tabpaint']}, 10:26:21 INFO - 'other-e10s': {'tests': ['a11yr', 10:26:21 INFO - 'ts_paint', 10:26:21 INFO - 'tpaint', 10:26:21 INFO - 'sessionrestore', 10:26:21 INFO - 'sessionrestore_no_auto_restore', 10:26:21 INFO - 'tabpaint']}, 10:26:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:26:21 INFO - 'ts_paint', 10:26:21 INFO - 'tpaint', 10:26:21 INFO - 'sessionrestore', 10:26:21 INFO - 'sessionrestore_no_auto_restore', 10:26:21 INFO - 'tabpaint']}, 10:26:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:26:21 INFO - 'ts_paint', 10:26:21 INFO - 'tpaint', 10:26:21 INFO - 'sessionrestore', 10:26:21 INFO - 'sessionrestore_no_auto_restore', 10:26:21 INFO - 'tabpaint']}, 10:26:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:26:21 INFO - 'tests': ['a11yr', 10:26:21 INFO - 'ts_paint', 10:26:21 INFO - 'tpaint', 10:26:21 INFO - 'sessionrestore', 10:26:21 INFO - 'sessionrestore_no_auto_restore', 10:26:21 INFO - 'tabpaint']}, 10:26:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:26:21 INFO - 'tests': ['a11yr', 10:26:21 INFO - 'ts_paint', 10:26:21 INFO - 'tpaint', 10:26:21 INFO - 'sessionrestore', 10:26:21 INFO - 'sessionrestore_no_auto_restore', 10:26:21 INFO - 'tabpaint']}, 10:26:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:26:21 INFO - 'tests': ['tsvgx', 10:26:21 INFO - 'tsvgr_opacity', 10:26:21 INFO - 'tart', 10:26:21 INFO - 'tscrollx', 10:26:21 INFO - 'cart']}, 10:26:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:26:21 INFO - 'tsvgr_opacity', 10:26:21 INFO - 'tart', 10:26:21 INFO - 'tscrollx', 10:26:21 INFO - 'cart']}, 10:26:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:26:21 INFO - 'talos_options': ['--disable-e10s'], 10:26:21 INFO - 'tests': ['tp5o']}, 10:26:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:26:21 INFO - 'tests': ['tp5o']}, 10:26:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:26:21 INFO - 'talos_options': ['--disable-e10s', 10:26:21 INFO - '--xperf_path', 10:26:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:26:21 INFO - 'tests': ['tp5n']}, 10:26:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:26:21 INFO - 'talos_options': ['--xperf_path', 10:26:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:26:21 INFO - 'tests': ['tp5n']}}, 10:26:21 INFO - 'talos.zip': {'path': '', 10:26:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:26:21 INFO - Running post-action listener: _resource_record_post_action 10:26:21 INFO - [mozharness: 2016-12-22 18:26:21.421555Z] Finished populate-webroot step (success) 10:26:21 INFO - [mozharness: 2016-12-22 18:26:21.421702Z] Running create-virtualenv step. 10:26:21 INFO - Running pre-action listener: _resource_record_pre_action 10:26:21 INFO - Running main action method: create_virtualenv 10:26:21 INFO - Creating virtualenv /builds/slave/test/build/venv 10:26:21 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 10:26:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:26:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:26:21 INFO - Using real prefix '/tools/python27' 10:26:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:26:22 INFO - Installing distribute.............................................................................................................................................................................................done. 10:26:25 INFO - Installing pip.................done. 10:26:25 INFO - Return code: 0 10:26:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:26:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:26:25 INFO - Reading from file tmpfile_stdout 10:26:25 INFO - Output received: 10:26:25 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) 10:26:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:26: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')]} 10:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26: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')]} 10:26:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1074ba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107430570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8661580f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ced30>, '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 0x107134db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072c6b20>, '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.hHhUgHbhn6/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.nyEJQ9NKaa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 10:26: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', 'pip>=1.5'] in /builds/slave/test/build 10:26: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 pip>=1.5 10:26:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hHhUgHbhn6/Render', 10:26:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:25 INFO - 'HOME': '/Users/cltbld', 10:26:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:25 INFO - 'LOGNAME': 'cltbld', 10:26:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:25 INFO - 'MOZ_NO_REMOTE': '1', 10:26:25 INFO - 'NO_EM_RESTART': '1', 10:26:25 INFO - 'PAGER': '/bin/cat', 10:26:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:25 INFO - 'PWD': '/builds/slave/test', 10:26:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:25 INFO - 'SHELL': '/bin/bash', 10:26:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nyEJQ9NKaa/Listeners', 10:26:25 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 10:26:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:25 INFO - 'USER': 'cltbld', 10:26:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:25 INFO - 'XPC_FLAGS': '0x0', 10:26:25 INFO - 'XPC_SERVICE_NAME': '0', 10:26:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:25 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 10:26:25 INFO - Cleaning up... 10:26:25 INFO - Return code: 0 10:26:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:26: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')]} 10:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26: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')]} 10:26:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26: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', '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 0x1074ba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107430570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8661580f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ced30>, '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 0x107134db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072c6b20>, '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.hHhUgHbhn6/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.nyEJQ9NKaa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 10:26: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', 'psutil>=3.1.1'] in /builds/slave/test/build 10:26: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 psutil>=3.1.1 10:26:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hHhUgHbhn6/Render', 10:26:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:25 INFO - 'HOME': '/Users/cltbld', 10:26:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:25 INFO - 'LOGNAME': 'cltbld', 10:26:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:25 INFO - 'MOZ_NO_REMOTE': '1', 10:26:25 INFO - 'NO_EM_RESTART': '1', 10:26:25 INFO - 'PAGER': '/bin/cat', 10:26:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:25 INFO - 'PWD': '/builds/slave/test', 10:26:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:25 INFO - 'SHELL': '/bin/bash', 10:26:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nyEJQ9NKaa/Listeners', 10:26:25 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 10:26:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:25 INFO - 'USER': 'cltbld', 10:26:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:25 INFO - 'XPC_FLAGS': '0x0', 10:26:25 INFO - 'XPC_SERVICE_NAME': '0', 10:26:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:25 INFO - Downloading/unpacking psutil>=3.1.1 10:26: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 10:26: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 10:26: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 10:26: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 10:26: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 10:26: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 10:26:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:26:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:26:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:26:29 INFO - Installing collected packages: psutil 10:26:29 INFO - Running setup.py install for psutil 10:26:29 INFO - building 'psutil._psutil_osx' extension 10:26:29 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 10:26:29 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 10:26:30 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 10:26:30 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 10:26:30 INFO - building 'psutil._psutil_posix' extension 10:26:30 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 10:26:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:26:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:26:30 INFO - ^ 10:26:30 INFO - 1 warning generated. 10:26:30 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 10:26:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:26:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:26:30 INFO - Successfully installed psutil 10:26:30 INFO - Cleaning up... 10:26:30 INFO - Return code: 0 10:26:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:26:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:30 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 0x1074ba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107430570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8661580f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ced30>, '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 0x107134db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072c6b20>, '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.hHhUgHbhn6/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.nyEJQ9NKaa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 10:26:30 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 10:26:30 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 10:26:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hHhUgHbhn6/Render', 10:26:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:30 INFO - 'HOME': '/Users/cltbld', 10:26:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:30 INFO - 'LOGNAME': 'cltbld', 10:26:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:30 INFO - 'MOZ_NO_REMOTE': '1', 10:26:30 INFO - 'NO_EM_RESTART': '1', 10:26:30 INFO - 'PAGER': '/bin/cat', 10:26:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:30 INFO - 'PWD': '/builds/slave/test', 10:26:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:30 INFO - 'SHELL': '/bin/bash', 10:26:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nyEJQ9NKaa/Listeners', 10:26:30 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 10:26:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:30 INFO - 'USER': 'cltbld', 10:26:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:30 INFO - 'XPC_FLAGS': '0x0', 10:26:30 INFO - 'XPC_SERVICE_NAME': '0', 10:26:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:26:30 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 10:26:30 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 10:26:30 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 10:26:30 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 10:26:30 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 10:26:30 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 10:26:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:26:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:26:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:26:33 INFO - Installing collected packages: mozsystemmonitor 10:26:33 INFO - Running setup.py install for mozsystemmonitor 10:26:33 INFO - Successfully installed mozsystemmonitor 10:26:33 INFO - Cleaning up... 10:26:33 INFO - Return code: 0 10:26:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:26:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:33 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 0x1074ba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107430570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8661580f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ced30>, '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 0x107134db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072c6b20>, '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.hHhUgHbhn6/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.nyEJQ9NKaa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 10:26:33 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 10:26:33 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 10:26:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hHhUgHbhn6/Render', 10:26:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:33 INFO - 'HOME': '/Users/cltbld', 10:26:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:33 INFO - 'LOGNAME': 'cltbld', 10:26:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:33 INFO - 'MOZ_NO_REMOTE': '1', 10:26:33 INFO - 'NO_EM_RESTART': '1', 10:26:33 INFO - 'PAGER': '/bin/cat', 10:26:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:33 INFO - 'PWD': '/builds/slave/test', 10:26:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:33 INFO - 'SHELL': '/bin/bash', 10:26:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nyEJQ9NKaa/Listeners', 10:26:33 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 10:26:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:33 INFO - 'USER': 'cltbld', 10:26:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:33 INFO - 'XPC_FLAGS': '0x0', 10:26:33 INFO - 'XPC_SERVICE_NAME': '0', 10:26:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:34 INFO - Downloading/unpacking jsonschema==2.5.1 10:26:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:26:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:26: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 10:26: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 10:26: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 10:26: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 10:26: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 10:26: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 10:26:37 INFO - Downloading functools32-3.2.3-2.tar.gz 10:26:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:26:37 INFO - warning: no files found matching '*.txt' 10:26:37 INFO - no previously-included directories found matching 'build' 10:26:37 INFO - no previously-included directories found matching 'dist' 10:26:37 INFO - no previously-included directories found matching '.git*' 10:26:37 INFO - Installing collected packages: jsonschema, functools32 10:26:37 INFO - Running setup.py install for functools32 10:26:37 INFO - warning: no files found matching '*.txt' 10:26:37 INFO - no previously-included directories found matching 'build' 10:26:37 INFO - no previously-included directories found matching 'dist' 10:26:37 INFO - no previously-included directories found matching '.git*' 10:26:37 INFO - Successfully installed jsonschema functools32 10:26:37 INFO - Cleaning up... 10:26:37 INFO - Return code: 0 10:26:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:26: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')]} 10:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26: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')]} 10:26:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1074ba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107430570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8661580f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ced30>, '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 0x107134db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072c6b20>, '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.hHhUgHbhn6/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.nyEJQ9NKaa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 10:26:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:26:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:26:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hHhUgHbhn6/Render', 10:26:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:37 INFO - 'HOME': '/Users/cltbld', 10:26:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:37 INFO - 'LOGNAME': 'cltbld', 10:26:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:37 INFO - 'MOZ_NO_REMOTE': '1', 10:26:37 INFO - 'NO_EM_RESTART': '1', 10:26:37 INFO - 'PAGER': '/bin/cat', 10:26:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:37 INFO - 'PWD': '/builds/slave/test', 10:26:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:37 INFO - 'SHELL': '/bin/bash', 10:26:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nyEJQ9NKaa/Listeners', 10:26:37 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 10:26:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:37 INFO - 'USER': 'cltbld', 10:26:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:37 INFO - 'XPC_FLAGS': '0x0', 10:26:37 INFO - 'XPC_SERVICE_NAME': '0', 10:26:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:26:37 INFO - Cleaning up... 10:26:37 INFO - Return code: 0 10:26:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:26: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')]} 10:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26: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')]} 10:26:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1074ba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107430570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8661580f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ced30>, '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 0x107134db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072c6b20>, '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.hHhUgHbhn6/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.nyEJQ9NKaa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 10:26:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:26:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:26:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hHhUgHbhn6/Render', 10:26:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:37 INFO - 'HOME': '/Users/cltbld', 10:26:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:37 INFO - 'LOGNAME': 'cltbld', 10:26:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:37 INFO - 'MOZ_NO_REMOTE': '1', 10:26:37 INFO - 'NO_EM_RESTART': '1', 10:26:37 INFO - 'PAGER': '/bin/cat', 10:26:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:37 INFO - 'PWD': '/builds/slave/test', 10:26:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:37 INFO - 'SHELL': '/bin/bash', 10:26:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nyEJQ9NKaa/Listeners', 10:26:37 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 10:26:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:37 INFO - 'USER': 'cltbld', 10:26:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:37 INFO - 'XPC_FLAGS': '0x0', 10:26:37 INFO - 'XPC_SERVICE_NAME': '0', 10:26:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:38 INFO - Downloading/unpacking blobuploader==1.2.4 10:26:38 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 10:26:38 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 10:26:38 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 10:26:38 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 10:26:38 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 10:26:38 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 10:26:40 INFO - Downloading blobuploader-1.2.4.tar.gz 10:26:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:26:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:26:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:26:41 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 10:26:41 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 10:26:41 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 10:26:41 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 10:26:41 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 10:26:41 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 10:26:41 INFO - Downloading docopt-0.6.1.tar.gz 10:26:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:26:42 INFO - Installing collected packages: blobuploader, requests, docopt 10:26:42 INFO - Running setup.py install for blobuploader 10:26:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:26:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:26:42 INFO - Running setup.py install for requests 10:26:42 INFO - Running setup.py install for docopt 10:26:42 INFO - Successfully installed blobuploader requests docopt 10:26:42 INFO - Cleaning up... 10:26:42 INFO - Return code: 0 10:26:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:26: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')]} 10:26:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:43 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 0x1074ba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107430570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8661580f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ced30>, '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 0x107134db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072c6b20>, '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.hHhUgHbhn6/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.nyEJQ9NKaa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 10:26:43 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 10:26:43 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 10:26:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hHhUgHbhn6/Render', 10:26:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:43 INFO - 'HOME': '/Users/cltbld', 10:26:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:43 INFO - 'LOGNAME': 'cltbld', 10:26:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:43 INFO - 'MOZ_NO_REMOTE': '1', 10:26:43 INFO - 'NO_EM_RESTART': '1', 10:26:43 INFO - 'PAGER': '/bin/cat', 10:26:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:43 INFO - 'PWD': '/builds/slave/test', 10:26:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:43 INFO - 'SHELL': '/bin/bash', 10:26:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nyEJQ9NKaa/Listeners', 10:26:43 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 10:26:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:43 INFO - 'USER': 'cltbld', 10:26:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:43 INFO - 'XPC_FLAGS': '0x0', 10:26:43 INFO - 'XPC_SERVICE_NAME': '0', 10:26:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:26:43 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-J_Owxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:26:44 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-jeSPVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:26:44 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-475p3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:26:44 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-67LbGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:26:44 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-XRMmSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:26:44 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-_qApQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:26:44 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-qtrHrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:26:44 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-HYDwLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:26:44 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-YhPbWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:26:44 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-5PYjNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:26:44 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-jJQCzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:26:45 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-8ccweF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:26:45 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-smA2e9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:26:45 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-riL5ki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:26:45 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-8Xhi2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:26:45 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-KJPKe5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:26:45 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-whPgA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:26:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:26:45 INFO - Running setup.py install for manifestparser 10:26:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:26:45 INFO - Running setup.py install for mozcrash 10:26:46 INFO - Running setup.py install for mozdebug 10:26:46 INFO - Running setup.py install for mozdevice 10:26:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:26:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:26:46 INFO - Running setup.py install for mozfile 10:26:46 INFO - Running setup.py install for mozhttpd 10:26:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:26:46 INFO - Running setup.py install for mozinfo 10:26:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:26:46 INFO - Running setup.py install for mozInstall 10:26:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:26:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:26:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:26:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:26:46 INFO - Running setup.py install for mozleak 10:26:47 INFO - Running setup.py install for mozlog 10:26:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:26:47 INFO - Running setup.py install for moznetwork 10:26:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:26:47 INFO - Running setup.py install for mozprocess 10:26:47 INFO - Running setup.py install for mozprofile 10:26:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:26:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:26:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:26:47 INFO - Running setup.py install for mozrunner 10:26:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:26:47 INFO - Running setup.py install for mozscreenshot 10:26:48 INFO - Running setup.py install for moztest 10:26:48 INFO - Running setup.py install for mozversion 10:26:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:26:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:26:48 INFO - Cleaning up... 10:26:48 INFO - Return code: 0 10:26:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:26: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')]} 10:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26: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')]} 10:26:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:48 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 0x1074ba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107430570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8661580f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ced30>, '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 0x107134db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072c6b20>, '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.hHhUgHbhn6/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.nyEJQ9NKaa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 10:26:48 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 10:26:48 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 10:26:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hHhUgHbhn6/Render', 10:26:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:48 INFO - 'HOME': '/Users/cltbld', 10:26:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:48 INFO - 'LOGNAME': 'cltbld', 10:26:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:48 INFO - 'MOZ_NO_REMOTE': '1', 10:26:48 INFO - 'NO_EM_RESTART': '1', 10:26:48 INFO - 'PAGER': '/bin/cat', 10:26:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:48 INFO - 'PWD': '/builds/slave/test', 10:26:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:48 INFO - 'SHELL': '/bin/bash', 10:26:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nyEJQ9NKaa/Listeners', 10:26:48 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 10:26:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:48 INFO - 'USER': 'cltbld', 10:26:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:48 INFO - 'XPC_FLAGS': '0x0', 10:26:48 INFO - 'XPC_SERVICE_NAME': '0', 10:26:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:26:48 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-4GiFgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:26:49 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)) 10:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:26:49 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-9XCMwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:26:49 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)) 10:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:26:49 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-h_GH1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:26:49 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)) 10:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:26:49 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-WyEfxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:26:49 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)) 10:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:26:49 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-gtvZRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:26:49 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)) 10:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:26:49 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-r8b1Yu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:26:49 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)) 10:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:26:49 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-ucEnfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:26:49 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)) 10:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:26:49 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-ckbY40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:26:49 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)) 10:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:26:49 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-VdoCKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:26:49 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)) 10:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:26:49 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-CJpmD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:26:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:26:50 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-quPkGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:26:50 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)) 10:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:26:50 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-gnxtmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:26:50 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)) 10:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:26:50 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-q1AJNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:26:50 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)) 10:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:26:50 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-EUVdUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:26:50 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)) 10:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:26:50 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-msIDJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:26:50 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)) 10:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:26:50 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-4Bz9ns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:26:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:26:50 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-2awLp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:26:50 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)) 10:26:50 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)) 10:26:50 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)) 10:26:50 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)) 10:26:50 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)) 10:26:50 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)) 10:26:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:26:50 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 10:26:50 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 10:26:50 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 10:26:50 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 10:26:50 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 10:26:50 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 10:26:53 INFO - Downloading blessings-1.6.tar.gz 10:26:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:26:53 INFO - Installing collected packages: blessings 10:26:53 INFO - Running setup.py install for blessings 10:26:54 INFO - Successfully installed blessings 10:26:54 INFO - Cleaning up... 10:26:54 INFO - Return code: 0 10:26:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:26:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:26:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:26:54 INFO - Reading from file tmpfile_stdout 10:26:54 INFO - Current package versions: 10:26:54 INFO - blessings == 1.6 10:26:54 INFO - blobuploader == 1.2.4 10:26:54 INFO - docopt == 0.6.1 10:26:54 INFO - functools32 == 3.2.3-2 10:26:54 INFO - jsonschema == 2.5.1 10:26:54 INFO - manifestparser == 1.1 10:26:54 INFO - mozInstall == 1.12 10:26:54 INFO - mozcrash == 1.0 10:26:54 INFO - mozdebug == 0.1 10:26:54 INFO - mozdevice == 0.48 10:26:54 INFO - mozfile == 1.2 10:26:54 INFO - mozhttpd == 0.7 10:26:54 INFO - mozinfo == 0.9 10:26:54 INFO - mozleak == 0.1 10:26:54 INFO - mozlog == 3.4 10:26:54 INFO - moznetwork == 0.27 10:26:54 INFO - mozprocess == 0.23 10:26:54 INFO - mozprofile == 0.28 10:26:54 INFO - mozrunner == 6.13 10:26:54 INFO - mozscreenshot == 0.1 10:26:54 INFO - mozsystemmonitor == 0.3 10:26:54 INFO - moztest == 0.7 10:26:54 INFO - mozversion == 1.4 10:26:54 INFO - psutil == 3.1.1 10:26:54 INFO - requests == 1.2.3 10:26:54 INFO - wsgiref == 0.1.2 10:26:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:54 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 0x1074ba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107430570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8661580f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ced30>, '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 0x107134db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072c6b20>, '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.hHhUgHbhn6/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.nyEJQ9NKaa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 10:26:54 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 10:26:54 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 10:26:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hHhUgHbhn6/Render', 10:26:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:54 INFO - 'HOME': '/Users/cltbld', 10:26:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:54 INFO - 'LOGNAME': 'cltbld', 10:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:54 INFO - 'MOZ_NO_REMOTE': '1', 10:26:54 INFO - 'NO_EM_RESTART': '1', 10:26:54 INFO - 'PAGER': '/bin/cat', 10:26:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:54 INFO - 'PWD': '/builds/slave/test', 10:26:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:54 INFO - 'SHELL': '/bin/bash', 10:26:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nyEJQ9NKaa/Listeners', 10:26:54 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 10:26:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:54 INFO - 'USER': 'cltbld', 10:26:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:54 INFO - 'XPC_FLAGS': '0x0', 10:26:54 INFO - 'XPC_SERVICE_NAME': '0', 10:26:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:26:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:26:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:26:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:26:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:26:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:26:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:26:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:26:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:26:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:26:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:26:54 INFO - Cleaning up... 10:26:54 INFO - Return code: 0 10:26:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1074ba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107430570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8661580f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ced30>, '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 0x107134db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072c6b20>, '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.hHhUgHbhn6/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.nyEJQ9NKaa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 10:26:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:26:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:26:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hHhUgHbhn6/Render', 10:26:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:54 INFO - 'HOME': '/Users/cltbld', 10:26:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:54 INFO - 'LOGNAME': 'cltbld', 10:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:54 INFO - 'MOZ_NO_REMOTE': '1', 10:26:54 INFO - 'NO_EM_RESTART': '1', 10:26:54 INFO - 'PAGER': '/bin/cat', 10:26:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:54 INFO - 'PWD': '/builds/slave/test', 10:26:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:54 INFO - 'SHELL': '/bin/bash', 10:26:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nyEJQ9NKaa/Listeners', 10:26:54 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 10:26:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:54 INFO - 'USER': 'cltbld', 10:26:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:54 INFO - 'XPC_FLAGS': '0x0', 10:26:54 INFO - 'XPC_SERVICE_NAME': '0', 10:26:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:26:54 INFO - Cleaning up... 10:26:55 INFO - Return code: 0 10:26:55 INFO - Running post-action listener: _resource_record_post_action 10:26:55 INFO - Running post-action listener: _start_resource_monitoring 10:26:55 INFO - Starting resource monitoring. 10:26:55 INFO - [mozharness: 2016-12-22 18:26:55.031074Z] Finished create-virtualenv step (success) 10:26:55 INFO - [mozharness: 2016-12-22 18:26:55.032063Z] Running install step. 10:26:55 INFO - Running pre-action listener: _resource_record_pre_action 10:26:55 INFO - Running main action method: install 10:26:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:26:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:26:55 INFO - Reading from file tmpfile_stdout 10:26:55 INFO - Detecting whether we're running mozinstall >=1.0... 10:26:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:26:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:26:55 INFO - Reading from file tmpfile_stdout 10:26:55 INFO - Output received: 10:26:55 INFO - Usage: mozinstall [options] installer 10:26:55 INFO - Options: 10:26:55 INFO - -h, --help show this help message and exit 10:26:55 INFO - -d DEST, --destination=DEST 10:26:55 INFO - Directory to install application into. [default: 10:26:55 INFO - "/builds/slave/test"] 10:26:55 INFO - --app=APP Application being installed. [default: firefox] 10:26:55 INFO - mkdir: /builds/slave/test/build/application 10:26:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:26:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 10:27:27 INFO - Reading from file tmpfile_stdout 10:27:27 INFO - Output received: 10:27:27 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 10:27:27 INFO - Running post-action listener: _resource_record_post_action 10:27:27 INFO - [mozharness: 2016-12-22 18:27:27.683884Z] Finished install step (success) 10:27:27 INFO - [mozharness: 2016-12-22 18:27:27.684049Z] Running run-tests step. 10:27:27 INFO - Running pre-action listener: _resource_record_pre_action 10:27:27 INFO - Running main action method: run_tests 10:27:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:27:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:27:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:27:27 INFO - 2016-12-22 10:27:27.698 screenresolution[1621:7794] starting screenresolution argv=screenresolution get 10:27:27 INFO - 2016-12-22 10:27:27.701 screenresolution[1621:7794] Display 0: 1600x1200x32@60 10:27:27 INFO - 2016-12-22 10:27:27.707 screenresolution[1622:7797] starting screenresolution argv=screenresolution list 10:27:27 INFO - Available Modes on Display 0 10:27:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:27:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:27:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:27:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:27:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:27:27 INFO - Intel Iris: 10:27:27 INFO - Chipset Model: Intel Iris 10:27:27 INFO - Type: GPU 10:27:27 INFO - Bus: Built-In 10:27:27 INFO - VRAM (Dynamic, Max): 1536 MB 10:27:27 INFO - Vendor: Intel (0x8086) 10:27:27 INFO - Device ID: 0x0a2e 10:27:27 INFO - Revision ID: 0x0009 10:27:27 INFO - Displays: 10:27:27 INFO - Display: 10:27:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:27:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:27:27 INFO - Display Serial Number: 1600x1200 60 10:27:27 INFO - Main Display: Yes 10:27:27 INFO - Mirror: Off 10:27:27 INFO - Online: Yes 10:27:27 INFO - Rotation: Supported 10:27:27 INFO - Return code: 0 10:27:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:27:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:27:27 INFO - Python 2.7.3 10:27:27 INFO - Return code: 0 10:27:27 INFO - grabbing minidump binary from tooltool 10:27:27 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')]} 10:27:27 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 0x1072ced30>, '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 0x107134db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072c6b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:27:27 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 10:27:27 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 10:27:27 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 10:27:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:27:28 INFO - Return code: 0 10:27:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:27:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:27:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:27:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:27:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:27:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X-WoevjwTyuzeF-sak0Saw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0184', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:27:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/X-WoevjwTyuzeF-sak0Saw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0184 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:27:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hHhUgHbhn6/Render', 10:27:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:27:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:27:28 INFO - 'HOME': '/Users/cltbld', 10:27:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:27:28 INFO - 'LOGNAME': 'cltbld', 10:27:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:27:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:27:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:28 INFO - 'MOZ_NO_REMOTE': '1', 10:27:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:27:28 INFO - 'NO_EM_RESTART': '1', 10:27:28 INFO - 'PAGER': '/bin/cat', 10:27:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:27:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:28 INFO - 'PWD': '/builds/slave/test', 10:27:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:27:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:27:28 INFO - 'SHELL': '/bin/bash', 10:27:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nyEJQ9NKaa/Listeners', 10:27:28 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 10:27:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:27:28 INFO - 'USER': 'cltbld', 10:27:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:27:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:27:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:28 INFO - 'XPC_FLAGS': '0x0', 10:27:28 INFO - 'XPC_SERVICE_NAME': '0', 10:27:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:27:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X-WoevjwTyuzeF-sak0Saw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0184', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:27:28 INFO - mozversion application_buildid: 20161222075153 10:27:28 INFO - mozversion application_changeset: af6633c41d46a6183d9173cd6aa13532ed6a733b 10:27:28 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:27:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:27:28 INFO - mozversion application_name: Firefox 10:27:28 INFO - mozversion application_remotingname: firefox-dev 10:27:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:27:28 INFO - mozversion application_vendor: Mozilla 10:27:28 INFO - mozversion application_version: 52.0a2 10:27:28 INFO - mozversion platform_buildid: 20161222075153 10:27:28 INFO - mozversion platform_changeset: af6633c41d46a6183d9173cd6aa13532ed6a733b 10:27:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:27:28 INFO - mozversion platform_version: 52.0a2 10:27:28 INFO - using testdate: 1482431248 10:27:28 INFO - actual date: 1482431248 10:27:28 INFO - starting webserver on 'localhost:49246' 10:27:28 INFO - SUITE-START | Running 2 tests 10:27:28 INFO - TEST-START | dromaeo_css 10:27:28 INFO - operating with platform_type : mac_ 10:27:28 INFO - Initialising browser for dromaeo_css test... 10:27:28 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/tmp7KrOr8/profile http://localhost:49246/getInfo.html) 10:27:31 INFO - PROCESS | 1632 | 2016-12-22 10:27:31.480 plugin-container[1634:7982] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a47, name = 'com.apple.tsm.portname' 10:27:31 INFO - PROCESS | 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:27:31 INFO - PROCESS | 1632 | 2016-12-22 10:27:31.484 plugin-container[1634:7982] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e1f, name = 'com.apple.CFPasteboardClient' 10:27:31 INFO - PROCESS | 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:27:31 INFO - PROCESS | 1632 | 2016-12-22 10:27:31.484 plugin-container[1634:7982] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:27:31 INFO - PROCESS | 1632 | __metrics Screen width/height:1600/1200 10:27:31 INFO - PROCESS | 1632 | colorDepth:24 10:27:31 INFO - PROCESS | 1632 | Browser inner width/height: 1024/663 10:27:31 INFO - PROCESS | 1632 | __metrics 10:27:31 ERROR - PROCESS | 1632 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 10:27:32 INFO - TEST-INFO | 1632: exit 0 10:27:32 INFO - Browser initialized. 10:27:32 INFO - Running cycle 1/1 for dromaeo_css test... 10:27:32 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/tmp7KrOr8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:27:35 INFO - PROCESS | 1635 | 2016-12-22 10:27:35.043 plugin-container[1636:8111] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843f, name = 'com.apple.tsm.portname' 10:27:35 INFO - PROCESS | 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:27:35 INFO - PROCESS | 1635 | 2016-12-22 10:27:35.044 plugin-container[1636:8111] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x890b, name = 'com.apple.CFPasteboardClient' 10:27:35 INFO - PROCESS | 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:27:35 INFO - PROCESS | 1635 | 2016-12-22 10:27:35.044 plugin-container[1636:8111] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:27:44 INFO - PROCESS | 1635 | RSS: Main: 243195904 10:27:44 INFO - PROCESS | 1635 | 10:28:34 INFO - PROCESS | 1635 | 1482431314338 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:30:48 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49246/tests/dromaeo/cssquery-ext.html) 10:30:51 INFO - PROCESS | 1635 | RSS: Main: 245485568 10:30:51 INFO - PROCESS | 1635 | 10:33:53 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-ext.html (next: http://localhost:49246/tests/dromaeo/cssquery-jquery.html) 10:33:53 INFO - PROCESS | 1635 | RSS: Main: 255750144 10:33:53 INFO - PROCESS | 1635 | 10:36:55 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49246/tests/dromaeo/cssquery-mootools.html) 10:36:56 INFO - PROCESS | 1635 | RSS: Main: 258457600 10:36:56 INFO - PROCESS | 1635 | 10:39:58 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49246/tests/dromaeo/cssquery-prototype.html) 10:39:59 INFO - PROCESS | 1635 | RSS: Main: 257728512 10:39:59 INFO - PROCESS | 1635 | 10:43:01 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49246/tests/dromaeo/cssquery-yui.html) 10:43:02 INFO - PROCESS | 1635 | RSS: Main: 261091328 10:43:02 INFO - PROCESS | 1635 | 10:46:05 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-yui.html (next: http://localhost:49246/tests/dromaeo/cssquery-dojo.html) 10:46:05 INFO - PROCESS | 1635 | RSS: Main: 262725632 10:46:05 INFO - PROCESS | 1635 | 10:46:05 INFO - PROCESS | 1635 | __start_tp_report 10:46:05 INFO - PROCESS | 1635 | _x_x_mozilla_page_load 10:46:05 INFO - PROCESS | 1635 | _x_x_mozilla_page_load_details 10:46:05 INFO - PROCESS | 1635 | |i|pagename|runs| 10:46:05 INFO - PROCESS | 1635 | |0;dojo.html;3374.1901943533544;3384.3738908301966;3413.0614081127687;3421.2644281479484;3428.799920027989;4839.298301746245;5862.618929769562;5864.5015173710235;5879.970600147004;5989.9401005989985;5889.293284805829;5922.940770592293;5933.732982015809;5944.286685597724;5965.821025369235;5276.287701160342;5335.119705248649;5351.866203344908;5389.487998640143;5394.8921021579545;5355.086085252572;5378.731063446812;5380.542653874406;5380.973095134538;5415.539679127279;5229.111051121299;5241.8951620967555;5360.195970604421;5387.757550910218;5390.865228369303;4108.383742438628;4314.61168494837;5291.735413229342;5381;5443.618946673734;5234.7120908350025;5287.920681189786;5303.893922121574;5325.467453254682;5335.306410166692;5655.462731040545;5895.55783316253;5947.791827286024;5948.881022379572;5973.283206015306;6146.86283037635;6162.352952939967;6162.7226774795245;6196.752129914798;6219.067139929001;5402.270693456372;6028.9449346364645;6147.969260153715;6197.16338294329;6198.907016394758;5979;5996.910046349309;6006.909896351558;6011.969940150271;6029.6683682397015;6099.207103076572;6199.814005579839;6236.844078898064;6355.618662880242;6367.076773867763;6129.083728908156;6183.81448556544;6207.34822843604;6220.502359811204;6246.250449946036;6178.443940045418;6192.195014648067;6193.473554747807;6195.628262304276;6212.81361559154;6096.786612468542;6124.724387402489;6148.78479253224;6150.846228844314;6207.6585787782105;6118.449339559461;6131.804871721949;6165.753369865155;6191.535634827406;6226.875462490725;4940.90118197634;4978.5270399312;4978.6017118630425;4993.70037797726;5017.2223305387;4477.6417886569;4478.552144785561;4508.639308855284;4519.819207231674;4547.090581883636;4841.733704646278;5540.944590554123;5839.416058394127;5907.172995780594;5976.5218782497295;6103.3591472894705;6153.784617538365;6169.753209871555;6173.104899789505;6180.289266734383;4515.864524064284;5796.88406231873;5865.266841644794;5877.118432235114;5944.4352786485215;4465.910681786346;4624.260118381043;4666.883327916761;4731.148393289172;4853.12643724126;6236.906446403398;6458.967705161444;6468.313061554869;6500.5449618526245;6509.609423434609;5045.772940217626;6136.335271946791;6146.938530614637;6171.9074213887725;6217.658028808459;6380.489560835215;6383.680815959091;6401.679916004275;6411.6153030818305;6438.806835794933;6199.907001395073;6201.534884883742;6225.906611400923;6229.1590635265475;6238;6101.694915254308;6109.586862300737;6127.403330890903;6150.04674275488;6189.690515474118;4822.541858523435;6177.876442471215;6185.938140618537;6218.968905155445;6267.5299352549655;6143.84640383994;6147.200863887666;6152.323244443018;6183.721732521957;6198.845028874134;4510.526394728638;5948.929192745348;6001.939980600138;6019.428154325332;6146.416090471398;6116.944513560587;6132.018876979661;6135.539834512519;6141.301904043321;6155.538334625011;4807.687500312469;5145.819896303611;6102.578645452504;6123.632582045091;6180.567360284737 10:46:05 INFO - PROCESS | 1635 | |1;ext.html;468.17133673398064;478.2873518457498;502.4924825925814;518.4711594173942;526.998702465316;37996.24007519851;39698.603013969885;39966.400503992394;40010.79994600027;42011.36982945251;40592.797036014854;41089.178216435655;41165.79417102918;41184.794076029575;41194.58805411945;9228.90771092289;9358.970513243537;9367.391119577205;9383.5308234588;9390.906090939072;9297.4886381249;9359.01730318317;9406.5767040483;9414.482203478807;9418.62325506979;9412.435253884789;9421.905780942207;9424.952875235615;9451.102145296185;9469.715908522756;9348.252139828797;9406.576704048266;9408.341416100875;9409.482478463717;9428.15146636806;9244.399114057565;9306.581203845843;9313.860292095624;9316.906830931672;9345.672901448417;28983.85508072446;35554;39274.80362598197;39551.60448395508;39711.60288397108;3417.8291085445876;3476.9652303476896;3484.0767196692896;3696.353138200831;3880.3597406427907;28115.875364985375;29541.70458295411;30130.54804177939;30389.78440862363;30517.847410762803;3111.5177147542167;3157.4000939821362;3167.445697003015;3192.808431494118;3236.5307030480685;517671.9999999962;521898;529058;530026;530606;63172;64004.719905601625;64014.67992660007;64138.67930660317;64223.678881606225;67247;68202.31797682059;69143.3085669147;69367;69677;16457.83542164587;16553.25510352037;16699.6660066798;16795.580110497092;16806.747898781527;12599.370031498389;12668.556600518938;12776.61670149897;12800.975921926223;12811.551595694293;18934.24263029491;19976.90011549933;19994.90002549978;20031;20084.69872951907;8164.387670924704;8191.303739182236;8191.46755460905;8207.589620518951;8229.46508476947;689.0706023135201;863.3826813828143;958.7075941837807;1054.536004158168;1128.210252823027;26244.687765612023;28650.426991460055;29775;29930.70069299323;30363;977.8239916814899;981.4601968917067;1003.4631472162358;1043.3531210649294;1076.853151393763;14890.404383824742;15423.920325577103;15555.066695998275;15584.595721914511;15625.687486250212;668744;671128;671151;671394;672793;57477.13784293239;57887.13169302464;57952.420475795545;58054;58096.128558071665;1266.6706656269437;1314.7962065879804;1316.414195682912;1325.3439547424086;1329.0895736420582;28844.855775720986;29098.563521547618;29441.822327106674;29940.550891736206;30185.245368865955;49322;49957.50042499528;50052.49947500624;50146.49853501418;50235.74410639763;578626;584055;584637;585150;586120;26673.33316667099;27100;27561.44877102487;27591.31021724473;28424.28939276452;45820;45901;46125.538744612124;46335.53664463447;46376.768116159205;36267.09332266715;36662.450063248536;37397.81301093477;38292.42561361526;38430;37452.812735936146;38077.809610951765;38656.42015369828;38702.80648596852;38735.03162420962;36107;36371.09072273108;37241;37342.62657373391;37444;31786.52320215245;33344.83327583443;33813.98558043263;33825.323493530486;34098;24719.134830280855;24901.377465563506;25270;25565.360865977756;26243.60634590521 10:46:05 INFO - PROCESS | 1635 | |2;jquery.html;320.97592680548956;331.170284179906;331.45475692485877;369.7300970291685;400.5793916387792;18264.99542525162;19102.04489775511;19176.137073831676;19203.231870725172;19501.512462188453;18736.812631873676;18931.62136757264;19191.904040479778;19683.60632787347;19883.60232795343;5521.696306703119;5765.596408251424;5769.336526299467;5782.653040817543;5801.07182850744;4023.0948036691802;6237.750489980395;6502.154719886432;6577.309382514839;6648.401643852052;6270.937290627104;6367.713452894631;6527.151470308853;6540.803775886731;6572.671366431683;6464.579802312858;6477.481801455896;6512.609243445361;6524.706388212542;6529.085927970112;5546.58400619951;5605.943940560624;5669.688167150805;5720.599558030939;5725.570582206309;24428.877855610786;24688.259352219462;24750.25749227526;24803.503929921302;24887.751122488724;2357.552065107624;2948.690387509302;2987.342784587387;3060.556219348204;3066.7546596272246;14803.481878134322;14855.331510082073;15022.924885375503;15216.847831521654;15783.763243551355;1581.7390130628548;1811.2121227266182;1881.7553718016707;1902.6289873474677;1925.2972664977322;113497.99999999917;114152;114333;119665;119701;9040.773980650536;10454.32046916948;10896.61861834832;11011.724706882233;11130;13546.525871594447;13636.659083522793;13639.727205455836;13654.863451365558;13658.521951731642;7213.49505534618;7477.915702223256;8109;8387.119352467904;8458.281046111026;7135.322144396274;8347.499150050895;8358.080611132771;8469.110743371857;8510.829783404297;6458.095866578683;6577.440917521969;6586.571872828346;6591.274959754423;6591.769288074895;1673.1550566963606;1792.829681180286;1800.1989114843768;1865.2818664813874;1874.297138573035;311.54981052379094;389.18271629578226;409.1224323825437;824.5423789796721;911.8996910339857;10322.174226061898;11333.659990200307;11505.252158609663;11513.88486115145;12081;425.0818232617593;433.42138245442055;439.23572983009336;444.391184077809;469.6313393985705;5841.853953651108;5919.852003699856;6121.571489995657;6122.051082082285;6122.142899994004;594170;616081;625964;633066;644480;134282;136137;136507;137099.31450342885;138814.30592846972;407.8966395899086;429.9419578356882;443.2044480158124;934.8878134623889;1000.4947501511836;16561.83438165603;18854.811451885307;19325.90337048362;19494.415167544998;19499.122539485474;42175;42869.571304287805;54842.903141937735;55435.722821385636;56541.71729141328;67792.6610366945;81233.28283813028;81370.59314703388;82439.5878020606;84657.30685386134;7905.169957154416;8040.758777236692;8102.513849169069;8173.019237691277;8326.6669333226;11780;11798.292102473879;12350.505979761068;12515.812262815884;12761.361931903182;10722.946385268024;10743.516541755796;10924.016838484575;10939.12487001022;11074.889251107386;10584.364938103738;10797.13622910181;10890.128789696646;10956.671299861016;11108.888911110786;10997;11051.447427628747;11112.110941140187;11150.219484635998;11163.776724465628;7948.3641308694005;8048.758537243892;8291.922050133686;8306.83386332258;8366.66533338684;9363.923148837699;9669.887962884359;10835.187360947803;11166.994970452373;11282.7743445129 10:46:05 INFO - PROCESS | 1635 | |3;mootools.html;1232.094410608203;1401.9439222431104;1520.429838810446;1644.7746428910464;1659.6348803263277;7483.8877416838795;7761.883571746414;8071.7174898878475;8499.19257670521;8515.36134789891;7982.401319901016;8223.547704876244;8269.13174116718;8386.11945745697;8406.201410865973;2329.336139200324;2347.9060837566476;2355.8350915435926;2355.893984770681;2356.587597170488;2317.9072837086496;2343.589871772433;2367.6566897799808;2384.988075059622;2386.6181410974245;2313.248194336839;2318.2233951626226;2319.82601304902;2346.085026839534;2353.14110349722;2307.40007598024;2313.4794671199015;2332.2769941318074;2336.754640762721;2337.5909215887236;2345.8592484450987;2363.8581685098948;2366.8461549999365;2370.4073981504625;2372.7034120734907;8326.417150799447;8341.83316333676;8385.580720963988;8395.286400655952;8438.535880526568;4519.389882365905;5069.822556210515;5102.132637451642;5222.112240919015;5247.370315562119;3318.2202182487094;3472.6700963408434;3595.964040359589;3596.2627661329366;3598;869.8173383589453;992.3450522655013;1004.1866088468364;1066.9893301066968;1104.0780947908506;10872.945635271852;10935.015848573586;10982.890171098346;10984.615538456115;11007.229493935427;4522.3668686383935;4631.814727410866;4680.953190468052;4715.929261061086;4768;9280.257579393632;9454.00732923047;9463.858042129374;9469.431834089977;9528.523573821281;5203.479652034766;5243.344581927259;5245.3705555332845;5250.553702935294;5250.737463126905;4281.914361712748;4296.334068219431;4717.905641887143;4775.2359622460235;4806.543378379049;3857.72995890285;3877.689784817208;3950.7432016919383;3977.4033894915415;3985.1631157456677;1279.4114707234776;1286.523986125121;1288.6456224538326;1297.4550688710765;1298.1237664576374;800.7637746864689;800.9399295052895;876.2989608313324;880.4101252161067;900.1043961258458;5211;5596.412376700469;5623.971880140573;5778.595498315078;5881;854.8076682746457;928.252756530999;944.9480278584743;948.0756262643868;975.1516180922642;3192.457282262021;3213.742900567949;3592.209713862946;3755.5493340798735;3802.125511132455;9786.510674466248;10107.444090575089;10120.59517619287;10140;10180.490975451197;9528.90471095294;10013.048760367754;10015.799684006279;10031.598736050477;10075.34510256831;7726.497777644435;7768.883466748003;7948.324392426593;7950.24472675095;7958.965334506477;4588.334691469651;5451.882364115426;5703.602617358773;5780.289064412658;5788.160716695971;8172.509649421054;9279.164875161268;9279.304052195977;9479.099485548863;9500.239980801382;9018.323625727966;9440.433573985583;9518.952405238206;9544.618215271312;9595.328327017041;6148.938510615016;6791.2190098139345;6872.656367181721;6945.861082778215;7183.389411900047;7415.592142432218;7418.96290518544;7427.665755040928;7960.800979975547;8038.316743076904;6727.73089076451;7188.209296977224;7189.388901943394;7243.782686519413;7323;6127.754889804358;6149.631022138686;7111.928880711127;7138.14342278909;7156.463265255023;6597.439217666552;6663.800085997428;6714.764983225564;6719.764808231688;6727.899081513683;4833.661643684908;4854.611631069577;4867.80528778859;4870.0746858096845;4906.852794416173;4752.976235118802;4760.976195119002;4928.063667903087;4932.7533623319405;4965.226427914883 10:46:05 INFO - PROCESS | 1635 | |4;prototype.html;290.36120534823397;300.30629246440725;306.63663558682964;308.31092508244086;311.2002154463031;4488;5101.6938983661;5507.366652834915;5613.522850557702;5661.545837744969;4731.380493922144;5499.835004949848;5510.6969116698565;5535.723213839312;5577.44225577442;3512.5258090157886;4068.5321188063454;4074.5925407459313;4080.7553696122745;4281.8073186706515;3914.2171565686835;4123.989622542481;4223.450951376317;4274.589385502776;4280.914381712364;3617.3488772021024;4092.7339722917914;4116.58834116589;4134.317837556815;4135.648469880064;3374.4432168692138;3596.2627661329498;4045.676345892351;4129.070959034223;4154.543000269998;3604.2250916052913;3605.603383627799;3609.530761001079;3619.2808416002454;3642.271545690846;4287.656987440997;4365.759883206422;4386.385905973167;4462.1744977179005;4951.3810773653295;3892.299386110499;3904.882853514399;4463.821447142111;4596.264597664358;4620;4985.426675932278;5204.921926171072;5810.7385167667135;5816.534677225812;5835.9708201458725;3487.2851065531504;3560.6647507184807;3865.091703449687;3911.5892831252595;3947.4670919426085;4977.104121258172;5081.949180508222;6104.786332478387;6127.234095738033;6154.9076763849025;3380.2901390707734;3772.698419045425;3970.861019864291;3997.520297564311;4009.3184158693093;3892.3577609694084;3991.4012898064943;4051.817668204938;4057.878263652095;4078.7552746835286;3930.30996671434;4652.55800698933;4659.930101048487;4676.532346765296;4678.6491013174145;4694.197699863122;5383.892322153613;5877.23595932526;5883.735231914574;5906.822795316148;1152.5620264299512;1264.9494020239088;1285.2609749394135;1301.4794082366939;1312;804.4730701390598;862.2929198057533;873.8820259265045;889.9555022248861;900.4552245891141;4309.96560825406;5104.412992505835;5225.216217567319;5254.65844720092;5269.920951185735;5732.627379220421;5749.597528172988;5771.249737534094;5772.62477938941;5828.067509198508;4263.744175349489;4557.794899229476;4811.639127065484;4932.755596203719;5216.426193118754;2438.305083051322;2898.94188621156;2930.164903002634;2985.3730716549335;3008.36824266902;5174.689518628894;5509.228707980886;5885.764569417261;5915.556333274935;6016.759329626853;4863.765595878772;5255.894882102413;5568.777248909998;5661.575381846378;5859.970700146472;5306.893862122736;5969.373215812364;5986.161937328778;6001.639901605918;6028.854517641634;4655.6973796703105;4930.901381972269;5754.7339585291165;5821.3118195724455;5824.330202026821;4419.734815910927;4977.850664480072;5307.575393968396;5664.745086471036;5972.8805423892145;5256.9737151314;5539.1443866305235;5809.506191973561;6029.60807547508;6033.306169790355;3196.633676962433;3593;3789.006684719041;3799.6960243181034;3812.6759225466144;5296.947030529799;5654.7842213924205;5702.971485142548;5719.456651618089;5789.768409263751;4952.4304704959395;4987.852793857361;5798.217240672455;5868.471837534642;5884.440978107073;4959.82640607577;5847.684271038982;5855.560832937462;5858.7070646468355;5860.560457965755;5513.195894832553;5762.7694892203845;5767.183337248754;5810.791899078492;5860.648361098348;5349.411564727799;5487.00957977895;5638.252141836044;5961;6021.488173505301;4898.412190537016;5563.471470210324;5654.46282603152;5919.171316015675;5925.792597259076 10:46:05 INFO - PROCESS | 1635 | |5;yui.html;727.3889932456735;731.7256028989129;732.1324230786519;756.4591317208202;776.0725932510649;14364.281785910714;14406.711865762678;14864.628384290398;14872.107673539595;15050.096994180356;12626.926711229533;13423.060385773;13475.865241347583;13562.389692463837;13659.112157709767;633.6071635585943;793.0364607002491;799.6801279488193;801.5150833745587;802.0695992648529;776.1113525013856;783.725696006399;785.1559573458526;785.7328508307174;786.3866184376195;830.6760363458226;838.4843321357351;843.085252501034;843.6372359885247;844.3920377328313;827.4125370986607;832.2634468495364;835.2733122183678;837.5728378526934;841.146236569882;620.4075108271635;620.88203241384;621.2606997672755;621.3475850357152;622.470899735226;12381.133320667557;12406.62780116598;12441.253524788543;12477.875221247763;12593.622191334274;11527.13546484017;11547.711307217303;11564.248323858923;11657.883421165765;11816.46825892837;10099.949500252525;10128;10257.948710256476;10332.276740628158;10430.322029068086;3377.5778027746533;3576.910577235564;3598.226381328001;3600.2979419013304;3699.075231192202;91480;91883.08116918812;91906.54046729724;92323;92563.53718231365;8417.537035462985;8444.408891377545;8780.385373023826;8839.16027977341;8842.557872106368;18264.726029109574;18524.0737963104;18557.721634175497;18669;18676.06619669011;7540;7570;7600.771976840703;7789.260020298063;7894.763157105296;4061.3298805696727;4193.182329445729;4212.726172798758;4273.423087883159;4375.949772054684;3348.3303339332233;3453.689167974844;3463.0130412832223;3463.809490478048;3466.185446420089;615.7721642992032;648.3743187823773;649.1885143570537;660.131926516629;662.5891946992896;533.3493138371181;562.3336346429494;566.8696199874053;581.3693038998565;622.6637615687569;8337.541435221;9024.36829421934;9072.8639070414;9086.500242486594;9491.383060101209;582.9387914269025;615.4122812713847;620.3579295429209;653.3531803514486;659.5020759326774;3481.7496139389277;3557.857685692595;4425.911481770411;4455.398521199661;4483.193025255486;116210.41894790472;118597;118825.40587297008;120924;121372;59837.803243934875;69772.95340569895;81267.59366203132;93454;107124;56703.86592268132;64994;70636.64681676558;75076.62461687656;82061.35877282421;9177.831729760384;9391.342606017513;9493.857592135986;9553.331266811534;9620.182284505616;49537;51045.23432148595;52375;52840.73579632077;54177.45822541724;70307.64846175736;72118.63940680263;78083.60958195172;78339;78622.21377786149;11973.401329933642;11987.820182697442;12062;12371.195872268274;12495.687607809878;13414.664633384244;13469.259190744604;13647.385867635781;13801.51694690681;14486.420543178576;12402.00783937301;12403.317817520123;12880.098393112392;13434.68479628952;13529.797053044016;12943.676408089874;13075.215487070805;13084.411201495765;13627.386767595284;13681.726365472834;12821.743565128458;12879.227246365248;13081.149725267827;13363.799543006668;13439.596812095653;8868.11318868108;10720.35677859331;10730.356178629307;10843;11022.614208502664;9580.281478888972;10746.570137194738;10976;11037.558497660324;11574.421278935852 10:46:05 INFO - PROCESS | 1635 | __end_tp_report 10:46:05 INFO - PROCESS | 1635 | __start_cc_report 10:46:05 INFO - PROCESS | 1635 | _x_x_mozilla_cycle_collect,360 10:46:05 INFO - PROCESS | 1635 | __end_cc_report 10:46:05 INFO - PROCESS | 1635 | __startTimestamp1482432365517__endTimestamp 10:46:05 INFO - PROCESS | 1635 | 10:46:05 INFO - PROCESS | 1635 | ------- Summary: start ------- 10:46:05 INFO - PROCESS | 1635 | Number of tests: 6 10:46:05 INFO - PROCESS | 1635 | 10:46:05 INFO - PROCESS | 1635 | [#0] dojo.html Cycles:165 Average:5715.25 Median:6019.43 stddev:692.65 (11.5%) stddev-sans-first:669.98 10:46:05 INFO - PROCESS | 1635 | Values: 3374.2 3384.4 3413.1 3421.3 3428.8 4839.3 5862.6 5864.5 5880.0 5989.9 5889.3 5922.9 5933.7 5944.3 5965.8 5276.3 5335.1 5351.9 5389.5 5394.9 5355.1 5378.7 5380.5 5381.0 5415.5 5229.1 5241.9 5360.2 5387.8 5390.9 4108.4 4314.6 5291.7 5381.0 5443.6 5234.7 5287.9 5303.9 5325.5 5335.3 5655.5 5895.6 5947.8 5948.9 5973.3 6146.9 6162.4 6162.7 6196.8 6219.1 5402.3 6028.9 6148.0 6197.2 6198.9 5979.0 5996.9 6006.9 6012.0 6029.7 6099.2 6199.8 6236.8 6355.6 6367.1 6129.1 6183.8 6207.3 6220.5 6246.3 6178.4 6192.2 6193.5 6195.6 6212.8 6096.8 6124.7 6148.8 6150.8 6207.7 6118.4 6131.8 6165.8 6191.5 6226.9 4940.9 4978.5 4978.6 4993.7 5017.2 4477.6 4478.6 4508.6 4519.8 4547.1 4841.7 5540.9 5839.4 5907.2 5976.5 6103.4 6153.8 6169.8 6173.1 6180.3 4515.9 5796.9 5865.3 5877.1 5944.4 4465.9 4624.3 4666.9 4731.1 4853.1 6236.9 6459.0 6468.3 6500.5 6509.6 5045.8 6136.3 6146.9 6171.9 6217.7 6380.5 6383.7 6401.7 6411.6 6438.8 6199.9 6201.5 6225.9 6229.2 6238.0 6101.7 6109.6 6127.4 6150.0 6189.7 4822.5 6177.9 6185.9 6219.0 6267.5 6143.8 6147.2 6152.3 6183.7 6198.8 4510.5 5948.9 6001.9 6019.4 6146.4 6116.9 6132.0 6135.5 6141.3 6155.5 4807.7 5145.8 6102.6 6123.6 6180.6 10:46:05 INFO - PROCESS | 1635 | 10:46:05 INFO - PROCESS | 1635 | [#1] ext.html Cycles:180 Average:72279.33 Median:39705.10 stddev:159597.05 (402.0%) stddev-sans-first:159953.69 10:46:05 INFO - PROCESS | 1635 | Values: 468.2 478.3 502.5 518.5 527.0 37996.2 39698.6 39966.4 40010.8 42011.4 40592.8 41089.2 41165.8 41184.8 41194.6 9228.9 9359.0 9367.4 9383.5 9390.9 9297.5 9359.0 9406.6 9414.5 9418.6 9412.4 9421.9 9425.0 9451.1 9469.7 9348.3 9406.6 9408.3 9409.5 9428.2 9244.4 9306.6 9313.9 9316.9 9345.7 28983.9 35554.0 39274.8 39551.6 39711.6 3417.8 3477.0 3484.1 3696.4 3880.4 28115.9 29541.7 30130.5 30389.8 30517.8 3111.5 3157.4 3167.4 3192.8 3236.5 517672.0 521898.0 529058.0 530026.0 530606.0 63172.0 64004.7 64014.7 64138.7 64223.7 67247.0 68202.3 69143.3 69367.0 69677.0 16457.8 16553.3 16699.7 16795.6 16806.7 12599.4 12668.6 12776.6 12801.0 12811.6 18934.2 19976.9 19994.9 20031.0 20084.7 8164.4 8191.3 8191.5 8207.6 8229.5 689.1 863.4 958.7 1054.5 1128.2 26244.7 28650.4 29775.0 29930.7 30363.0 977.8 981.5 1003.5 1043.4 1076.9 14890.4 15423.9 15555.1 15584.6 15625.7 668744.0 671128.0 671151.0 671394.0 672793.0 57477.1 57887.1 57952.4 58054.0 58096.1 1266.7 1314.8 1316.4 1325.3 1329.1 28844.9 29098.6 29441.8 29940.6 30185.2 49322.0 49957.5 50052.5 50146.5 50235.7 578626.0 584055.0 584637.0 585150.0 586120.0 26673.3 27100.0 27561.4 27591.3 28424.3 45820.0 45901.0 46125.5 46335.5 46376.8 36267.1 36662.5 37397.8 38292.4 38430.0 37452.8 38077.8 38656.4 38702.8 38735.0 36107.0 36371.1 37241.0 37342.6 37444.0 31786.5 33344.8 33814.0 33825.3 34098.0 24719.1 24901.4 25270.0 25565.4 26243.6 10:46:05 INFO - PROCESS | 1635 | 10:46:05 INFO - PROCESS | 1635 | [#2] jquery.html Cycles:180 Average:35479.33 Median:331.31 stddev:104028.62 (31398.9%) stddev-sans-first:104286.95 10:46:05 INFO - PROCESS | 1635 | Values: 321.0 331.2 331.5 369.7 400.6 18265.0 19102.0 19176.1 19203.2 19501.5 18736.8 18931.6 19191.9 19683.6 19883.6 5521.7 5765.6 5769.3 5782.7 5801.1 4023.1 6237.8 6502.2 6577.3 6648.4 6270.9 6367.7 6527.2 6540.8 6572.7 6464.6 6477.5 6512.6 6524.7 6529.1 5546.6 5605.9 5669.7 5720.6 5725.6 24428.9 24688.3 24750.3 24803.5 24887.8 2357.6 2948.7 2987.3 3060.6 3066.8 14803.5 14855.3 15022.9 15216.8 15783.8 1581.7 1811.2 1881.8 1902.6 1925.3 113498.0 114152.0 114333.0 119665.0 119701.0 9040.8 10454.3 10896.6 11011.7 11130.0 13546.5 13636.7 13639.7 13654.9 13658.5 7213.5 7477.9 8109.0 8387.1 8458.3 7135.3 8347.5 8358.1 8469.1 8510.8 6458.1 6577.4 6586.6 6591.3 6591.8 1673.2 1792.8 1800.2 1865.3 1874.3 311.5 389.2 409.1 824.5 911.9 10322.2 11333.7 11505.3 11513.9 12081.0 425.1 433.4 439.2 444.4 469.6 5841.9 5919.9 6121.6 6122.1 6122.1 594170.0 616081.0 625964.0 633066.0 644480.0 134282.0 136137.0 136507.0 137099.3 138814.3 407.9 429.9 443.2 934.9 1000.5 16561.8 18854.8 19325.9 19494.4 19499.1 42175.0 42869.6 54842.9 55435.7 56541.7 67792.7 81233.3 81370.6 82439.6 84657.3 7905.2 8040.8 8102.5 8173.0 8326.7 11780.0 11798.3 12350.5 12515.8 12761.4 10722.9 10743.5 10924.0 10939.1 11074.9 10584.4 10797.1 10890.1 10956.7 11108.9 10997.0 11051.4 11112.1 11150.2 11163.8 7948.4 8048.8 8291.9 8306.8 8366.7 9363.9 9669.9 10835.2 11167.0 11282.8 10:46:05 INFO - PROCESS | 1635 | 10:46:05 INFO - PROCESS | 1635 | [#3] mootools.html Cycles:180 Average:5419.69 Median:5207.24 stddev:2966.18 (57.0%) stddev-sans-first:2957.80 10:46:05 INFO - PROCESS | 1635 | Values: 1232.1 1401.9 1520.4 1644.8 1659.6 7483.9 7761.9 8071.7 8499.2 8515.4 7982.4 8223.5 8269.1 8386.1 8406.2 2329.3 2347.9 2355.8 2355.9 2356.6 2317.9 2343.6 2367.7 2385.0 2386.6 2313.2 2318.2 2319.8 2346.1 2353.1 2307.4 2313.5 2332.3 2336.8 2337.6 2345.9 2363.9 2366.8 2370.4 2372.7 8326.4 8341.8 8385.6 8395.3 8438.5 4519.4 5069.8 5102.1 5222.1 5247.4 3318.2 3472.7 3596.0 3596.3 3598.0 869.8 992.3 1004.2 1067.0 1104.1 10872.9 10935.0 10982.9 10984.6 11007.2 4522.4 4631.8 4681.0 4715.9 4768.0 9280.3 9454.0 9463.9 9469.4 9528.5 5203.5 5243.3 5245.4 5250.6 5250.7 4281.9 4296.3 4717.9 4775.2 4806.5 3857.7 3877.7 3950.7 3977.4 3985.2 1279.4 1286.5 1288.6 1297.5 1298.1 800.8 800.9 876.3 880.4 900.1 5211.0 5596.4 5624.0 5778.6 5881.0 854.8 928.3 944.9 948.1 975.2 3192.5 3213.7 3592.2 3755.5 3802.1 9786.5 10107.4 10120.6 10140.0 10180.5 9528.9 10013.0 10015.8 10031.6 10075.3 7726.5 7768.9 7948.3 7950.2 7959.0 4588.3 5451.9 5703.6 5780.3 5788.2 8172.5 9279.2 9279.3 9479.1 9500.2 9018.3 9440.4 9519.0 9544.6 9595.3 6148.9 6791.2 6872.7 6945.9 7183.4 7415.6 7419.0 7427.7 7960.8 8038.3 6727.7 7188.2 7189.4 7243.8 7323.0 6127.8 6149.6 7111.9 7138.1 7156.5 6597.4 6663.8 6714.8 6719.8 6727.9 4833.7 4854.6 4867.8 4870.1 4906.9 4753.0 4761.0 4928.1 4932.8 4965.2 10:46:05 INFO - PROCESS | 1635 | 10:46:05 INFO - PROCESS | 1635 | [#4] prototype.html Cycles:180 Average:4547.11 Median:4977.48 stddev:1427.13 (28.7%) stddev-sans-first:1394.91 10:46:05 INFO - PROCESS | 1635 | Values: 290.4 300.3 306.6 308.3 311.2 4488.0 5101.7 5507.4 5613.5 5661.5 4731.4 5499.8 5510.7 5535.7 5577.4 3512.5 4068.5 4074.6 4080.8 4281.8 3914.2 4124.0 4223.5 4274.6 4280.9 3617.3 4092.7 4116.6 4134.3 4135.6 3374.4 3596.3 4045.7 4129.1 4154.5 3604.2 3605.6 3609.5 3619.3 3642.3 4287.7 4365.8 4386.4 4462.2 4951.4 3892.3 3904.9 4463.8 4596.3 4620.0 4985.4 5204.9 5810.7 5816.5 5836.0 3487.3 3560.7 3865.1 3911.6 3947.5 4977.1 5081.9 6104.8 6127.2 6154.9 3380.3 3772.7 3970.9 3997.5 4009.3 3892.4 3991.4 4051.8 4057.9 4078.8 3930.3 4652.6 4659.9 4676.5 4678.6 4694.2 5383.9 5877.2 5883.7 5906.8 1152.6 1264.9 1285.3 1301.5 1312.0 804.5 862.3 873.9 890.0 900.5 4310.0 5104.4 5225.2 5254.7 5269.9 5732.6 5749.6 5771.2 5772.6 5828.1 4263.7 4557.8 4811.6 4932.8 5216.4 2438.3 2898.9 2930.2 2985.4 3008.4 5174.7 5509.2 5885.8 5915.6 6016.8 4863.8 5255.9 5568.8 5661.6 5860.0 5306.9 5969.4 5986.2 6001.6 6028.9 4655.7 4930.9 5754.7 5821.3 5824.3 4419.7 4977.9 5307.6 5664.7 5972.9 5257.0 5539.1 5809.5 6029.6 6033.3 3196.6 3593.0 3789.0 3799.7 3812.7 5296.9 5654.8 5703.0 5719.5 5789.8 4952.4 4987.9 5798.2 5868.5 5884.4 4959.8 5847.7 5855.6 5858.7 5860.6 5513.2 5762.8 5767.2 5810.8 5860.6 5349.4 5487.0 5638.3 5961.0 6021.5 4898.4 5563.5 5654.5 5919.2 5925.8 10:46:05 INFO - PROCESS | 1635 | 10:46:05 INFO - PROCESS | 1635 | [#5] yui.html Cycles:180 Average:19857.21 Median:51710.12 stddev:29661.32 (57.4%) stddev-sans-first:29709.74 10:46:05 INFO - PROCESS | 1635 | Values: 727.4 731.7 732.1 756.5 776.1 14364.3 14406.7 14864.6 14872.1 15050.1 12626.9 13423.1 13475.9 13562.4 13659.1 633.6 793.0 799.7 801.5 802.1 776.1 783.7 785.2 785.7 786.4 830.7 838.5 843.1 843.6 844.4 827.4 832.3 835.3 837.6 841.1 620.4 620.9 621.3 621.3 622.5 12381.1 12406.6 12441.3 12477.9 12593.6 11527.1 11547.7 11564.2 11657.9 11816.5 10099.9 10128.0 10257.9 10332.3 10430.3 3377.6 3576.9 3598.2 3600.3 3699.1 91480.0 91883.1 91906.5 92323.0 92563.5 8417.5 8444.4 8780.4 8839.2 8842.6 18264.7 18524.1 18557.7 18669.0 18676.1 7540.0 7570.0 7600.8 7789.3 7894.8 4061.3 4193.2 4212.7 4273.4 4375.9 3348.3 3453.7 3463.0 3463.8 3466.2 615.8 648.4 649.2 660.1 662.6 533.3 562.3 566.9 581.4 622.7 8337.5 9024.4 9072.9 9086.5 9491.4 582.9 615.4 620.4 653.4 659.5 3481.7 3557.9 4425.9 4455.4 4483.2 116210.4 118597.0 118825.4 120924.0 121372.0 59837.8 69773.0 81267.6 93454.0 107124.0 56703.9 64994.0 70636.6 75076.6 82061.4 9177.8 9391.3 9493.9 9553.3 9620.2 49537.0 51045.2 52375.0 52840.7 54177.5 70307.6 72118.6 78083.6 78339.0 78622.2 11973.4 11987.8 12062.0 12371.2 12495.7 13414.7 13469.3 13647.4 13801.5 14486.4 12402.0 12403.3 12880.1 13434.7 13529.8 12943.7 13075.2 13084.4 13627.4 13681.7 12821.7 12879.2 13081.1 13363.8 13439.6 8868.1 10720.4 10730.4 10843.0 11022.6 9580.3 10746.6 10976.0 11037.6 11574.4 10:46:05 INFO - PROCESS | 1635 | -------- Summary: end -------- 10:46:05 INFO - PROCESS | 1635 | 10:46:06 INFO - TEST-INFO | 1635: exit 0 10:46:06 INFO - TEST-OK | dromaeo_css | took 1117876ms 10:46:06 INFO - TEST-START | kraken 10:46:06 INFO - operating with platform_type : mac_ 10:46:06 INFO - Initialising browser for kraken test... 10:46:06 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/tmpKwc_Qp/profile http://localhost:49246/getInfo.html) 10:46:09 INFO - PROCESS | 1647 | 2016-12-22 10:46:09.035 plugin-container[1648:10434] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4547, name = 'com.apple.tsm.portname' 10:46:09 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:46:09 INFO - PROCESS | 1647 | 2016-12-22 10:46:09.039 plugin-container[1648:10434] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 10:46:09 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:46:09 INFO - PROCESS | 1647 | 2016-12-22 10:46:09.039 plugin-container[1648:10434] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:46:09 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 10:46:09 INFO - PROCESS | 1647 | colorDepth:24 10:46:09 INFO - PROCESS | 1647 | Browser inner width/height: 1024/663 10:46:09 INFO - PROCESS | 1647 | __metrics 10:46:09 ERROR - PROCESS | 1647 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 10:46:10 INFO - TEST-INFO | 1647: exit 0 10:46:10 INFO - Browser initialized. 10:46:10 INFO - Running cycle 1/1 for kraken test... 10:46:10 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/tmpKwc_Qp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:46:12 INFO - PROCESS | 1649 | 2016-12-22 10:46:12.561 plugin-container[1650:10562] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 10:46:12 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:46:12 INFO - PROCESS | 1649 | 2016-12-22 10:46:12.562 plugin-container[1650:10562] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x460b, name = 'com.apple.CFPasteboardClient' 10:46:12 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:46:12 INFO - PROCESS | 1649 | 2016-12-22 10:46:12.562 plugin-container[1650:10562] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:46:22 INFO - PROCESS | 1649 | RSS: Main: 243040256 10:46:22 INFO - PROCESS | 1649 | 10:46:25 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection) 10:46:26 INFO - PROCESS | 1649 | RSS: Main: 252715008 10:46:26 INFO - PROCESS | 1649 | 10:46:28 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-dft) 10:46:29 INFO - PROCESS | 1649 | RSS: Main: 260337664 10:46:29 INFO - PROCESS | 1649 | 10:46:32 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-fft) 10:46:33 INFO - PROCESS | 1649 | RSS: Main: 261210112 10:46:33 INFO - PROCESS | 1649 | 10:46:35 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator) 10:46:36 INFO - PROCESS | 1649 | RSS: Main: 261042176 10:46:36 INFO - PROCESS | 1649 | 10:46:37 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:46:38 INFO - PROCESS | 1649 | RSS: Main: 261566464 10:46:38 INFO - PROCESS | 1649 | 10:46:41 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom) 10:46:42 INFO - PROCESS | 1649 | RSS: Main: 265744384 10:46:42 INFO - PROCESS | 1649 | 10:46:45 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate) 10:46:45 INFO - PROCESS | 1649 | RSS: Main: 264704000 10:46:45 INFO - PROCESS | 1649 | 10:46:48 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial) 10:46:49 INFO - PROCESS | 1649 | RSS: Main: 265027584 10:46:49 INFO - PROCESS | 1649 | 10:46:50 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:46:51 INFO - PROCESS | 1649 | RSS: Main: 264024064 10:46:51 INFO - PROCESS | 1649 | 10:46:53 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:46:54 INFO - PROCESS | 1649 | RSS: Main: 264269824 10:46:54 INFO - PROCESS | 1649 | 10:46:56 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:46:57 INFO - PROCESS | 1649 | RSS: Main: 264065024 10:46:57 INFO - PROCESS | 1649 | 10:46:59 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:47:00 INFO - PROCESS | 1649 | RSS: Main: 264335360 10:47:00 INFO - PROCESS | 1649 | 10:47:03 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:47:04 INFO - PROCESS | 1649 | RSS: Main: 264355840 10:47:04 INFO - PROCESS | 1649 | 10:47:05 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49246/tests/kraken/driver.html?testName=ai-astar) 10:47:06 INFO - PROCESS | 1649 | RSS: Main: 266084352 10:47:06 INFO - PROCESS | 1649 | 10:47:06 INFO - PROCESS | 1649 | __start_tp_report 10:47:06 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 10:47:06 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 10:47:06 INFO - PROCESS | 1649 | |i|pagename|runs| 10:47:06 INFO - PROCESS | 1649 | |0;ai-astar;107;144;156;117;118;118;121;177;138;119 10:47:06 INFO - PROCESS | 1649 | |1;audio-beat-detection;153;110;97;180;101;150;146;141;152;110 10:47:06 INFO - PROCESS | 1649 | |2;audio-dft;190;200;198;197;196;195;196;198;199;196 10:47:06 INFO - PROCESS | 1649 | |3;audio-fft;83;60;62;87;60;60;60;63;96;84 10:47:06 INFO - PROCESS | 1649 | |4;audio-oscillator;82;72;89;71;69;73;86;70;71;88 10:47:06 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;93;105;122;91;96;120;94;91;94;104 10:47:06 INFO - PROCESS | 1649 | |6;imaging-darkroom;97;153;127;98;133;151;100;99;98;100 10:47:06 INFO - PROCESS | 1649 | |7;imaging-desaturate;96;98;88;84;93;84;91;93;109;117 10:47:06 INFO - PROCESS | 1649 | |8;json-parse-financial;59;57;52;53;62;61;60;62;61;61 10:47:06 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;76;74;75;70;96;92;101;104;103;73 10:47:06 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;85;85;84;80;86;70;98;79;84;102 10:47:06 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;141;155;150;140;146;142;146;169;217;181 10:47:06 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;169;168;188;173;159;168;170;153;159;145 10:47:06 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;69;70;67;67;70;70;73;72;72;80 10:47:06 INFO - PROCESS | 1649 | __end_tp_report 10:47:06 INFO - PROCESS | 1649 | __start_cc_report 10:47:06 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,981 10:47:06 INFO - PROCESS | 1649 | __end_cc_report 10:47:06 INFO - PROCESS | 1649 | __startTimestamp1482432426135__endTimestamp 10:47:06 INFO - PROCESS | 1649 | 10:47:06 INFO - PROCESS | 1649 | ------- Summary: start ------- 10:47:06 INFO - PROCESS | 1649 | Number of tests: 14 10:47:06 INFO - PROCESS | 1649 | 10:47:06 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:131.50 Median:129.50 stddev:21.88 (16.9%) stddev-sans-first:21.34 10:47:06 INFO - PROCESS | 1649 | Values: 107.0 144.0 156.0 117.0 118.0 118.0 121.0 177.0 138.0 119.0 10:47:06 INFO - PROCESS | 1649 | 10:47:06 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:134.00 Median:151.00 stddev:27.61 (18.3%) stddev-sans-first:28.41 10:47:06 INFO - PROCESS | 1649 | Values: 153.0 110.0 97.0 180.0 101.0 150.0 146.0 141.0 152.0 110.0 10:47:06 INFO - PROCESS | 1649 | 10:47:06 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:196.50 Median:197.50 stddev:2.76 (1.4%) stddev-sans-first:1.64 10:47:06 INFO - PROCESS | 1649 | Values: 190.0 200.0 198.0 197.0 196.0 195.0 196.0 198.0 199.0 196.0 10:47:06 INFO - PROCESS | 1649 | 10:47:06 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:71.50 Median:73.00 stddev:14.22 (19.5%) stddev-sans-first:14.46 10:47:06 INFO - PROCESS | 1649 | Values: 83.0 60.0 62.0 87.0 60.0 60.0 60.0 63.0 96.0 84.0 10:47:06 INFO - PROCESS | 1649 | 10:47:06 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:77.10 Median:77.50 stddev:8.14 (10.5%) stddev-sans-first:8.44 10:47:06 INFO - PROCESS | 1649 | Values: 82.0 72.0 89.0 71.0 69.0 73.0 86.0 70.0 71.0 88.0 10:47:06 INFO - PROCESS | 1649 | 10:47:06 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:101.00 Median:92.00 stddev:11.61 (12.6%) stddev-sans-first:11.95 10:47:06 INFO - PROCESS | 1649 | Values: 93.0 105.0 122.0 91.0 96.0 120.0 94.0 91.0 94.0 104.0 10:47:06 INFO - PROCESS | 1649 | 10:47:06 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:115.60 Median:125.00 stddev:23.12 (18.5%) stddev-sans-first:23.53 10:47:06 INFO - PROCESS | 1649 | Values: 97.0 153.0 127.0 98.0 133.0 151.0 100.0 99.0 98.0 100.0 10:47:06 INFO - PROCESS | 1649 | 10:47:06 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:92.00 stddev:10.56 (11.5%) stddev-sans-first:11.20 10:47:06 INFO - PROCESS | 1649 | Values: 96.0 98.0 88.0 84.0 93.0 84.0 91.0 93.0 109.0 117.0 10:47:06 INFO - PROCESS | 1649 | 10:47:06 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:61.00 stddev:3.65 (6.0%) stddev-sans-first:3.87 10:47:06 INFO - PROCESS | 1649 | Values: 59.0 57.0 52.0 53.0 62.0 61.0 60.0 62.0 61.0 61.0 10:47:06 INFO - PROCESS | 1649 | 10:47:06 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:86.40 Median:74.50 stddev:13.99 (18.8%) stddev-sans-first:14.33 10:47:06 INFO - PROCESS | 1649 | Values: 76.0 74.0 75.0 70.0 96.0 92.0 101.0 104.0 103.0 73.0 10:47:06 INFO - PROCESS | 1649 | 10:47:06 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:84.50 stddev:9.10 (10.8%) stddev-sans-first:9.66 10:47:06 INFO - PROCESS | 1649 | Values: 85.0 85.0 84.0 80.0 86.0 70.0 98.0 79.0 84.0 102.0 10:47:06 INFO - PROCESS | 1649 | 10:47:06 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:158.70 Median:152.50 stddev:24.40 (16.0%) stddev-sans-first:25.02 10:47:06 INFO - PROCESS | 1649 | Values: 141.0 155.0 150.0 140.0 146.0 142.0 146.0 169.0 217.0 181.0 10:47:06 INFO - PROCESS | 1649 | 10:47:06 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.20 Median:168.50 stddev:11.87 (7.0%) stddev-sans-first:12.51 10:47:06 INFO - PROCESS | 1649 | Values: 169.0 168.0 188.0 173.0 159.0 168.0 170.0 153.0 159.0 145.0 10:47:06 INFO - PROCESS | 1649 | 10:47:06 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:71.00 stddev:3.74 (5.3%) stddev-sans-first:3.90 10:47:06 INFO - PROCESS | 1649 | Values: 69.0 70.0 67.0 67.0 70.0 70.0 73.0 72.0 72.0 80.0 10:47:06 INFO - PROCESS | 1649 | -------- Summary: end -------- 10:47:06 INFO - PROCESS | 1649 | 10:47:07 INFO - TEST-INFO | 1649: exit 0 10:47:07 INFO - TEST-OK | kraken | took 61153ms 10:47:07 INFO - SUITE-END | took 1179s 10:47:07 INFO - Completed test suite (00:19:39) 10:47:07 INFO - javascript benchmark 10:47:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7103.90198887354, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3374.1901943533544, 3384.3738908301966, 3413.0614081127687, 3421.2644281479484, 3428.799920027989, 4839.298301746245, 5862.618929769562, 5864.5015173710235, 5879.970600147004, 5989.9401005989985, 5889.293284805829, 5922.940770592293, 5933.732982015809, 5944.286685597724, 5965.821025369235, 5276.287701160342, 5335.119705248649, 5351.866203344908, 5389.487998640143, 5394.8921021579545, 5355.086085252572, 5378.731063446812, 5380.542653874406, 5380.973095134538, 5415.539679127279, 5229.111051121299, 5241.8951620967555, 5360.195970604421, 5387.757550910218, 5390.865228369303, 4108.383742438628, 4314.61168494837, 5291.735413229342, 5381.0, 5443.618946673734, 5234.7120908350025, 5287.920681189786, 5303.893922121574, 5325.467453254682, 5335.306410166692, 5655.462731040545, 5895.55783316253, 5947.791827286024, 5948.881022379572, 5973.283206015306, 6146.86283037635, 6162.352952939967, 6162.7226774795245, 6196.752129914798, 6219.067139929001, 5402.270693456372, 6028.9449346364645, 6147.969260153715, 6197.16338294329, 6198.907016394758, 5979.0, 5996.910046349309, 6006.909896351558, 6011.969940150271, 6029.6683682397015, 6099.207103076572, 6199.814005579839, 6236.844078898064, 6355.618662880242, 6367.076773867763, 6129.083728908156, 6183.81448556544, 6207.34822843604, 6220.502359811204, 6246.250449946036, 6178.443940045418, 6192.195014648067, 6193.473554747807, 6195.628262304276, 6212.81361559154, 6096.786612468542, 6124.724387402489, 6148.78479253224, 6150.846228844314, 6207.6585787782105, 6118.449339559461, 6131.804871721949, 6165.753369865155, 6191.535634827406, 6226.875462490725, 4940.90118197634, 4978.5270399312, 4978.6017118630425, 4993.70037797726, 5017.2223305387, 4477.6417886569, 4478.552144785561, 4508.639308855284, 4519.819207231674, 4547.090581883636, 4841.733704646278, 5540.944590554123, 5839.416058394127, 5907.172995780594, 5976.5218782497295, 6103.3591472894705, 6153.784617538365, 6169.753209871555, 6173.104899789505, 6180.289266734383, 4515.864524064284, 5796.88406231873, 5865.266841644794, 5877.118432235114, 5944.4352786485215, 4465.910681786346, 4624.260118381043, 4666.883327916761, 4731.148393289172, 4853.12643724126, 6236.906446403398, 6458.967705161444, 6468.313061554869, 6500.5449618526245, 6509.609423434609, 5045.772940217626, 6136.335271946791, 6146.938530614637, 6171.9074213887725, 6217.658028808459, 6380.489560835215, 6383.680815959091, 6401.679916004275, 6411.6153030818305, 6438.806835794933, 6199.907001395073, 6201.534884883742, 6225.906611400923, 6229.1590635265475, 6238.0, 6101.694915254308, 6109.586862300737, 6127.403330890903, 6150.04674275488, 6189.690515474118, 4822.541858523435, 6177.876442471215, 6185.938140618537, 6218.968905155445, 6267.5299352549655, 6143.84640383994, 6147.200863887666, 6152.323244443018, 6183.721732521957, 6198.845028874134, 4510.526394728638, 5948.929192745348, 6001.939980600138, 6019.428154325332, 6146.416090471398, 6116.944513560587, 6132.018876979661, 6135.539834512519, 6141.301904043321, 6155.538334625011, 4807.687500312469, 5145.819896303611, 6102.578645452504, 6123.632582045091, 6180.567360284737], "value": 5673.509222683125, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [468.17133673398064, 478.2873518457498, 502.4924825925814, 518.4711594173942, 526.998702465316, 37996.24007519851, 39698.603013969885, 39966.400503992394, 40010.79994600027, 42011.36982945251, 40592.797036014854, 41089.178216435655, 41165.79417102918, 41184.794076029575, 41194.58805411945, 9228.90771092289, 9358.970513243537, 9367.391119577205, 9383.5308234588, 9390.906090939072, 9297.4886381249, 9359.01730318317, 9406.5767040483, 9414.482203478807, 9418.62325506979, 9412.435253884789, 9421.905780942207, 9424.952875235615, 9451.102145296185, 9469.715908522756, 9348.252139828797, 9406.576704048266, 9408.341416100875, 9409.482478463717, 9428.15146636806, 9244.399114057565, 9306.581203845843, 9313.860292095624, 9316.906830931672, 9345.672901448417, 28983.85508072446, 35554.0, 39274.80362598197, 39551.60448395508, 39711.60288397108, 3417.8291085445876, 3476.9652303476896, 3484.0767196692896, 3696.353138200831, 3880.3597406427907, 28115.875364985375, 29541.70458295411, 30130.54804177939, 30389.78440862363, 30517.847410762803, 3111.5177147542167, 3157.4000939821362, 3167.445697003015, 3192.808431494118, 3236.5307030480685, 517671.9999999962, 521898.0, 529058.0, 530026.0, 530606.0, 63172.0, 64004.719905601625, 64014.67992660007, 64138.67930660317, 64223.678881606225, 67247.0, 68202.31797682059, 69143.3085669147, 69367.0, 69677.0, 16457.83542164587, 16553.25510352037, 16699.6660066798, 16795.580110497092, 16806.747898781527, 12599.370031498389, 12668.556600518938, 12776.61670149897, 12800.975921926223, 12811.551595694293, 18934.24263029491, 19976.90011549933, 19994.90002549978, 20031.0, 20084.69872951907, 8164.387670924704, 8191.303739182236, 8191.46755460905, 8207.589620518951, 8229.46508476947, 689.0706023135201, 863.3826813828143, 958.7075941837807, 1054.536004158168, 1128.210252823027, 26244.687765612023, 28650.426991460055, 29775.0, 29930.70069299323, 30363.0, 977.8239916814899, 981.4601968917067, 1003.4631472162358, 1043.3531210649294, 1076.853151393763, 14890.404383824742, 15423.920325577103, 15555.066695998275, 15584.595721914511, 15625.687486250212, 668744.0, 671128.0, 671151.0, 671394.0, 672793.0, 57477.13784293239, 57887.13169302464, 57952.420475795545, 58054.0, 58096.128558071665, 1266.6706656269437, 1314.7962065879804, 1316.414195682912, 1325.3439547424086, 1329.0895736420582, 28844.855775720986, 29098.563521547618, 29441.822327106674, 29940.550891736206, 30185.245368865955, 49322.0, 49957.50042499528, 50052.49947500624, 50146.49853501418, 50235.74410639763, 578626.0, 584055.0, 584637.0, 585150.0, 586120.0, 26673.33316667099, 27100.0, 27561.44877102487, 27591.31021724473, 28424.28939276452, 45820.0, 45901.0, 46125.538744612124, 46335.53664463447, 46376.768116159205, 36267.09332266715, 36662.450063248536, 37397.81301093477, 38292.42561361526, 38430.0, 37452.812735936146, 38077.809610951765, 38656.42015369828, 38702.80648596852, 38735.03162420962, 36107.0, 36371.09072273108, 37241.0, 37342.62657373391, 37444.0, 31786.52320215245, 33344.83327583443, 33813.98558043263, 33825.323493530486, 34098.0, 24719.134830280855, 24901.377465563506, 25270.0, 25565.360865977756, 26243.60634590521], "value": 19944.004658548274, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.97592680548956, 331.170284179906, 331.45475692485877, 369.7300970291685, 400.5793916387792, 18264.99542525162, 19102.04489775511, 19176.137073831676, 19203.231870725172, 19501.512462188453, 18736.812631873676, 18931.62136757264, 19191.904040479778, 19683.60632787347, 19883.60232795343, 5521.696306703119, 5765.596408251424, 5769.336526299467, 5782.653040817543, 5801.07182850744, 4023.0948036691802, 6237.750489980395, 6502.154719886432, 6577.309382514839, 6648.401643852052, 6270.937290627104, 6367.713452894631, 6527.151470308853, 6540.803775886731, 6572.671366431683, 6464.579802312858, 6477.481801455896, 6512.609243445361, 6524.706388212542, 6529.085927970112, 5546.58400619951, 5605.943940560624, 5669.688167150805, 5720.599558030939, 5725.570582206309, 24428.877855610786, 24688.259352219462, 24750.25749227526, 24803.503929921302, 24887.751122488724, 2357.552065107624, 2948.690387509302, 2987.342784587387, 3060.556219348204, 3066.7546596272246, 14803.481878134322, 14855.331510082073, 15022.924885375503, 15216.847831521654, 15783.763243551355, 1581.7390130628548, 1811.2121227266182, 1881.7553718016707, 1902.6289873474677, 1925.2972664977322, 113497.99999999917, 114152.0, 114333.0, 119665.0, 119701.0, 9040.773980650536, 10454.32046916948, 10896.61861834832, 11011.724706882233, 11130.0, 13546.525871594447, 13636.659083522793, 13639.727205455836, 13654.863451365558, 13658.521951731642, 7213.49505534618, 7477.915702223256, 8109.0, 8387.119352467904, 8458.281046111026, 7135.322144396274, 8347.499150050895, 8358.080611132771, 8469.110743371857, 8510.829783404297, 6458.095866578683, 6577.440917521969, 6586.571872828346, 6591.274959754423, 6591.769288074895, 1673.1550566963606, 1792.829681180286, 1800.1989114843768, 1865.2818664813874, 1874.297138573035, 311.54981052379094, 389.18271629578226, 409.1224323825437, 824.5423789796721, 911.8996910339857, 10322.174226061898, 11333.659990200307, 11505.252158609663, 11513.88486115145, 12081.0, 425.0818232617593, 433.42138245442055, 439.23572983009336, 444.391184077809, 469.6313393985705, 5841.853953651108, 5919.852003699856, 6121.571489995657, 6122.051082082285, 6122.142899994004, 594170.0, 616081.0, 625964.0, 633066.0, 644480.0, 134282.0, 136137.0, 136507.0, 137099.31450342885, 138814.30592846972, 407.8966395899086, 429.9419578356882, 443.2044480158124, 934.8878134623889, 1000.4947501511836, 16561.83438165603, 18854.811451885307, 19325.90337048362, 19494.415167544998, 19499.122539485474, 42175.0, 42869.571304287805, 54842.903141937735, 55435.722821385636, 56541.71729141328, 67792.6610366945, 81233.28283813028, 81370.59314703388, 82439.5878020606, 84657.30685386134, 7905.169957154416, 8040.758777236692, 8102.513849169069, 8173.019237691277, 8326.6669333226, 11780.0, 11798.292102473879, 12350.505979761068, 12515.812262815884, 12761.361931903182, 10722.946385268024, 10743.516541755796, 10924.016838484575, 10939.12487001022, 11074.889251107386, 10584.364938103738, 10797.13622910181, 10890.128789696646, 10956.671299861016, 11108.888911110786, 10997.0, 11051.447427628747, 11112.110941140187, 11150.219484635998, 11163.776724465628, 7948.3641308694005, 8048.758537243892, 8291.922050133686, 8306.83386332258, 8366.66533338684, 9363.923148837699, 9669.887962884359, 10835.187360947803, 11166.994970452373, 11282.7743445129], "value": 8981.65543263649, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1232.094410608203, 1401.9439222431104, 1520.429838810446, 1644.7746428910464, 1659.6348803263277, 7483.8877416838795, 7761.883571746414, 8071.7174898878475, 8499.19257670521, 8515.36134789891, 7982.401319901016, 8223.547704876244, 8269.13174116718, 8386.11945745697, 8406.201410865973, 2329.336139200324, 2347.9060837566476, 2355.8350915435926, 2355.893984770681, 2356.587597170488, 2317.9072837086496, 2343.589871772433, 2367.6566897799808, 2384.988075059622, 2386.6181410974245, 2313.248194336839, 2318.2233951626226, 2319.82601304902, 2346.085026839534, 2353.14110349722, 2307.40007598024, 2313.4794671199015, 2332.2769941318074, 2336.754640762721, 2337.5909215887236, 2345.8592484450987, 2363.8581685098948, 2366.8461549999365, 2370.4073981504625, 2372.7034120734907, 8326.417150799447, 8341.83316333676, 8385.580720963988, 8395.286400655952, 8438.535880526568, 4519.389882365905, 5069.822556210515, 5102.132637451642, 5222.112240919015, 5247.370315562119, 3318.2202182487094, 3472.6700963408434, 3595.964040359589, 3596.2627661329366, 3598.0, 869.8173383589453, 992.3450522655013, 1004.1866088468364, 1066.9893301066968, 1104.0780947908506, 10872.945635271852, 10935.015848573586, 10982.890171098346, 10984.615538456115, 11007.229493935427, 4522.3668686383935, 4631.814727410866, 4680.953190468052, 4715.929261061086, 4768.0, 9280.257579393632, 9454.00732923047, 9463.858042129374, 9469.431834089977, 9528.523573821281, 5203.479652034766, 5243.344581927259, 5245.3705555332845, 5250.553702935294, 5250.737463126905, 4281.914361712748, 4296.334068219431, 4717.905641887143, 4775.2359622460235, 4806.543378379049, 3857.72995890285, 3877.689784817208, 3950.7432016919383, 3977.4033894915415, 3985.1631157456677, 1279.4114707234776, 1286.523986125121, 1288.6456224538326, 1297.4550688710765, 1298.1237664576374, 800.7637746864689, 800.9399295052895, 876.2989608313324, 880.4101252161067, 900.1043961258458, 5211.0, 5596.412376700469, 5623.971880140573, 5778.595498315078, 5881.0, 854.8076682746457, 928.252756530999, 944.9480278584743, 948.0756262643868, 975.1516180922642, 3192.457282262021, 3213.742900567949, 3592.209713862946, 3755.5493340798735, 3802.125511132455, 9786.510674466248, 10107.444090575089, 10120.59517619287, 10140.0, 10180.490975451197, 9528.90471095294, 10013.048760367754, 10015.799684006279, 10031.598736050477, 10075.34510256831, 7726.497777644435, 7768.883466748003, 7948.324392426593, 7950.24472675095, 7958.965334506477, 4588.334691469651, 5451.882364115426, 5703.602617358773, 5780.289064412658, 5788.160716695971, 8172.509649421054, 9279.164875161268, 9279.304052195977, 9479.099485548863, 9500.239980801382, 9018.323625727966, 9440.433573985583, 9518.952405238206, 9544.618215271312, 9595.328327017041, 6148.938510615016, 6791.2190098139345, 6872.656367181721, 6945.861082778215, 7183.389411900047, 7415.592142432218, 7418.96290518544, 7427.665755040928, 7960.800979975547, 8038.316743076904, 6727.73089076451, 7188.209296977224, 7189.388901943394, 7243.782686519413, 7323.0, 6127.754889804358, 6149.631022138686, 7111.928880711127, 7138.14342278909, 7156.463265255023, 6597.439217666552, 6663.800085997428, 6714.764983225564, 6719.764808231688, 6727.899081513683, 4833.661643684908, 4854.611631069577, 4867.80528778859, 4870.0746858096845, 4906.852794416173, 4752.976235118802, 4760.976195119002, 4928.063667903087, 4932.7533623319405, 4965.226427914883], "value": 4396.374892127641, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.36120534823397, 300.30629246440725, 306.63663558682964, 308.31092508244086, 311.2002154463031, 4488.0, 5101.6938983661, 5507.366652834915, 5613.522850557702, 5661.545837744969, 4731.380493922144, 5499.835004949848, 5510.6969116698565, 5535.723213839312, 5577.44225577442, 3512.5258090157886, 4068.5321188063454, 4074.5925407459313, 4080.7553696122745, 4281.8073186706515, 3914.2171565686835, 4123.989622542481, 4223.450951376317, 4274.589385502776, 4280.914381712364, 3617.3488772021024, 4092.7339722917914, 4116.58834116589, 4134.317837556815, 4135.648469880064, 3374.4432168692138, 3596.2627661329498, 4045.676345892351, 4129.070959034223, 4154.543000269998, 3604.2250916052913, 3605.603383627799, 3609.530761001079, 3619.2808416002454, 3642.271545690846, 4287.656987440997, 4365.759883206422, 4386.385905973167, 4462.1744977179005, 4951.3810773653295, 3892.299386110499, 3904.882853514399, 4463.821447142111, 4596.264597664358, 4620.0, 4985.426675932278, 5204.921926171072, 5810.7385167667135, 5816.534677225812, 5835.9708201458725, 3487.2851065531504, 3560.6647507184807, 3865.091703449687, 3911.5892831252595, 3947.4670919426085, 4977.104121258172, 5081.949180508222, 6104.786332478387, 6127.234095738033, 6154.9076763849025, 3380.2901390707734, 3772.698419045425, 3970.861019864291, 3997.520297564311, 4009.3184158693093, 3892.3577609694084, 3991.4012898064943, 4051.817668204938, 4057.878263652095, 4078.7552746835286, 3930.30996671434, 4652.55800698933, 4659.930101048487, 4676.532346765296, 4678.6491013174145, 4694.197699863122, 5383.892322153613, 5877.23595932526, 5883.735231914574, 5906.822795316148, 1152.5620264299512, 1264.9494020239088, 1285.2609749394135, 1301.4794082366939, 1312.0, 804.4730701390598, 862.2929198057533, 873.8820259265045, 889.9555022248861, 900.4552245891141, 4309.96560825406, 5104.412992505835, 5225.216217567319, 5254.65844720092, 5269.920951185735, 5732.627379220421, 5749.597528172988, 5771.249737534094, 5772.62477938941, 5828.067509198508, 4263.744175349489, 4557.794899229476, 4811.639127065484, 4932.755596203719, 5216.426193118754, 2438.305083051322, 2898.94188621156, 2930.164903002634, 2985.3730716549335, 3008.36824266902, 5174.689518628894, 5509.228707980886, 5885.764569417261, 5915.556333274935, 6016.759329626853, 4863.765595878772, 5255.894882102413, 5568.777248909998, 5661.575381846378, 5859.970700146472, 5306.893862122736, 5969.373215812364, 5986.161937328778, 6001.639901605918, 6028.854517641634, 4655.6973796703105, 4930.901381972269, 5754.7339585291165, 5821.3118195724455, 5824.330202026821, 4419.734815910927, 4977.850664480072, 5307.575393968396, 5664.745086471036, 5972.8805423892145, 5256.9737151314, 5539.1443866305235, 5809.506191973561, 6029.60807547508, 6033.306169790355, 3196.633676962433, 3593.0, 3789.006684719041, 3799.6960243181034, 3812.6759225466144, 5296.947030529799, 5654.7842213924205, 5702.971485142548, 5719.456651618089, 5789.768409263751, 4952.4304704959395, 4987.852793857361, 5798.217240672455, 5868.471837534642, 5884.440978107073, 4959.82640607577, 5847.684271038982, 5855.560832937462, 5858.7070646468355, 5860.560457965755, 5513.195894832553, 5762.7694892203845, 5767.183337248754, 5810.791899078492, 5860.648361098348, 5349.411564727799, 5487.00957977895, 5638.252141836044, 5961.0, 6021.488173505301, 4898.412190537016, 5563.471470210324, 5654.46282603152, 5919.171316015675, 5925.792597259076], "value": 4090.578198238685, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [727.3889932456735, 731.7256028989129, 732.1324230786519, 756.4591317208202, 776.0725932510649, 14364.281785910714, 14406.711865762678, 14864.628384290398, 14872.107673539595, 15050.096994180356, 12626.926711229533, 13423.060385773, 13475.865241347583, 13562.389692463837, 13659.112157709767, 633.6071635585943, 793.0364607002491, 799.6801279488193, 801.5150833745587, 802.0695992648529, 776.1113525013856, 783.725696006399, 785.1559573458526, 785.7328508307174, 786.3866184376195, 830.6760363458226, 838.4843321357351, 843.085252501034, 843.6372359885247, 844.3920377328313, 827.4125370986607, 832.2634468495364, 835.2733122183678, 837.5728378526934, 841.146236569882, 620.4075108271635, 620.88203241384, 621.2606997672755, 621.3475850357152, 622.470899735226, 12381.133320667557, 12406.62780116598, 12441.253524788543, 12477.875221247763, 12593.622191334274, 11527.13546484017, 11547.711307217303, 11564.248323858923, 11657.883421165765, 11816.46825892837, 10099.949500252525, 10128.0, 10257.948710256476, 10332.276740628158, 10430.322029068086, 3377.5778027746533, 3576.910577235564, 3598.226381328001, 3600.2979419013304, 3699.075231192202, 91480.0, 91883.08116918812, 91906.54046729724, 92323.0, 92563.53718231365, 8417.537035462985, 8444.408891377545, 8780.385373023826, 8839.16027977341, 8842.557872106368, 18264.726029109574, 18524.0737963104, 18557.721634175497, 18669.0, 18676.06619669011, 7540.0, 7570.0, 7600.771976840703, 7789.260020298063, 7894.763157105296, 4061.3298805696727, 4193.182329445729, 4212.726172798758, 4273.423087883159, 4375.949772054684, 3348.3303339332233, 3453.689167974844, 3463.0130412832223, 3463.809490478048, 3466.185446420089, 615.7721642992032, 648.3743187823773, 649.1885143570537, 660.131926516629, 662.5891946992896, 533.3493138371181, 562.3336346429494, 566.8696199874053, 581.3693038998565, 622.6637615687569, 8337.541435221, 9024.36829421934, 9072.8639070414, 9086.500242486594, 9491.383060101209, 582.9387914269025, 615.4122812713847, 620.3579295429209, 653.3531803514486, 659.5020759326774, 3481.7496139389277, 3557.857685692595, 4425.911481770411, 4455.398521199661, 4483.193025255486, 116210.41894790472, 118597.0, 118825.40587297008, 120924.0, 121372.0, 59837.803243934875, 69772.95340569895, 81267.59366203132, 93454.0, 107124.0, 56703.86592268132, 64994.0, 70636.64681676558, 75076.62461687656, 82061.35877282421, 9177.831729760384, 9391.342606017513, 9493.857592135986, 9553.331266811534, 9620.182284505616, 49537.0, 51045.23432148595, 52375.0, 52840.73579632077, 54177.45822541724, 70307.64846175736, 72118.63940680263, 78083.60958195172, 78339.0, 78622.21377786149, 11973.401329933642, 11987.820182697442, 12062.0, 12371.195872268274, 12495.687607809878, 13414.664633384244, 13469.259190744604, 13647.385867635781, 13801.51694690681, 14486.420543178576, 12402.00783937301, 12403.317817520123, 12880.098393112392, 13434.68479628952, 13529.797053044016, 12943.676408089874, 13075.215487070805, 13084.411201495765, 13627.386767595284, 13681.726365472834, 12821.743565128458, 12879.227246365248, 13081.149725267827, 13363.799543006668, 13439.596812095653, 8868.11318868108, 10720.35677859331, 10730.356178629307, 10843.0, 11022.614208502664, 9580.281478888972, 10746.570137194738, 10976.0, 11037.558497660324, 11574.421278935852], "value": 7031.293858922012, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1547.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 144.0, 156.0, 117.0, 118.0, 118.0, 121.0, 177.0, 138.0, 119.0], "value": 131.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 110.0, 97.0, 180.0, 101.0, 150.0, 146.0, 141.0, 152.0, 110.0], "value": 134.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 200.0, 198.0, 197.0, 196.0, 195.0, 196.0, 198.0, 199.0, 196.0], "value": 196.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 60.0, 62.0, 87.0, 60.0, 60.0, 60.0, 63.0, 96.0, 84.0], "value": 71.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 72.0, 89.0, 71.0, 69.0, 73.0, 86.0, 70.0, 71.0, 88.0], "value": 77.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 105.0, 122.0, 91.0, 96.0, 120.0, 94.0, 91.0, 94.0, 104.0], "value": 101.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 153.0, 127.0, 98.0, 133.0, 151.0, 100.0, 99.0, 98.0, 100.0], "value": 115.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 88.0, 84.0, 93.0, 84.0, 91.0, 93.0, 109.0, 117.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 52.0, 53.0, 62.0, 61.0, 60.0, 62.0, 61.0, 61.0], "value": 58.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 70.0, 96.0, 92.0, 101.0, 104.0, 103.0, 73.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 80.0, 86.0, 70.0, 98.0, 79.0, 84.0, 102.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 155.0, 150.0, 140.0, 146.0, 142.0, 146.0, 169.0, 217.0, 181.0], "value": 158.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 168.0, 188.0, 173.0, 159.0, 168.0, 170.0, 153.0, 159.0, 145.0], "value": 165.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 67.0, 67.0, 70.0, 70.0, 73.0, 72.0, 72.0, 80.0], "value": 71.0, "unit": "score"}]}]} 10:47:07 INFO - Return code: 0 10:47:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:47:07 ERROR - # TBPL SUCCESS # 10:47:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:47:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:47:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:47:07 INFO - 2016-12-22 10:47:07.962 screenresolution[1654:10943] starting screenresolution argv=screenresolution get 10:47:07 INFO - 2016-12-22 10:47:07.965 screenresolution[1654:10943] Display 0: 1600x1200x32@60 10:47:07 INFO - 2016-12-22 10:47:07.971 screenresolution[1655:10946] starting screenresolution argv=screenresolution list 10:47:07 INFO - Available Modes on Display 0 10:47:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:47:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:47:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:47:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:47:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:47:08 INFO - Intel Iris: 10:47:08 INFO - Chipset Model: Intel Iris 10:47:08 INFO - Type: GPU 10:47:08 INFO - Bus: Built-In 10:47:08 INFO - VRAM (Dynamic, Max): 1536 MB 10:47:08 INFO - Vendor: Intel (0x8086) 10:47:08 INFO - Device ID: 0x0a2e 10:47:08 INFO - Revision ID: 0x0009 10:47:08 INFO - Displays: 10:47:08 INFO - Display: 10:47:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:47:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:47:08 INFO - Display Serial Number: 1600x1200 60 10:47:08 INFO - Main Display: Yes 10:47:08 INFO - Mirror: Off 10:47:08 INFO - Online: Yes 10:47:08 INFO - Rotation: Supported 10:47:08 INFO - Return code: 0 10:47:08 INFO - Running post-action listener: _resource_record_post_action 10:47:08 INFO - [mozharness: 2016-12-22 18:47:08.206616Z] Finished run-tests step (success) 10:47:08 INFO - Running post-run listener: _resource_record_post_run 10:47:08 INFO - Total resource usage - Wall time: 1212s; CPU: 55.0%; Read bytes: 39733760; Write bytes: 660839424; Read time: 392; Write time: 2458 10:47:08 INFO - TinderboxPrint: CPU usage
54.6% 10:47:08 INFO - TinderboxPrint: I/O read bytes / time
39,733,760 / 392 10:47:08 INFO - TinderboxPrint: I/O write bytes / time
660,839,424 / 2,458 10:47:08 INFO - TinderboxPrint: CPU idle
2,202.1 (45.4%) 10:47:08 INFO - TinderboxPrint: CPU system
983.4 (20.3%) 10:47:08 INFO - TinderboxPrint: CPU user
1,664.1 (34.3%) 10:47:08 INFO - TinderboxPrint: Swap in / out
388,206,592 / 0 10:47:08 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 344152576; Write bytes: 345118720; Read time: 27383; Write time: 695 10:47:08 INFO - run-tests - Wall time: 1181s; CPU: 55.0%; Read bytes: 37894656; Write bytes: 308823040; Read time: 373; Write time: 1736 10:47:08 INFO - Running post-run listener: _upload_blobber_files 10:47:08 INFO - Blob upload gear active. 10:47:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:47:08 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 10:47:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:47:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:47:09 INFO - (blobuploader) - INFO - Open directory for files ... 10:47:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:47:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:47:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:47:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:47:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:47:10 INFO - (blobuploader) - INFO - Done attempting. 10:47:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:47:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:47:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:47:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:47:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:47:11 INFO - (blobuploader) - INFO - Done attempting. 10:47:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:47:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:47:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:47:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:47:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:47:14 INFO - (blobuploader) - INFO - Done attempting. 10:47:14 INFO - (blobuploader) - INFO - Iteration through files over. 10:47:14 INFO - Return code: 0 10:47:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:47:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:47:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1ee71b1a829151dbb291423ec6dcb940315ef1764962bee207b47c78b1e75f2d6cc8842abb3c3c37bbcfa04b91cfc59f402f4b8e948c52c16b008d70801410ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8521f16ff589e659415d0189f16dc9db628ac7d13c0146b9c75516aa4ee5cd42bf24c707db8b0907c2bf7dea02506c894ea0a1de8fff77f347bafc592cea5f7f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f1b7e5410a499320f251cfaa15f3a7580221fba2377d42f7e7e7f43a4926fd84d4006bf6ec08820e95b11cecccac891579bb3051e503ab457eaf0cec8005173e"} 10:47:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:47:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:47:14 INFO - Contents: 10:47:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1ee71b1a829151dbb291423ec6dcb940315ef1764962bee207b47c78b1e75f2d6cc8842abb3c3c37bbcfa04b91cfc59f402f4b8e948c52c16b008d70801410ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8521f16ff589e659415d0189f16dc9db628ac7d13c0146b9c75516aa4ee5cd42bf24c707db8b0907c2bf7dea02506c894ea0a1de8fff77f347bafc592cea5f7f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f1b7e5410a499320f251cfaa15f3a7580221fba2377d42f7e7e7f43a4926fd84d4006bf6ec08820e95b11cecccac891579bb3051e503ab457eaf0cec8005173e"} 10:47:14 INFO - Running post-run listener: copy_logs_to_upload_dir 10:47:14 INFO - Copying logs to upload dir... 10:47:14 INFO - mkdir: /builds/slave/test/build/upload/logs 10:47:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.507723 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-12-22 10:47:14.186776) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 10:47:14.192115) ========= 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.hHhUgHbhn6/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.nyEJQ9NKaa/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1ee71b1a829151dbb291423ec6dcb940315ef1764962bee207b47c78b1e75f2d6cc8842abb3c3c37bbcfa04b91cfc59f402f4b8e948c52c16b008d70801410ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8521f16ff589e659415d0189f16dc9db628ac7d13c0146b9c75516aa4ee5cd42bf24c707db8b0907c2bf7dea02506c894ea0a1de8fff77f347bafc592cea5f7f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f1b7e5410a499320f251cfaa15f3a7580221fba2377d42f7e7e7f43a4926fd84d4006bf6ec08820e95b11cecccac891579bb3051e503ab457eaf0cec8005173e"} build_url:https://queue.taskcluster.net/v1/task/X-WoevjwTyuzeF-sak0Saw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010990 build_url: 'https://queue.taskcluster.net/v1/task/X-WoevjwTyuzeF-sak0Saw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1ee71b1a829151dbb291423ec6dcb940315ef1764962bee207b47c78b1e75f2d6cc8842abb3c3c37bbcfa04b91cfc59f402f4b8e948c52c16b008d70801410ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8521f16ff589e659415d0189f16dc9db628ac7d13c0146b9c75516aa4ee5cd42bf24c707db8b0907c2bf7dea02506c894ea0a1de8fff77f347bafc592cea5f7f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f1b7e5410a499320f251cfaa15f3a7580221fba2377d42f7e7e7f43a4926fd84d4006bf6ec08820e95b11cecccac891579bb3051e503ab457eaf0cec8005173e"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 10:47:14.231501) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 10:47:14.234840) ========= 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.hHhUgHbhn6/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.nyEJQ9NKaa/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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.005085 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 10:47:14.283412) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 10:47:14.286742) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 10:47:14.287051) ========= ========= Total master_lag: 0.24 =========