builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0025 starttime: 1484025216.54 results: success (0) buildid: 20170109201208 builduid: 9498fab751f84ebb8bace0e92c0c5966 revision: 9e93163b43f8dd2b7a2a7191dac910ae1259c0e8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 21:13:36.544710) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 21:13:36.545222) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 21:13:36.545517) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 21:13:36.572969) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 21:13:36.573357) ========= 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.sTy2lP05LE/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.8jSyTwY8sf/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-09 21:13:36-- 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% 194M=0s 2017-01-09 21:13:37 (194 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.621132 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 21:13:37.218464) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 21:13:37.218801) ========= 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.sTy2lP05LE/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.8jSyTwY8sf/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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.026346 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 21:13:37.274704) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 21:13:37.275053) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9e93163b43f8dd2b7a2a7191dac910ae1259c0e8 --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 9e93163b43f8dd2b7a2a7191dac910ae1259c0e8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sTy2lP05LE/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.8jSyTwY8sf/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-09 21:13:37,368 truncating revision to first 12 chars 2017-01-09 21:13:37,368 Setting DEBUG logging. 2017-01-09 21:13:37,369 attempt 1/10 2017-01-09 21:13:37,369 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9e93163b43f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-09 21:13:37,996 unpacking tar archive at: mozilla-aurora-9e93163b43f8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.900154 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 21:13:38.198950) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 21:13:38.199257) ========= script_repo_revision: 9e93163b43f8dd2b7a2a7191dac910ae1259c0e8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 21:13:38.199698) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 21:13:38.199972) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 21:13:38.219757) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2017-01-09 21:13:38.220160) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.sTy2lP05LE/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.8jSyTwY8sf/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 21:13:38 INFO - MultiFileLogger online at 20170109 21:13:38 in /builds/slave/test 21:13:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 21:13:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:13:38 INFO - {'append_to_log': False, 21:13:38 INFO - 'base_work_dir': '/builds/slave/test', 21:13:38 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 21:13:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:13:38 INFO - 'branch': 'Mozilla-Aurora', 21:13:38 INFO - 'buildbot_json_path': 'buildprops.json', 21:13:38 INFO - 'config_files': ('talos/mac_config.py',), 21:13:38 INFO - 'default_actions': ('clobber', 21:13:38 INFO - 'read-buildbot-config', 21:13:38 INFO - 'download-and-extract', 21:13:38 INFO - 'populate-webroot', 21:13:38 INFO - 'create-virtualenv', 21:13:38 INFO - 'install', 21:13:38 INFO - 'run-tests'), 21:13:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:13:38 INFO - 'download_minidump_stackwalk': True, 21:13:38 INFO - 'download_symbols': 'ondemand', 21:13:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:13:38 INFO - 'tooltool.py': '/tools/tooltool.py', 21:13:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:13:38 INFO - '/tools/misc-python/virtualenv.py')}, 21:13:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:13:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:13:38 INFO - 'installer_path': 'installer.exe', 21:13:38 INFO - 'log_level': 'info', 21:13:38 INFO - 'log_name': 'talos', 21:13:38 INFO - 'log_to_console': True, 21:13:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:13:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:13:38 INFO - 'opt_config_files': (), 21:13:38 INFO - 'pip_index': False, 21:13:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:13:38 INFO - 'cmd': ('bash', 21:13:38 INFO - '-c', 21:13:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:13:38 INFO - 'enabled': True, 21:13:38 INFO - 'halt_on_failure': False, 21:13:38 INFO - 'name': 'check_screen_resolution'},), 21:13:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:13:38 INFO - 'cmd': ('bash', 21:13:38 INFO - '-c', 21:13:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:13:38 INFO - 'enabled': True, 21:13:38 INFO - 'halt_on_failure': False, 21:13:38 INFO - 'name': 'check_screen_resolution'},), 21:13:38 INFO - 'run_cmd_checks_enabled': True, 21:13:38 INFO - 'sps_profile': False, 21:13:38 INFO - 'sps_profile_interval': 0, 21:13:38 INFO - 'suite': 'dromaeojs', 21:13:38 INFO - 'system_bits': '32', 21:13:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:13:38 INFO - 'title': 't-yosemite-r7-0025', 21:13:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:13:38 INFO - 'use_talos_json': True, 21:13:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:13:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:13:38 INFO - 'work_dir': 'build'} 21:13:38 INFO - [mozharness: 2017-01-10 05:13:38.428919Z] Running clobber step. 21:13:38 INFO - Running pre-action listener: _resource_record_pre_action 21:13:38 INFO - Running main action method: clobber 21:13:38 INFO - rmtree: /builds/slave/test/build 21:13:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:13:40 INFO - Running post-action listener: _resource_record_post_action 21:13:40 INFO - [mozharness: 2017-01-10 05:13:40.801091Z] Finished clobber step (success) 21:13:40 INFO - [mozharness: 2017-01-10 05:13:40.801167Z] Running read-buildbot-config step. 21:13:40 INFO - Running pre-action listener: _resource_record_pre_action 21:13:40 INFO - Running main action method: read_buildbot_config 21:13:40 INFO - Using buildbot properties: 21:13:40 INFO - { 21:13:40 INFO - "project": "", 21:13:40 INFO - "product": "firefox", 21:13:40 INFO - "script_repo_revision": "production", 21:13:40 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 21:13:40 INFO - "repository": "", 21:13:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 21:13:40 INFO - "buildid": "20170109201208", 21:13:40 INFO - "pgo_build": "False", 21:13:40 INFO - "basedir": "/builds/slave/test", 21:13:40 INFO - "buildnumber": 19, 21:13:40 INFO - "slavename": "t-yosemite-r7-0025", 21:13:40 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 21:13:40 INFO - "platform": "yosemite_r7", 21:13:40 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 21:13:40 INFO - "branch": "mozilla-aurora", 21:13:40 INFO - "repo_path": "releases/mozilla-aurora", 21:13:40 INFO - "revision": "9e93163b43f8dd2b7a2a7191dac910ae1259c0e8", 21:13:40 INFO - "stage_platform": "macosx64", 21:13:40 INFO - "builduid": "9498fab751f84ebb8bace0e92c0c5966", 21:13:40 INFO - "slavebuilddir": "test" 21:13:40 INFO - } 21:13:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/HqIf4kSiTxSu_98az9YCCw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 21:13:40 INFO - Running post-action listener: _resource_record_post_action 21:13:40 INFO - [mozharness: 2017-01-10 05:13:40.804376Z] Finished read-buildbot-config step (success) 21:13:40 INFO - [mozharness: 2017-01-10 05:13:40.804482Z] Running download-and-extract step. 21:13:40 INFO - Running pre-action listener: _resource_record_pre_action 21:13:40 INFO - Running main action method: download_and_extract 21:13:40 INFO - mkdir: /builds/slave/test/build/tests 21:13:40 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')]} 21:13:40 INFO - trying https://queue.taskcluster.net/v1/task/HqIf4kSiTxSu_98az9YCCw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 21:13:40 INFO - Downloading https://queue.taskcluster.net/v1/task/HqIf4kSiTxSu_98az9YCCw/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 21:13:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HqIf4kSiTxSu_98az9YCCw/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 21:13:42 INFO - Downloaded 1199 bytes. 21:13:42 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 21:13:42 INFO - Using the following test package requirements: 21:13:42 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 21:13:42 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 21:13:42 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 21:13:42 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 21:13:42 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 21:13:42 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 21:13:42 INFO - u'jsshell-mac.zip'], 21:13:42 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 21:13:42 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 21:13:42 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 21:13:42 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 21:13:42 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 21:13:42 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 21:13:42 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 21:13:42 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 21:13:42 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 21:13:42 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 21:13:42 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 21:13:42 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 21:13:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HqIf4kSiTxSu_98az9YCCw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 21:13:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HqIf4kSiTxSu_98az9YCCw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 21:13:42 INFO - Fetch https://queue.taskcluster.net/v1/task/HqIf4kSiTxSu_98az9YCCw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 21:13:42 INFO - Http code: 200 21:13:42 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 21:13:42 INFO - x-amz-cf-id: pEKtcd_PxUw5aVX5Jz839xYCsiCK8U3qAKsT6PBJyeHQGmzj8JSF6Q== 21:13:42 INFO - x-amz-version-id: ekguY7I288Gbzdwg1X7EsLVIOAaLK5ZY 21:13:42 INFO - Expected file size: 16271253 21:13:42 INFO - Obtained file size: 16271253 21:13:49 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 21:13:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HqIf4kSiTxSu_98az9YCCw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 21:13:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HqIf4kSiTxSu_98az9YCCw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 21:13:49 INFO - Fetch https://queue.taskcluster.net/v1/task/HqIf4kSiTxSu_98az9YCCw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 21:13:50 INFO - Http code: 200 21:13:50 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 21:13:50 INFO - x-amz-cf-id: yyIm5PqYCmydEkqktmo92o119J0qxB7rl1m_epVn9TwZ39Sk5b8YQw== 21:13:50 INFO - x-amz-version-id: ekguY7I288Gbzdwg1X7EsLVIOAaLK5ZY 21:13:50 INFO - Expected file size: 16271253 21:13:50 INFO - Obtained file size: 16271253 21:13:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HqIf4kSiTxSu_98az9YCCw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 21:13:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HqIf4kSiTxSu_98az9YCCw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 21:13:56 INFO - Fetch https://queue.taskcluster.net/v1/task/HqIf4kSiTxSu_98az9YCCw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 21:13:57 INFO - Http code: 200 21:13:57 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 21:13:57 INFO - x-amz-cf-id: cUgCIrIepB_kpR2tflxIB4kIXpcgdgIWssj0w1JKvHvqT10IbmgsFA== 21:13:57 INFO - x-amz-version-id: EY1pu4BHVXzm44Ixhr5woM6TG6PGqHvH 21:13:58 INFO - Expected file size: 14409038 21:13:58 INFO - Obtained file size: 14409038 21:13:58 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')]} 21:13:58 INFO - trying https://queue.taskcluster.net/v1/task/HqIf4kSiTxSu_98az9YCCw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 21:13:58 INFO - Downloading https://queue.taskcluster.net/v1/task/HqIf4kSiTxSu_98az9YCCw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 21:13:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HqIf4kSiTxSu_98az9YCCw/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 21:14:01 INFO - Downloaded 109878436 bytes. 21:14:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HqIf4kSiTxSu_98az9YCCw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 21:14:01 INFO - mkdir: /builds/slave/test/properties 21:14:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:14:01 INFO - Writing to file /builds/slave/test/properties/build_url 21:14:01 INFO - Contents: 21:14:01 INFO - build_url:https://queue.taskcluster.net/v1/task/HqIf4kSiTxSu_98az9YCCw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 21:14:01 INFO - Running post-action listener: _resource_record_post_action 21:14:01 INFO - Running post-action listener: set_extra_try_arguments 21:14:01 INFO - [mozharness: 2017-01-10 05:14:01.984652Z] Finished download-and-extract step (success) 21:14:01 INFO - [mozharness: 2017-01-10 05:14:01.984777Z] Running populate-webroot step. 21:14:01 INFO - Running pre-action listener: _resource_record_pre_action 21:14:01 INFO - Running main action method: populate_webroot 21:14:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:14:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:14:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:14:01 INFO - '--tppagecycles', 21:14:01 INFO - '7'], 21:14:01 INFO - 'tests': ['tsvgm']}}, 21:14:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:14:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:14:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:14:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:14:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:14:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:14:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:14:01 INFO - 'talos_options': ['--disable-e10s'], 21:14:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:14:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:14:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:14:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:14:01 INFO - 'talos_options': ['--disable-e10s'], 21:14:01 INFO - 'tests': ['damp', 'tps']}, 21:14:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:14:01 INFO - 'tests': ['damp', 'tps']}, 21:14:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:14:01 INFO - 'tests': ['dromaeo_dom']}, 21:14:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:14:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:14:01 INFO - 'tests': ['basic_compositor_video']}, 21:14:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:14:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:14:01 INFO - 'tests': ['a11yr', 21:14:01 INFO - 'ts_paint', 21:14:01 INFO - 'tpaint', 21:14:01 INFO - 'sessionrestore', 21:14:01 INFO - 'sessionrestore_no_auto_restore', 21:14:01 INFO - 'tabpaint']}, 21:14:01 INFO - 'other-e10s': {'tests': ['a11yr', 21:14:01 INFO - 'ts_paint', 21:14:01 INFO - 'tpaint', 21:14:01 INFO - 'sessionrestore', 21:14:01 INFO - 'sessionrestore_no_auto_restore', 21:14:01 INFO - 'tabpaint']}, 21:14:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:14:01 INFO - 'ts_paint', 21:14:01 INFO - 'tpaint', 21:14:01 INFO - 'sessionrestore', 21:14:01 INFO - 'sessionrestore_no_auto_restore', 21:14:01 INFO - 'tabpaint']}, 21:14:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:14:01 INFO - 'ts_paint', 21:14:01 INFO - 'tpaint', 21:14:01 INFO - 'sessionrestore', 21:14:01 INFO - 'sessionrestore_no_auto_restore', 21:14:01 INFO - 'tabpaint']}, 21:14:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:14:01 INFO - 'tests': ['a11yr', 21:14:01 INFO - 'ts_paint', 21:14:01 INFO - 'tpaint', 21:14:01 INFO - 'sessionrestore', 21:14:01 INFO - 'sessionrestore_no_auto_restore', 21:14:02 INFO - 'tabpaint']}, 21:14:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:14:02 INFO - 'tests': ['a11yr', 21:14:02 INFO - 'ts_paint', 21:14:02 INFO - 'tpaint', 21:14:02 INFO - 'sessionrestore', 21:14:02 INFO - 'sessionrestore_no_auto_restore', 21:14:02 INFO - 'tabpaint']}, 21:14:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:14:02 INFO - 'tests': ['tsvgx', 21:14:02 INFO - 'tsvgr_opacity', 21:14:02 INFO - 'tart', 21:14:02 INFO - 'tscrollx', 21:14:02 INFO - 'cart']}, 21:14:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:14:02 INFO - 'tsvgr_opacity', 21:14:02 INFO - 'tart', 21:14:02 INFO - 'tscrollx', 21:14:02 INFO - 'cart']}, 21:14:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:14:02 INFO - 'talos_options': ['--disable-e10s'], 21:14:02 INFO - 'tests': ['tp5o']}, 21:14:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:14:02 INFO - 'tests': ['tp5o']}, 21:14:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:14:02 INFO - 'talos_options': ['--disable-e10s', 21:14:02 INFO - '--xperf_path', 21:14:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:14:02 INFO - 'tests': ['tp5n']}, 21:14:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:14:02 INFO - 'talos_options': ['--xperf_path', 21:14:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:14:02 INFO - 'tests': ['tp5n']}}, 21:14:02 INFO - 'talos.zip': {'path': '', 21:14:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:14:02 INFO - Running post-action listener: _resource_record_post_action 21:14:02 INFO - [mozharness: 2017-01-10 05:14:02.003861Z] Finished populate-webroot step (success) 21:14:02 INFO - [mozharness: 2017-01-10 05:14:02.003977Z] Running create-virtualenv step. 21:14:02 INFO - Running pre-action listener: _resource_record_pre_action 21:14:02 INFO - Running main action method: create_virtualenv 21:14:02 INFO - Creating virtualenv /builds/slave/test/build/venv 21:14:02 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 21:14:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:14:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:14:02 INFO - Using real prefix '/tools/python27' 21:14:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:14:02 INFO - Installing distribute.............................................................................................................................................................................................done. 21:14:05 INFO - Installing pip.................done. 21:14:05 INFO - Return code: 0 21:14:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:14:06 INFO - Reading from file tmpfile_stdout 21:14:06 INFO - Output received: 21:14:06 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) 21:14:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:06 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 0x110433490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103a9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb51ada01b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110247d30>, '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 0x1100addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11023fb20>, '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.sTy2lP05LE/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.8jSyTwY8sf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 21:14:06 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 21:14:06 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 21:14:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sTy2lP05LE/Render', 21:14:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:06 INFO - 'HOME': '/Users/cltbld', 21:14:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:06 INFO - 'LOGNAME': 'cltbld', 21:14:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:06 INFO - 'MOZ_NO_REMOTE': '1', 21:14:06 INFO - 'NO_EM_RESTART': '1', 21:14:06 INFO - 'PAGER': '/bin/cat', 21:14:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:06 INFO - 'PWD': '/builds/slave/test', 21:14:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:06 INFO - 'SHELL': '/bin/bash', 21:14:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8jSyTwY8sf/Listeners', 21:14:06 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 21:14:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:06 INFO - 'USER': 'cltbld', 21:14:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:06 INFO - 'XPC_FLAGS': '0x0', 21:14:06 INFO - 'XPC_SERVICE_NAME': '0', 21:14:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:06 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 21:14:06 INFO - Cleaning up... 21:14:06 INFO - Return code: 0 21:14:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:06 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 0x110433490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103a9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb51ada01b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110247d30>, '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 0x1100addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11023fb20>, '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.sTy2lP05LE/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.8jSyTwY8sf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 21:14:06 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 21:14:06 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 21:14:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sTy2lP05LE/Render', 21:14:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:06 INFO - 'HOME': '/Users/cltbld', 21:14:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:06 INFO - 'LOGNAME': 'cltbld', 21:14:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:06 INFO - 'MOZ_NO_REMOTE': '1', 21:14:06 INFO - 'NO_EM_RESTART': '1', 21:14:06 INFO - 'PAGER': '/bin/cat', 21:14:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:06 INFO - 'PWD': '/builds/slave/test', 21:14:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:06 INFO - 'SHELL': '/bin/bash', 21:14:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8jSyTwY8sf/Listeners', 21:14:06 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 21:14:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:06 INFO - 'USER': 'cltbld', 21:14:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:06 INFO - 'XPC_FLAGS': '0x0', 21:14:06 INFO - 'XPC_SERVICE_NAME': '0', 21:14:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:06 INFO - Downloading/unpacking psutil>=3.1.1 21:14:06 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 21:14:06 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 21:14:06 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 21:14:06 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 21:14:06 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 21:14:06 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 21:14:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:14:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:14:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:14:10 INFO - Installing collected packages: psutil 21:14:10 INFO - Running setup.py install for psutil 21:14:10 INFO - building 'psutil._psutil_osx' extension 21:14:10 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 21:14:11 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 21:14:11 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 21:14:11 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 21:14:11 INFO - building 'psutil._psutil_posix' extension 21:14:11 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 21:14:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:14:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:14:11 INFO - ^ 21:14:11 INFO - 1 warning generated. 21:14:11 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 21:14:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:14:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:14:11 INFO - Successfully installed psutil 21:14:11 INFO - Cleaning up... 21:14:11 INFO - Return code: 0 21:14:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:11 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 0x110433490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103a9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb51ada01b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110247d30>, '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 0x1100addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11023fb20>, '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.sTy2lP05LE/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.8jSyTwY8sf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 21:14:11 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 21:14:11 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 21:14:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sTy2lP05LE/Render', 21:14:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:11 INFO - 'HOME': '/Users/cltbld', 21:14:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:11 INFO - 'LOGNAME': 'cltbld', 21:14:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:11 INFO - 'MOZ_NO_REMOTE': '1', 21:14:11 INFO - 'NO_EM_RESTART': '1', 21:14:11 INFO - 'PAGER': '/bin/cat', 21:14:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:11 INFO - 'PWD': '/builds/slave/test', 21:14:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:11 INFO - 'SHELL': '/bin/bash', 21:14:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8jSyTwY8sf/Listeners', 21:14:11 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 21:14:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:11 INFO - 'USER': 'cltbld', 21:14:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:11 INFO - 'XPC_FLAGS': '0x0', 21:14:11 INFO - 'XPC_SERVICE_NAME': '0', 21:14:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:14:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:14:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:14:14 INFO - Installing collected packages: mozsystemmonitor 21:14:14 INFO - Running setup.py install for mozsystemmonitor 21:14:15 INFO - Successfully installed mozsystemmonitor 21:14:15 INFO - Cleaning up... 21:14:15 INFO - Return code: 0 21:14:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110433490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103a9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb51ada01b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110247d30>, '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 0x1100addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11023fb20>, '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.sTy2lP05LE/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.8jSyTwY8sf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 21:14:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:14:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:14:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sTy2lP05LE/Render', 21:14:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:15 INFO - 'HOME': '/Users/cltbld', 21:14:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:15 INFO - 'LOGNAME': 'cltbld', 21:14:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:15 INFO - 'MOZ_NO_REMOTE': '1', 21:14:15 INFO - 'NO_EM_RESTART': '1', 21:14:15 INFO - 'PAGER': '/bin/cat', 21:14:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:15 INFO - 'PWD': '/builds/slave/test', 21:14:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:15 INFO - 'SHELL': '/bin/bash', 21:14:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8jSyTwY8sf/Listeners', 21:14:15 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 21:14:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:15 INFO - 'USER': 'cltbld', 21:14:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:15 INFO - 'XPC_FLAGS': '0x0', 21:14:15 INFO - 'XPC_SERVICE_NAME': '0', 21:14:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:15 INFO - Downloading/unpacking jsonschema==2.5.1 21:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:14:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:18 INFO - Downloading functools32-3.2.3-2.tar.gz 21:14:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:14:18 INFO - warning: no files found matching '*.txt' 21:14:18 INFO - no previously-included directories found matching 'build' 21:14:18 INFO - no previously-included directories found matching 'dist' 21:14:18 INFO - no previously-included directories found matching '.git*' 21:14:18 INFO - Installing collected packages: jsonschema, functools32 21:14:18 INFO - Running setup.py install for functools32 21:14:18 INFO - warning: no files found matching '*.txt' 21:14:18 INFO - no previously-included directories found matching 'build' 21:14:18 INFO - no previously-included directories found matching 'dist' 21:14:18 INFO - no previously-included directories found matching '.git*' 21:14:18 INFO - Successfully installed jsonschema functools32 21:14:18 INFO - Cleaning up... 21:14:18 INFO - Return code: 0 21:14:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:14:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x110433490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103a9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb51ada01b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110247d30>, '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 0x1100addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11023fb20>, '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.sTy2lP05LE/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.8jSyTwY8sf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 21:14:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:14:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:14:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sTy2lP05LE/Render', 21:14:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:19 INFO - 'HOME': '/Users/cltbld', 21:14:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:19 INFO - 'LOGNAME': 'cltbld', 21:14:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:19 INFO - 'MOZ_NO_REMOTE': '1', 21:14:19 INFO - 'NO_EM_RESTART': '1', 21:14:19 INFO - 'PAGER': '/bin/cat', 21:14:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:19 INFO - 'PWD': '/builds/slave/test', 21:14:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:19 INFO - 'SHELL': '/bin/bash', 21:14:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8jSyTwY8sf/Listeners', 21:14:19 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 21:14:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:19 INFO - 'USER': 'cltbld', 21:14:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:19 INFO - 'XPC_FLAGS': '0x0', 21:14:19 INFO - 'XPC_SERVICE_NAME': '0', 21:14:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:14:19 INFO - Cleaning up... 21:14:19 INFO - Return code: 0 21:14:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:14:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x110433490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103a9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb51ada01b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110247d30>, '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 0x1100addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11023fb20>, '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.sTy2lP05LE/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.8jSyTwY8sf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 21:14:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:14:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:14:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sTy2lP05LE/Render', 21:14:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:19 INFO - 'HOME': '/Users/cltbld', 21:14:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:19 INFO - 'LOGNAME': 'cltbld', 21:14:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:19 INFO - 'MOZ_NO_REMOTE': '1', 21:14:19 INFO - 'NO_EM_RESTART': '1', 21:14:19 INFO - 'PAGER': '/bin/cat', 21:14:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:19 INFO - 'PWD': '/builds/slave/test', 21:14:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:19 INFO - 'SHELL': '/bin/bash', 21:14:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8jSyTwY8sf/Listeners', 21:14:19 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 21:14:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:19 INFO - 'USER': 'cltbld', 21:14:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:19 INFO - 'XPC_FLAGS': '0x0', 21:14:19 INFO - 'XPC_SERVICE_NAME': '0', 21:14:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:19 INFO - Downloading/unpacking blobuploader==1.2.4 21:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:22 INFO - Downloading blobuploader-1.2.4.tar.gz 21:14:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:14:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:14:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:23 INFO - Downloading docopt-0.6.1.tar.gz 21:14:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:14:23 INFO - Installing collected packages: blobuploader, requests, docopt 21:14:23 INFO - Running setup.py install for blobuploader 21:14:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:14:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:14:23 INFO - Running setup.py install for requests 21:14:24 INFO - Running setup.py install for docopt 21:14:24 INFO - Successfully installed blobuploader requests docopt 21:14:24 INFO - Cleaning up... 21:14:24 INFO - Return code: 0 21:14:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:14:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:24 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 0x110433490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103a9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb51ada01b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110247d30>, '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 0x1100addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11023fb20>, '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.sTy2lP05LE/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.8jSyTwY8sf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 21:14:24 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 21:14:24 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 21:14:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sTy2lP05LE/Render', 21:14:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:24 INFO - 'HOME': '/Users/cltbld', 21:14:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:24 INFO - 'LOGNAME': 'cltbld', 21:14:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:24 INFO - 'MOZ_NO_REMOTE': '1', 21:14:24 INFO - 'NO_EM_RESTART': '1', 21:14:24 INFO - 'PAGER': '/bin/cat', 21:14:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:24 INFO - 'PWD': '/builds/slave/test', 21:14:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:24 INFO - 'SHELL': '/bin/bash', 21:14:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8jSyTwY8sf/Listeners', 21:14:24 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 21:14:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:24 INFO - 'USER': 'cltbld', 21:14:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:24 INFO - 'XPC_FLAGS': '0x0', 21:14:24 INFO - 'XPC_SERVICE_NAME': '0', 21:14:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:14:24 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-Z1OnLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:14:24 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-Mtj3GM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:14:24 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-Vm0kK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:14:24 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-MpzHu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:14:25 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-5TklTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:14:25 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-udveZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:14:25 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-CweedG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:14:25 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-tWcmj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:14:25 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-zEI3Q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:14:25 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-Wfk5oi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:14:25 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-PXcRnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:14:25 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-CqbuD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:14:25 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-6BTimb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:14:25 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-Dyo_hd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:14:26 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-BlCUz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:14:26 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-nmnBHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:14:26 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-zfcImu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:14:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:14:26 INFO - Running setup.py install for manifestparser 21:14:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:14:26 INFO - Running setup.py install for mozcrash 21:14:26 INFO - Running setup.py install for mozdebug 21:14:26 INFO - Running setup.py install for mozdevice 21:14:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:14:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:14:27 INFO - Running setup.py install for mozfile 21:14:27 INFO - Running setup.py install for mozhttpd 21:14:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:14:27 INFO - Running setup.py install for mozinfo 21:14:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:14:27 INFO - Running setup.py install for mozInstall 21:14:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:14:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:14:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:14:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:14:27 INFO - Running setup.py install for mozleak 21:14:27 INFO - Running setup.py install for mozlog 21:14:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:14:27 INFO - Running setup.py install for moznetwork 21:14:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:14:28 INFO - Running setup.py install for mozprocess 21:14:28 INFO - Running setup.py install for mozprofile 21:14:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:14:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:14:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:14:28 INFO - Running setup.py install for mozrunner 21:14:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:14:28 INFO - Running setup.py install for mozscreenshot 21:14:28 INFO - Running setup.py install for moztest 21:14:28 INFO - Running setup.py install for mozversion 21:14:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:14:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:14:28 INFO - Cleaning up... 21:14:28 INFO - Return code: 0 21:14:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:14:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:28 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 0x110433490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103a9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb51ada01b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110247d30>, '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 0x1100addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11023fb20>, '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.sTy2lP05LE/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.8jSyTwY8sf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 21:14:28 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 21:14:28 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 21:14:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sTy2lP05LE/Render', 21:14:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:28 INFO - 'HOME': '/Users/cltbld', 21:14:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:28 INFO - 'LOGNAME': 'cltbld', 21:14:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:28 INFO - 'MOZ_NO_REMOTE': '1', 21:14:28 INFO - 'NO_EM_RESTART': '1', 21:14:28 INFO - 'PAGER': '/bin/cat', 21:14:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:28 INFO - 'PWD': '/builds/slave/test', 21:14:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:28 INFO - 'SHELL': '/bin/bash', 21:14:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8jSyTwY8sf/Listeners', 21:14:28 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 21:14:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:28 INFO - 'USER': 'cltbld', 21:14:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:28 INFO - 'XPC_FLAGS': '0x0', 21:14:28 INFO - 'XPC_SERVICE_NAME': '0', 21:14:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:14:29 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-IU_dTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:14:29 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)) 21:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:14:29 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-QJHfAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:14:29 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)) 21:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:14:29 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-5pZs_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:14:29 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)) 21:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:14:29 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-wab9xn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:14:29 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)) 21:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:14:29 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-Rfecwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:14:29 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)) 21:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:14:29 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-7gWggJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:14:29 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)) 21:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:14:29 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-kKo5Y8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:14:29 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)) 21:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:14:29 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-unu5nY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:14:30 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)) 21:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:14:30 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-SZmB1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:14:30 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)) 21:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:14:30 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-KDqqdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:14:30 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)) 21:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:14:30 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-WatMvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:14:30 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)) 21:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:14:30 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-E2tS8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:14:30 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)) 21:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:14:30 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-n5SQby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:14:30 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)) 21:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:14:30 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-QiR01l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:14:30 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)) 21:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:14:30 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-oTta_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:14:30 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)) 21:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:14:30 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-xTz8jK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:14:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:14:30 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-6IpXRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:14:31 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)) 21:14:31 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)) 21:14:31 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)) 21:14:31 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)) 21:14:31 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)) 21:14:31 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)) 21:14:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:33 INFO - Downloading blessings-1.6.tar.gz 21:14:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:14:33 INFO - Installing collected packages: blessings 21:14:33 INFO - Running setup.py install for blessings 21:14:33 INFO - Successfully installed blessings 21:14:33 INFO - Cleaning up... 21:14:34 INFO - Return code: 0 21:14:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:14:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:14:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:14:34 INFO - Reading from file tmpfile_stdout 21:14:34 INFO - Current package versions: 21:14:34 INFO - blessings == 1.6 21:14:34 INFO - blobuploader == 1.2.4 21:14:34 INFO - docopt == 0.6.1 21:14:34 INFO - functools32 == 3.2.3-2 21:14:34 INFO - jsonschema == 2.5.1 21:14:34 INFO - manifestparser == 1.1 21:14:34 INFO - mozInstall == 1.12 21:14:34 INFO - mozcrash == 1.0 21:14:34 INFO - mozdebug == 0.1 21:14:34 INFO - mozdevice == 0.48 21:14:34 INFO - mozfile == 1.2 21:14:34 INFO - mozhttpd == 0.7 21:14:34 INFO - mozinfo == 0.9 21:14:34 INFO - mozleak == 0.1 21:14:34 INFO - mozlog == 3.4 21:14:34 INFO - moznetwork == 0.27 21:14:34 INFO - mozprocess == 0.23 21:14:34 INFO - mozprofile == 0.28 21:14:34 INFO - mozrunner == 6.13 21:14:34 INFO - mozscreenshot == 0.1 21:14:34 INFO - mozsystemmonitor == 0.3 21:14:34 INFO - moztest == 0.8 21:14:34 INFO - mozversion == 1.4 21:14:34 INFO - psutil == 3.1.1 21:14:34 INFO - requests == 1.2.3 21:14:34 INFO - wsgiref == 0.1.2 21:14:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:34 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 0x110433490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103a9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb51ada01b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110247d30>, '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 0x1100addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11023fb20>, '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.sTy2lP05LE/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.8jSyTwY8sf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 21:14:34 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 21:14:34 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 21:14:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sTy2lP05LE/Render', 21:14:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:34 INFO - 'HOME': '/Users/cltbld', 21:14:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:34 INFO - 'LOGNAME': 'cltbld', 21:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:34 INFO - 'MOZ_NO_REMOTE': '1', 21:14:34 INFO - 'NO_EM_RESTART': '1', 21:14:34 INFO - 'PAGER': '/bin/cat', 21:14:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:34 INFO - 'PWD': '/builds/slave/test', 21:14:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:34 INFO - 'SHELL': '/bin/bash', 21:14:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8jSyTwY8sf/Listeners', 21:14:34 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 21:14:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:34 INFO - 'USER': 'cltbld', 21:14:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:34 INFO - 'XPC_FLAGS': '0x0', 21:14:34 INFO - 'XPC_SERVICE_NAME': '0', 21:14:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:34 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)) 21:14:34 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)) 21:14:34 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)) 21:14:34 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)) 21:14:34 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)) 21:14:34 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)) 21:14:34 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)) 21:14:34 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)) 21:14:34 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)) 21:14:34 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)) 21:14:34 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)) 21:14:34 INFO - Cleaning up... 21:14:34 INFO - Return code: 0 21:14:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:34 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 0x110433490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103a9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb51ada01b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110247d30>, '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 0x1100addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11023fb20>, '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.sTy2lP05LE/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.8jSyTwY8sf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 21:14:34 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 21:14:34 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 21:14:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sTy2lP05LE/Render', 21:14:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:34 INFO - 'HOME': '/Users/cltbld', 21:14:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:34 INFO - 'LOGNAME': 'cltbld', 21:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:34 INFO - 'MOZ_NO_REMOTE': '1', 21:14:34 INFO - 'NO_EM_RESTART': '1', 21:14:34 INFO - 'PAGER': '/bin/cat', 21:14:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:34 INFO - 'PWD': '/builds/slave/test', 21:14:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:34 INFO - 'SHELL': '/bin/bash', 21:14:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8jSyTwY8sf/Listeners', 21:14:34 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 21:14:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:34 INFO - 'USER': 'cltbld', 21:14:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:34 INFO - 'XPC_FLAGS': '0x0', 21:14:34 INFO - 'XPC_SERVICE_NAME': '0', 21:14:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:14:34 INFO - Cleaning up... 21:14:34 INFO - Return code: 0 21:14:34 INFO - Running post-action listener: _resource_record_post_action 21:14:34 INFO - Running post-action listener: _start_resource_monitoring 21:14:34 INFO - Starting resource monitoring. 21:14:34 INFO - [mozharness: 2017-01-10 05:14:34.927775Z] Finished create-virtualenv step (success) 21:14:34 INFO - [mozharness: 2017-01-10 05:14:34.928815Z] Running install step. 21:14:34 INFO - Running pre-action listener: _resource_record_pre_action 21:14:34 INFO - Running main action method: install 21:14:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:14:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:14:35 INFO - Reading from file tmpfile_stdout 21:14:35 INFO - Detecting whether we're running mozinstall >=1.0... 21:14:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:14:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:14:35 INFO - Reading from file tmpfile_stdout 21:14:35 INFO - Output received: 21:14:35 INFO - Usage: mozinstall [options] installer 21:14:35 INFO - Options: 21:14:35 INFO - -h, --help show this help message and exit 21:14:35 INFO - -d DEST, --destination=DEST 21:14:35 INFO - Directory to install application into. [default: 21:14:35 INFO - "/builds/slave/test"] 21:14:35 INFO - --app=APP Application being installed. [default: firefox] 21:14:35 INFO - mkdir: /builds/slave/test/build/application 21:14:35 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'] 21:14:35 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 21:15:06 INFO - Reading from file tmpfile_stdout 21:15:06 INFO - Output received: 21:15:06 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 21:15:06 INFO - Running post-action listener: _resource_record_post_action 21:15:06 INFO - [mozharness: 2017-01-10 05:15:06.715915Z] Finished install step (success) 21:15:06 INFO - [mozharness: 2017-01-10 05:15:06.716092Z] Running run-tests step. 21:15:06 INFO - Running pre-action listener: _resource_record_pre_action 21:15:06 INFO - Running main action method: run_tests 21:15:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:15:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:15:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:15:06 INFO - 2017-01-09 21:15:06.730 screenresolution[1624:8123] starting screenresolution argv=screenresolution get 21:15:06 INFO - 2017-01-09 21:15:06.733 screenresolution[1624:8123] Display 0: 1600x1200x32@60 21:15:06 INFO - 2017-01-09 21:15:06.738 screenresolution[1625:8125] starting screenresolution argv=screenresolution list 21:15:06 INFO - Available Modes on Display 0 21:15:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:15:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:15:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:15:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:15:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:15:06 INFO - Intel Iris: 21:15:06 INFO - Chipset Model: Intel Iris 21:15:06 INFO - Type: GPU 21:15:06 INFO - Bus: Built-In 21:15:06 INFO - VRAM (Dynamic, Max): 1536 MB 21:15:06 INFO - Vendor: Intel (0x8086) 21:15:06 INFO - Device ID: 0x0a2e 21:15:06 INFO - Revision ID: 0x0009 21:15:06 INFO - Displays: 21:15:06 INFO - Display: 21:15:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:15:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:15:06 INFO - Display Serial Number: 1600x1200 60 21:15:06 INFO - Main Display: Yes 21:15:06 INFO - Mirror: Off 21:15:06 INFO - Online: Yes 21:15:06 INFO - Rotation: Supported 21:15:06 INFO - Return code: 0 21:15:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:15:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:15:06 INFO - Python 2.7.3 21:15:06 INFO - Return code: 0 21:15:06 INFO - grabbing minidump binary from tooltool 21:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:15:06 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 0x110247d30>, '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 0x1100addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11023fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:15:06 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 21:15:06 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 21:15:06 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 21:15:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:15:07 INFO - Return code: 0 21:15:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:15:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:15:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:15:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:15:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:15:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HqIf4kSiTxSu_98az9YCCw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HqIf4kSiTxSu_98az9YCCw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:15:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sTy2lP05LE/Render', 21:15:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:15:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:15:07 INFO - 'HOME': '/Users/cltbld', 21:15:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:15:07 INFO - 'LOGNAME': 'cltbld', 21:15:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:15:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:15:07 INFO - 'MOZ_NO_REMOTE': '1', 21:15:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:15:07 INFO - 'NO_EM_RESTART': '1', 21:15:07 INFO - 'PAGER': '/bin/cat', 21:15:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:15:07 INFO - 'PWD': '/builds/slave/test', 21:15:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:15:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:15:07 INFO - 'SHELL': '/bin/bash', 21:15:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8jSyTwY8sf/Listeners', 21:15:07 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 21:15:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:15:07 INFO - 'USER': 'cltbld', 21:15:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:15:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:15:07 INFO - 'XPC_FLAGS': '0x0', 21:15:07 INFO - 'XPC_SERVICE_NAME': '0', 21:15:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:15:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HqIf4kSiTxSu_98az9YCCw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:15:07 INFO - mozversion application_buildid: 20170109201208 21:15:07 INFO - mozversion application_changeset: 9e93163b43f8dd2b7a2a7191dac910ae1259c0e8 21:15:07 INFO - mozversion application_display_name: FirefoxDeveloperEdition 21:15:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:15:07 INFO - mozversion application_name: Firefox 21:15:07 INFO - mozversion application_remotingname: firefox-dev 21:15:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:15:07 INFO - mozversion application_vendor: Mozilla 21:15:07 INFO - mozversion application_version: 52.0a2 21:15:07 INFO - mozversion platform_buildid: 20170109201208 21:15:07 INFO - mozversion platform_changeset: 9e93163b43f8dd2b7a2a7191dac910ae1259c0e8 21:15:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:15:07 INFO - mozversion platform_version: 52.0a2 21:15:07 INFO - using testdate: 1484025307 21:15:07 INFO - actual date: 1484025307 21:15:07 INFO - starting webserver on 'localhost:49235' 21:15:07 INFO - SUITE-START | Running 2 tests 21:15:07 INFO - TEST-START | dromaeo_css 21:15:07 INFO - operating with platform_type : mac_ 21:15:07 INFO - Initialising browser for dromaeo_css test... 21:15:07 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpl1jdNQ/profile http://localhost:49235/getInfo.html) 21:15:10 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 21:15:10 INFO - PROCESS | 1635 | colorDepth:24 21:15:10 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 21:15:10 INFO - PROCESS | 1635 | __metrics 21:15:10 INFO - PROCESS | 1635 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:15:10 INFO - PROCESS | 1635 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:15:10 INFO - TEST-INFO | 1635: exit 0 21:15:10 INFO - Browser initialized. 21:15:10 INFO - Running cycle 1/1 for dromaeo_css test... 21:15:10 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpl1jdNQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:15:23 INFO - PROCESS | 1638 | RSS: Main: 238084096 21:15:23 INFO - PROCESS | 1638 | 21:18:27 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 21:18:29 INFO - PROCESS | 1638 | RSS: Main: 379142144 21:18:29 INFO - PROCESS | 1638 | 21:21:32 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 21:21:33 INFO - PROCESS | 1638 | RSS: Main: 362344448 21:21:33 INFO - PROCESS | 1638 | 21:24:35 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 21:24:35 INFO - PROCESS | 1638 | RSS: Main: 334258176 21:24:35 INFO - PROCESS | 1638 | 21:27:38 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 21:27:38 INFO - PROCESS | 1638 | RSS: Main: 334278656 21:27:38 INFO - PROCESS | 1638 | 21:30:42 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 21:30:42 INFO - PROCESS | 1638 | RSS: Main: 321867776 21:30:42 INFO - PROCESS | 1638 | 21:33:45 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 21:33:46 INFO - PROCESS | 1638 | RSS: Main: 372879360 21:33:46 INFO - PROCESS | 1638 | 21:33:46 INFO - PROCESS | 1638 | __start_tp_report 21:33:46 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 21:33:46 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 21:33:46 INFO - PROCESS | 1638 | |i|pagename|runs| 21:33:46 INFO - PROCESS | 1638 | |0;dojo.html;3267.950980735289;3294.868205271789;3327.48423994281;3338.265581572053;3373.3421982713367;5531.778728850846;5587.916181257279;5590.496855283024;5600.52395546378;5611.186377975197;5524.254225679532;5581.162825576165;5599.356074051485;5599.916001259984;5652.773889044433;5075.441701412851;5087.262346959688;5104.617153713468;5164.612654050942;5213.921791173136;5081.8221362252325;5084.618653600995;5114.693118412907;5162.1482455395;5179.896402071975;5117.513836185556;5150.1759718445055;5160.741962901859;5184.326037615105;5189.455107213745;5111.2333150027425;5125.154349532323;5134.0758663440565;5148.485151484859;5176.197689358156;4058.5535591085254;5064.189729643276;5129.948700512984;5133.614978876599;5141.5115564021735;5466.590005749585;5500.367457742331;5528.06022976095;5540.445955404468;5560.2493663355335;6043.093535969596;6119.388061193845;6129.785457508966;6130.887362651042;6139.969300153471;6178.581052085296;6198.194234749454;6199.473044791198;6219.87560248797;6236.594621349643;5455.890882182334;5520.06158952979;5520.337559492887;5701.087825947829;5714.771409143629;6219.284782250009;6276.592021518678;6302.747890084437;6323;6339.366063393623;5975.462208401264;5981.581289309706;5982.551308651781;5992.58051936369;6029.909551356734;5048.7728052237735;6010.579259451796;6032.245969253843;6174.845628859224;6204.751809927642;5908.497777688945;5981.491573216325;5994.67029313392;6037.396260374016;6054.39456054391;6114.052321890114;6115.969420152871;6117.388261173847;6117.785877494266;6122.479589234876;4834.806607735722;4864.294677271776;4865.489123642037;4866.31871537985;4888.26675998596;4165.166966606691;4177.26897792885;4216.47294088239;4298.290782020994;4311.978440107842;5561.221428999943;5561.58288128392;5606.243157173811;5636.070048442043;5646;6148.600340977822;6148.877022459616;6156.846078848064;6165.383461653799;6171.691415429211;5479.150731636602;5495.340559132929;5567.66594004361;5583.692896890629;5590.748416321276;5243.9213411798855;5246.921296180561;5281.15501519755;5325.147976323847;5343.67937923718;6253.593516421418;6302.054691796084;6365.872682546323;6375.681215939092;6377.394147555975;4872.829450969199;6213.471854892385;6214.533909956681;6226.283977342664;6240.4071613196675;6129.175413489998;6182.072689096672;6185.319614842274;6236.844467942761;6265.185525881606;5984.251968503937;5986.790462333797;5999.790007349722;6008.1588577598295;6027.156198132353;6040.275166979991;6088.147659327609;6097.634141951497;6099.786507472217;6124.724387402666;5723.627964182481;5757.5681823864215;5768.365479797303;5834.737436815269;5862.149988251595;5895.64626122434;5899.351071382059;5900.43945825146;5909.645421274738;5923.881522369615;5668.546516278605;5738.540916726735;5741.511971482304;5742;5752;4672.9532704673875;5575.442455754554;5619.971900140473;5761.308642962704;5901.734421950937;4836.516348365135;5662.943370566241;5801.854953626024;5804.303483581997;5809.157672137432 21:33:46 INFO - PROCESS | 1638 | |1;ext.html;492.83936329942975;506.7111746304606;510.55581643969754;523.3353640876085;593.6764463367464;26356.86821565892;31418.842905785496;31482.52776208356;31492.740290388385;31561.68438315616;40772.59227407725;41930.58069419305;41933.58066419335;42960.78519607405;43137.137257254835;9055.275577953764;9215.95392023039;9220.5850736717;9239.907600923972;9241.49171795551;9195.816083678323;9275.721728348126;9279.443233405984;9296.070392960717;9299.95350023249;9251.814963700723;9309.301802364816;9309.975902650704;9315.953420232889;9331.860022099674;9160.717499550068;9196.770080747969;9272.999999999965;9281.489518076503;9286.90713092874;7816.8827467588035;8927.910720892838;8930.687425940127;9014.684486042957;9158.404703694305;38568.80715596404;39012.41481377782;39057.609423905684;39127.60872391296;39175.80412097921;3055.3125546752026;3067.2025273428844;3193.1857376368876;3346.665333466658;3403.149212696826;28889.855550722114;29150;29339.266518337212;29802.254943626365;29969.70030299691;3163.335699503107;3172.730317922956;3213.7268332191793;3225.225945773021;3290.2596915694016;345424;357202;381573;382819;383105;58234;58438.41561584415;58605.41394586;58606.41393586095;58810.70594646999;34489.82755086259;35213.64786352104;35554.46668299977;35866;35907.4613880792;15504.30230639624;15642.374305027672;15649.217539122998;15656.608584785243;15692;11897.70255743596;11899.643010709693;11930.403479825975;11937.403129843473;11954.342511161969;18801.435956921316;18838.811611883706;18869.62260754777;18931.716024259647;18939.90530047341;7749.690012399554;7910.644021019068;7927.5243485391065;8006.919930800617;8051.315638170821;848.1815048478124;912.0879120879121;930.1303281431748;988.2341185581089;991.3062442380284;28770.136895893156;29035;29810.55284170739;29867.551986720217;30424.54363184554;857.2242120880613;864.4985908173245;1068.257560995101;1082.3451811653993;1110.294962698676;14468.855311446961;15048.849511504965;15089.094654320776;15347.539573812803;15356.232188390535;661730;666244;666296;666772;667980;57604;57831.71084144552;57953;58097.70951145217;58174;1234.4259919137644;1267;1349.048920511057;1362.4958765256918;1392.046448182998;29867;30241.2841984938;30720;30947;31306.68693313129;49304.01391972212;49906.50093499019;49996.25005624991;50034;50111;528468;529677;531630;532015;669559;39759.403608946464;40727.79636101801;41551.96120097022;41574.96062598459;41753.58246417497;44982.325265121704;45094;45112.09775804531;45124.0975180488;45402.31896521621;37021.62978370182;37147.62852371442;37953.051173719774;38891;38951.22097557976;37219.00693012721;37548.43677344787;38060.619393805704;38268.61731382762;38916.61083389243;36271.818640906626;36703;37265.25469490541;37639.81180094082;37791.811040944616;32294.677053229167;33905;34264.44505508251;34487;34613.480797787546;24891.50216995686;25047.248582542554;25115;25435;25713.971441142894 21:33:46 INFO - PROCESS | 1638 | |2;jquery.html;316.42568737741;330.1350461790107;342.39054483020215;357.8157249016756;399.18566125104786;15098.924505377472;16003.839961600395;19304.324348647784;19651.410457686292;20410.693839592383;19857;20282.898585507053;20392;20425.387238382835;20592.8970355148;4632.934425082233;5809.622374545662;5968.224130862982;5978.22283103196;5978.432048955342;5626.268585083933;5842.357340692521;5877.559183061266;5890.440408161217;5926.111083337512;5839.5620328475325;5844.415558444164;5844.736986835603;5845.824625261249;5853.736581853806;5575.749091290902;5759.798407055775;5823.79616713413;5829.067349224104;5842.5618078644275;5124.128898087334;5126.359205099363;5127.9230811537855;5132.28148059272;5136.409312929024;24673;24783.88472518723;24887.875560622262;24962.251132465874;25246.62130068032;2268.7164104486938;2404.7354790972977;2425.866577338246;2599.5450796110604;2760.4479104179045;14500.492482763053;15172.620684482867;15334;15741.527754167393;15891.92054039734;1770.530809335527;1824.4617837737899;1827.0316732131992;1852.2961274715656;1914.349121298765;112891;118144;120278;121283.3935830324;121611.39194304061;10499.68500944973;10531.420771857469;10603.575856965635;10629;11005.504752286166;13477.989150813728;13656.317184140753;13806.309684515734;13844.930775346058;13854.792178117335;8271.2142346477;8339.291160251447;8359.623816928131;8364.330853531703;8503.234708876107;8268.338532917352;8316.251537361666;8426.862373579488;8440.155984401634;8504.532250726146;6539.051837483538;6544.280129185786;6675.365840245266;6678.232003319583;6688.097106890605;1523.2612183091192;1769.991060146717;1808.7467754514378;1814.219885449243;1816.7456556082159;851.5784686580058;954.370115723619;974.2254907348674;1012.1801340913884;1023.3552861697083;21890;22353.776462235168;22421.55156896853;22468.101275949106;22580;959.9616015359308;974.2449601558849;999.915092125038;1011.4942528735633;1022.0954455306958;10188.134008609202;10565.151098557722;10921.508532116073;11429.771404571862;11528.711782205512;572857.6285422804;584878;590661.0466947723;595606;600557;113207;115902.8409715909;117761.05597359964;120598;120826;947.2611363136764;976.702105857706;992.771662517625;993.4039576254189;993.557866749304;18224.45326640203;19316.034198290312;19687.507812304808;19722.915239661957;19754.81471111738;51630.967380652924;52521;52559;52814.47185528249;53779.462205377444;67626;69610;69990.65004675147;70373;70638.94041589278;6880.552764070319;7350.154732205651;7399.186089530255;7572.962135189288;8355;11749.29504229749;11922.284662919905;12000.63998080059;12677.30274834893;12810.295433751233;9332.580033898626;10809.297395669257;11007.944960275468;11275.041621462267;11320.320780753182;10791.892081079088;10955.452227388758;10968.561257549609;11311.264767790068;11384.089272858317;10652.786944260917;10887.727806804893;11217.943910280723;11708.004819590431;11719;8111.067227268703;8148.592570371577;8150.592470376576;8336.791580210544;8367.456115352483;9751.60993560278;10935.125189984941;10979.725506862393;11072.889271107508;11128.888711112786 21:33:46 INFO - PROCESS | 1638 | |3;mootools.html;1319.8548159702436;1411.0968979852896;1446.4503488674302;1489.9925500372497;1820.3719716697735;7419.777406677795;7734.265244801742;7919.445638805286;8268.710595129156;8306.83386332273;7734.613269336539;7966.760997170094;7971.003624546932;7981.600919953994;7984.24149705777;1937.3994061840804;2281.634938409859;2321.6401457774073;2327.8836058197107;2328.790408863202;2313.4910319729715;2361.445060410802;2371.122684606698;2373.32360277321;2376.1089591403224;2304.458452263725;2328.557574060923;2339.578875802355;2340.2979106268053;2343.179887039531;1897.8671492995495;1916.597514521952;2271.284545368212;2302.1712183613886;2305.654151877232;2328.1153161798406;2345.812335013195;2350.17743789674;2354.8587084774967;2354.929352119439;8039.07550631679;8217.753467395987;8243.216894395024;8255.380846436541;8260.463069900497;5043.646944713872;5211.530962213381;5227.085260079509;5236.188390799432;5247.606429517801;2904.4917139500712;3541.8937431877084;3547.4146765783617;3600.963990360089;3617.222297206087;1077.3212875888141;1098.6703988803326;1413.441690532234;1731.203646322693;1820.8543316534644;10484.161267098614;10696.358218506915;10700.14398848098;10702.946485267601;10725.570977160904;4618.930716039262;4626.329182268552;4678.1813182692895;4724.385829842098;4732;9371.625134994523;9378.343515953955;9387.62449502026;9388.718338449857;9391.342606017513;5206.349206349207;5206.453322401169;5218.478152184827;5219.451957544479;5228.424873263938;4031.737937034083;4274.572542745763;4430.645548356124;4691.929621055687;4767.713937163781;3120.625524937022;3832.137769002008;3896.376579747227;3921.215756848642;3934.213157368538;1234.3026190202686;1248.4881198708485;1251.4931452761646;1263.7030297879992;1263.7788387032233;798.7124635131464;815.0097631377904;895.0870112485229;909.5179554835947;917.4862077236769;4790.01804630057;5277.287566178594;5349.598780091509;5496.422875598005;5604.6917419542315;443.3726277317624;448.15299084729884;458.7178884985776;729.7810656802938;1015.6902144845893;3148.937021259562;3329.550510681027;3488.860445582199;3600.2439487707875;3621;9803.509824508888;10058.446785426871;10160.23798215122;10193.847092293621;10231.48842557884;10116.949415252877;10124.493775311204;10129.240306977006;10130.544125514369;10136.695899123039;7174.426045916314;7387.409007279405;7595.620218989028;7690.461667683208;7706.73026444083;5427.918581221206;5553.194786755817;5558.944410555842;5630.971845140748;5793.188953546422;9131.360804743605;9298.674546390845;9339.346245763003;9423.19902808269;9440.622375104918;8034.718784842503;8560.91439085626;9244.907550924405;9448.007959164188;9464.668736594185;7072.151341839012;7097.680604372919;7211.747588834365;7256.2018178001435;7267.7819665410125;7149.60677162761;7299.927000729925;7762.5730584818375;7856.175101614248;7859.52842829432;7005.474589405917;7083.539569927938;7132.750353737594;7138.357547820721;7270.890936635848;5768.336641286306;6976.476764242803;6978.441724662116;6980.336867997532;7042.7887163385185;6521.380468855451;6574.638394888136;6656.866862662623;6684.799456016327;6693.966530167318;4798.640101992295;4826.203676393356;4848.80604775805;4903.828366007173;4944.381952255968;4453.599176074169;4498.8425405111975;4611.216093264086;4614.054118905683;4759.833405830779 21:33:46 INFO - PROCESS | 1638 | |4;prototype.html;295.3075039033466;303.8374469658733;304.79121801565924;310.93314937288477;314.63816610897453;4480.661906879372;5214.348206474191;5227.634065615413;5263.842084737464;5270.841874743759;4593.655475839317;4892.951070489294;5059.949400505994;5131.767681058742;5138.845834624958;3743.929977418518;3831.578526362098;3852.614738526139;3910;3938.940915886264;3660.450932360154;3878.941815872764;3910.804459777014;3915.4714113594587;3971.7616942983514;3337.1657085728566;3865.5747867734526;3877.8448862045484;3893.9221215575812;3920.607939206085;3312.287858110518;3511.455724362728;3543.9291214175573;3914.5693973662874;3944.6252606002386;3409.710174635134;3422.9657703422895;3447.77589456687;3450.3783221885674;3458.39478091333;4055.9797201013807;4288.842012656565;4548.749818759967;4985.651004429691;5014.648974571782;4289.399484072233;4434.337123578658;4447.710898791568;4456.3538286948215;4457.130859482402;4626.58360747531;5270.736463176864;5302.761375738101;5315.033437628103;5341.359036915556;3135.2945587242916;3757.3236817372863;3775.2449510097817;3792.412176112707;3797.791121488317;5394.703291319015;5617.915731263994;5639.520640745542;5641.445889089847;5719.71401429931;3166.9683303167135;3770.604876195825;3809.5238095238096;3825.024618722208;3843.7706130444276;3880.941785873214;3886.8639597613947;3893.8053097345587;3901.668358189529;3910.354791459434;3334;3674.254729003755;3740.1023754299317;4458.308962110878;4493.865184044484;4317.352397140454;4677.906441871143;4871.926921096187;5297.437256009486;5439.864003399867;1116.8268918317674;1194.832723418722;1198.5086114692933;1260.9936950315373;1262.5013119817804;824.4599787139433;835.9832803343899;865.5455885659953;869.6434461870729;877.2674816528142;4730.692504987165;4789.976050119797;4886.706797592155;4895.7062576245535;4914.36113305268;4819.7108173509705;5471.781128754885;5483.666365348029;5497.47773961473;5500.889982200333;4197.643200327945;4973.458227949275;4994.975025124923;4995.001999200349;5050;2600.54490464168;2613.359726866892;2661.4144888124583;2734.3164208947765;2750;4441.666874984389;4555.840545580955;5305;5310.575153987672;5473.9325831463275;4954.628402869799;5327.973360133252;5335.439778823245;5362.463753624685;5432.674039557639;4752.360435649695;5225.738713064332;5280.732624170171;5298.894022119536;5327.786888524415;5020.422651395136;5148.382194136728;5155;5226.895462090661;5262.789488420573;4767.523247675204;4832.565069143794;5162.483751624807;5220.817271395483;5264.447233040476;5006.374203224597;5216.165413533817;5464.26232458613;5482.038754926798;5482.972585137049;3092.567040614271;3493.8206232329476;3579.624139465423;3657.5428071491065;3659.0852286928266;4905.285715690084;5189.299444575085;5200.245964335075;5202.918832467043;5255.687497501087;4177.496101403553;4811.1820990431015;4969.627277954096;5013.623978201723;5037.496250374933;4812.25410061441;4988.725620090785;4995.402390756713;5007.119482401168;5025.874353141055;4123.670106391542;4259.97870010648;4789.880252993703;4812.614990800657;4903;5092.745362731923;5282.656627319212;5293.9205911910585;5328.014317351302;5387.703676297684;5098;5231.346081739783;5243.606729495227;5249.632525723163;5252.7898884045735 21:33:46 INFO - PROCESS | 1638 | |5;yui.html;672.5191488086017;685.773694680755;719.2304234469118;723.2767232767233;750.1036261667309;13863.23752193629;14337.426502939896;14338.42646294147;14359.35382907769;14362.928185359071;12599;12683.175593586411;12728.61814145577;12738;12745.936270318658;635.8982562789954;663.141232104426;667.9031540426636;804.9798755031112;815.4984684419098;799.2087833045301;821.8931538899965;823.9052508961486;823.9217274358926;830.6345208108413;868.587420975035;870.4603146049458;871.6208449324564;873.7204094689702;873.8252349530088;669.7454967112515;695.523566357047;821.8191997760483;851.7189327521903;865.3596338709373;643.2570381209711;643.5045015338163;644.8742495213435;645.1000853808957;645.6223109480959;13963.441462341494;14106.224157671324;14117.294135293298;14124.435022599084;14162.575122746333;13035.543755968496;13103.737925241441;13202.933985330108;13247.07270491066;13340.33298335089;12021;12237.143399962006;12324.32216228107;12351.505939762399;12670.493180272779;4384.408104905829;4393.297072468422;4417.867463976054;4431.335299705038;4578.656600754956;78830;80699.5965020177;81196;85226.14773852307;93177.06822931752;10906.72733181661;10944.890551094546;11015.724606884733;11115.777684446428;11164.609238676607;21256.893715531325;21287.574248514942;21497.67753483699;21580.89209553942;21587.2444464443;7646.732364367221;7853.371730261565;7889.723859664999;8137.837243255101;8146.959265203636;4219.6202341789385;4237.576242375738;4304.246756817544;4367.541408152162;4380.452443444569;3375.8987230383127;3477.530533378012;3481.89554313371;3499.807510586942;3503.2292895562937;460.3348161906014;640.2796853539768;646.3697894552773;646.4214527997416;648.1185587600859;486.6714967396993;566.1931747260138;580.5036693626972;596.3172167867767;624.1262232873922;7045.921453171327;8509.744707658656;8679.435836670596;8786.956065219632;8988.235999939947;567.3447168520365;590.3859985614912;597.6066004311041;641.0800501280677;666.1406785247074;4262.168877069003;4397.978010109929;4451.198784218807;4466.687331886802;4479.602079494267;61967.690161548904;78284;100592;110499.89500104896;117052.41473792576;92124;96671;97093.51453242688;99667.00332996722;104965.47517262364;79928;81685.18314816894;83664.58167709244;84367;84918.5754071238;8274.627641756257;8518.78703032429;8524.659013639633;8568.143185681382;8723.389362744547;52224.47775522196;54008;54452.455475446324;54878;55274.72362638322;70708;73939;74859.25140748522;75705.62147189229;76178;11500.884991150317;11513.424328783694;11767.88232117668;11813.645590632295;11869.347185904859;11883.940580297043;12014.519419223134;12153.392330383269;12258.20321679088;12650.936745316214;11654.533818647498;11904.285742855456;11917.225380350596;12115.636530904087;12203.389830508617;11599;11756.294622322688;11827.586034488751;12065.698357541132;12093.57672481459;11100.500477478694;11400.087992960709;11553.942230288794;11898.821517677416;12337.259764414164;9431.245500359817;9706.9029309706;9837.262205334486;9845.163161131384;9875.604975800887;7975.481593696391;9220.815583688423;9757.26820488452;9873.456959867277;9892.060254275832 21:33:46 INFO - PROCESS | 1638 | __end_tp_report 21:33:46 INFO - PROCESS | 1638 | __start_cc_report 21:33:46 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,1836 21:33:46 INFO - PROCESS | 1638 | __end_cc_report 21:33:46 INFO - PROCESS | 1638 | __startTimestamp1484026426077__endTimestamp 21:33:46 INFO - PROCESS | 1638 | 21:33:46 INFO - PROCESS | 1638 | ------- Summary: start ------- 21:33:46 INFO - PROCESS | 1638 | Number of tests: 6 21:33:46 INFO - PROCESS | 1638 | 21:33:46 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5589.38 Median:5714.77 stddev:647.31 (11.3%) stddev-sans-first:623.15 21:33:46 INFO - PROCESS | 1638 | Values: 3268.0 3294.9 3327.5 3338.3 3373.3 5531.8 5587.9 5590.5 5600.5 5611.2 5524.3 5581.2 5599.4 5599.9 5652.8 5075.4 5087.3 5104.6 5164.6 5213.9 5081.8 5084.6 5114.7 5162.1 5179.9 5117.5 5150.2 5160.7 5184.3 5189.5 5111.2 5125.2 5134.1 5148.5 5176.2 4058.6 5064.2 5129.9 5133.6 5141.5 5466.6 5500.4 5528.1 5540.4 5560.2 6043.1 6119.4 6129.8 6130.9 6140.0 6178.6 6198.2 6199.5 6219.9 6236.6 5455.9 5520.1 5520.3 5701.1 5714.8 6219.3 6276.6 6302.7 6323.0 6339.4 5975.5 5981.6 5982.6 5992.6 6029.9 5048.8 6010.6 6032.2 6174.8 6204.8 5908.5 5981.5 5994.7 6037.4 6054.4 6114.1 6116.0 6117.4 6117.8 6122.5 4834.8 4864.3 4865.5 4866.3 4888.3 4165.2 4177.3 4216.5 4298.3 4312.0 5561.2 5561.6 5606.2 5636.1 5646.0 6148.6 6148.9 6156.8 6165.4 6171.7 5479.2 5495.3 5567.7 5583.7 5590.7 5243.9 5246.9 5281.2 5325.1 5343.7 6253.6 6302.1 6365.9 6375.7 6377.4 4872.8 6213.5 6214.5 6226.3 6240.4 6129.2 6182.1 6185.3 6236.8 6265.2 5984.3 5986.8 5999.8 6008.2 6027.2 6040.3 6088.1 6097.6 6099.8 6124.7 5723.6 5757.6 5768.4 5834.7 5862.1 5895.6 5899.4 5900.4 5909.6 5923.9 5668.5 5738.5 5741.5 5742.0 5752.0 4673.0 5575.4 5620.0 5761.3 5901.7 4836.5 5662.9 5801.9 5804.3 5809.2 21:33:46 INFO - PROCESS | 1638 | 21:33:46 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:66138.15 Median:38729.90 stddev:146318.58 (377.8%) stddev-sans-first:146646.03 21:33:46 INFO - PROCESS | 1638 | Values: 492.8 506.7 510.6 523.3 593.7 26356.9 31418.8 31482.5 31492.7 31561.7 40772.6 41930.6 41933.6 42960.8 43137.1 9055.3 9216.0 9220.6 9239.9 9241.5 9195.8 9275.7 9279.4 9296.1 9300.0 9251.8 9309.3 9310.0 9316.0 9331.9 9160.7 9196.8 9273.0 9281.5 9286.9 7816.9 8927.9 8930.7 9014.7 9158.4 38568.8 39012.4 39057.6 39127.6 39175.8 3055.3 3067.2 3193.2 3346.7 3403.1 28889.9 29150.0 29339.3 29802.3 29969.7 3163.3 3172.7 3213.7 3225.2 3290.3 345424.0 357202.0 381573.0 382819.0 383105.0 58234.0 58438.4 58605.4 58606.4 58810.7 34489.8 35213.6 35554.5 35866.0 35907.5 15504.3 15642.4 15649.2 15656.6 15692.0 11897.7 11899.6 11930.4 11937.4 11954.3 18801.4 18838.8 18869.6 18931.7 18939.9 7749.7 7910.6 7927.5 8006.9 8051.3 848.2 912.1 930.1 988.2 991.3 28770.1 29035.0 29810.6 29867.6 30424.5 857.2 864.5 1068.3 1082.3 1110.3 14468.9 15048.8 15089.1 15347.5 15356.2 661730.0 666244.0 666296.0 666772.0 667980.0 57604.0 57831.7 57953.0 58097.7 58174.0 1234.4 1267.0 1349.0 1362.5 1392.0 29867.0 30241.3 30720.0 30947.0 31306.7 49304.0 49906.5 49996.3 50034.0 50111.0 528468.0 529677.0 531630.0 532015.0 669559.0 39759.4 40727.8 41552.0 41575.0 41753.6 44982.3 45094.0 45112.1 45124.1 45402.3 37021.6 37147.6 37953.1 38891.0 38951.2 37219.0 37548.4 38060.6 38268.6 38916.6 36271.8 36703.0 37265.3 37639.8 37791.8 32294.7 33905.0 34264.4 34487.0 34613.5 24891.5 25047.2 25115.0 25435.0 25714.0 21:33:46 INFO - PROCESS | 1638 | 21:33:46 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:34337.74 Median:24728.44 stddev:98037.26 (396.5%) stddev-sans-first:98279.00 21:33:46 INFO - PROCESS | 1638 | Values: 316.4 330.1 342.4 357.8 399.2 15098.9 16003.8 19304.3 19651.4 20410.7 19857.0 20282.9 20392.0 20425.4 20592.9 4632.9 5809.6 5968.2 5978.2 5978.4 5626.3 5842.4 5877.6 5890.4 5926.1 5839.6 5844.4 5844.7 5845.8 5853.7 5575.7 5759.8 5823.8 5829.1 5842.6 5124.1 5126.4 5127.9 5132.3 5136.4 24673.0 24783.9 24887.9 24962.3 25246.6 2268.7 2404.7 2425.9 2599.5 2760.4 14500.5 15172.6 15334.0 15741.5 15891.9 1770.5 1824.5 1827.0 1852.3 1914.3 112891.0 118144.0 120278.0 121283.4 121611.4 10499.7 10531.4 10603.6 10629.0 11005.5 13478.0 13656.3 13806.3 13844.9 13854.8 8271.2 8339.3 8359.6 8364.3 8503.2 8268.3 8316.3 8426.9 8440.2 8504.5 6539.1 6544.3 6675.4 6678.2 6688.1 1523.3 1770.0 1808.7 1814.2 1816.7 851.6 954.4 974.2 1012.2 1023.4 21890.0 22353.8 22421.6 22468.1 22580.0 960.0 974.2 999.9 1011.5 1022.1 10188.1 10565.2 10921.5 11429.8 11528.7 572857.6 584878.0 590661.0 595606.0 600557.0 113207.0 115902.8 117761.1 120598.0 120826.0 947.3 976.7 992.8 993.4 993.6 18224.5 19316.0 19687.5 19722.9 19754.8 51631.0 52521.0 52559.0 52814.5 53779.5 67626.0 69610.0 69990.7 70373.0 70638.9 6880.6 7350.2 7399.2 7573.0 8355.0 11749.3 11922.3 12000.6 12677.3 12810.3 9332.6 10809.3 11007.9 11275.0 11320.3 10791.9 10955.5 10968.6 11311.3 11384.1 10652.8 10887.7 11217.9 11708.0 11719.0 8111.1 8148.6 8150.6 8336.8 8367.5 9751.6 10935.1 10979.7 11072.9 11128.9 21:33:46 INFO - PROCESS | 1638 | 21:33:46 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5359.81 Median:4837.50 stddev:2942.20 (60.8%) stddev-sans-first:2934.78 21:33:46 INFO - PROCESS | 1638 | Values: 1319.9 1411.1 1446.5 1490.0 1820.4 7419.8 7734.3 7919.4 8268.7 8306.8 7734.6 7966.8 7971.0 7981.6 7984.2 1937.4 2281.6 2321.6 2327.9 2328.8 2313.5 2361.4 2371.1 2373.3 2376.1 2304.5 2328.6 2339.6 2340.3 2343.2 1897.9 1916.6 2271.3 2302.2 2305.7 2328.1 2345.8 2350.2 2354.9 2354.9 8039.1 8217.8 8243.2 8255.4 8260.5 5043.6 5211.5 5227.1 5236.2 5247.6 2904.5 3541.9 3547.4 3601.0 3617.2 1077.3 1098.7 1413.4 1731.2 1820.9 10484.2 10696.4 10700.1 10702.9 10725.6 4618.9 4626.3 4678.2 4724.4 4732.0 9371.6 9378.3 9387.6 9388.7 9391.3 5206.3 5206.5 5218.5 5219.5 5228.4 4031.7 4274.6 4430.6 4691.9 4767.7 3120.6 3832.1 3896.4 3921.2 3934.2 1234.3 1248.5 1251.5 1263.7 1263.8 798.7 815.0 895.1 909.5 917.5 4790.0 5277.3 5349.6 5496.4 5604.7 443.4 448.2 458.7 729.8 1015.7 3148.9 3329.6 3488.9 3600.2 3621.0 9803.5 10058.4 10160.2 10193.8 10231.5 10116.9 10124.5 10129.2 10130.5 10136.7 7174.4 7387.4 7595.6 7690.5 7706.7 5427.9 5553.2 5558.9 5631.0 5793.2 9131.4 9298.7 9339.3 9423.2 9440.6 8034.7 8560.9 9244.9 9448.0 9464.7 7072.2 7097.7 7211.7 7256.2 7267.8 7149.6 7299.9 7762.6 7856.2 7859.5 7005.5 7083.5 7132.8 7138.4 7270.9 5768.3 6976.5 6978.4 6980.3 7042.8 6521.4 6574.6 6656.9 6684.8 6694.0 4798.6 4826.2 4848.8 4903.8 4944.4 4453.6 4498.8 4611.2 4614.1 4759.8 21:33:46 INFO - PROCESS | 1638 | 21:33:46 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4252.35 Median:4812.43 stddev:1283.35 (26.7%) stddev-sans-first:1252.11 21:33:46 INFO - PROCESS | 1638 | Values: 295.3 303.8 304.8 310.9 314.6 4480.7 5214.3 5227.6 5263.8 5270.8 4593.7 4893.0 5059.9 5131.8 5138.8 3743.9 3831.6 3852.6 3910.0 3938.9 3660.5 3878.9 3910.8 3915.5 3971.8 3337.2 3865.6 3877.8 3893.9 3920.6 3312.3 3511.5 3543.9 3914.6 3944.6 3409.7 3423.0 3447.8 3450.4 3458.4 4056.0 4288.8 4548.7 4985.7 5014.6 4289.4 4434.3 4447.7 4456.4 4457.1 4626.6 5270.7 5302.8 5315.0 5341.4 3135.3 3757.3 3775.2 3792.4 3797.8 5394.7 5617.9 5639.5 5641.4 5719.7 3167.0 3770.6 3809.5 3825.0 3843.8 3880.9 3886.9 3893.8 3901.7 3910.4 3334.0 3674.3 3740.1 4458.3 4493.9 4317.4 4677.9 4871.9 5297.4 5439.9 1116.8 1194.8 1198.5 1261.0 1262.5 824.5 836.0 865.5 869.6 877.3 4730.7 4790.0 4886.7 4895.7 4914.4 4819.7 5471.8 5483.7 5497.5 5500.9 4197.6 4973.5 4995.0 4995.0 5050.0 2600.5 2613.4 2661.4 2734.3 2750.0 4441.7 4555.8 5305.0 5310.6 5473.9 4954.6 5328.0 5335.4 5362.5 5432.7 4752.4 5225.7 5280.7 5298.9 5327.8 5020.4 5148.4 5155.0 5226.9 5262.8 4767.5 4832.6 5162.5 5220.8 5264.4 5006.4 5216.2 5464.3 5482.0 5483.0 3092.6 3493.8 3579.6 3657.5 3659.1 4905.3 5189.3 5200.2 5202.9 5255.7 4177.5 4811.2 4969.6 5013.6 5037.5 4812.3 4988.7 4995.4 5007.1 5025.9 4123.7 4260.0 4789.9 4812.6 4903.0 5092.7 5282.7 5293.9 5328.0 5387.7 5098.0 5231.3 5243.6 5249.6 5252.8 21:33:46 INFO - PROCESS | 1638 | 21:33:46 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:19785.08 Median:27920.46 stddev:28839.91 (103.3%) stddev-sans-first:28885.11 21:33:46 INFO - PROCESS | 1638 | Values: 672.5 685.8 719.2 723.3 750.1 13863.2 14337.4 14338.4 14359.4 14362.9 12599.0 12683.2 12728.6 12738.0 12745.9 635.9 663.1 667.9 805.0 815.5 799.2 821.9 823.9 823.9 830.6 868.6 870.5 871.6 873.7 873.8 669.7 695.5 821.8 851.7 865.4 643.3 643.5 644.9 645.1 645.6 13963.4 14106.2 14117.3 14124.4 14162.6 13035.5 13103.7 13202.9 13247.1 13340.3 12021.0 12237.1 12324.3 12351.5 12670.5 4384.4 4393.3 4417.9 4431.3 4578.7 78830.0 80699.6 81196.0 85226.1 93177.1 10906.7 10944.9 11015.7 11115.8 11164.6 21256.9 21287.6 21497.7 21580.9 21587.2 7646.7 7853.4 7889.7 8137.8 8147.0 4219.6 4237.6 4304.2 4367.5 4380.5 3375.9 3477.5 3481.9 3499.8 3503.2 460.3 640.3 646.4 646.4 648.1 486.7 566.2 580.5 596.3 624.1 7045.9 8509.7 8679.4 8787.0 8988.2 567.3 590.4 597.6 641.1 666.1 4262.2 4398.0 4451.2 4466.7 4479.6 61967.7 78284.0 100592.0 110499.9 117052.4 92124.0 96671.0 97093.5 99667.0 104965.5 79928.0 81685.2 83664.6 84367.0 84918.6 8274.6 8518.8 8524.7 8568.1 8723.4 52224.5 54008.0 54452.5 54878.0 55274.7 70708.0 73939.0 74859.3 75705.6 76178.0 11500.9 11513.4 11767.9 11813.6 11869.3 11883.9 12014.5 12153.4 12258.2 12650.9 11654.5 11904.3 11917.2 12115.6 12203.4 11599.0 11756.3 11827.6 12065.7 12093.6 11100.5 11400.1 11553.9 11898.8 12337.3 9431.2 9706.9 9837.3 9845.2 9875.6 7975.5 9220.8 9757.3 9873.5 9892.1 21:33:46 INFO - PROCESS | 1638 | -------- Summary: end -------- 21:33:46 INFO - PROCESS | 1638 | 21:33:46 INFO - TEST-INFO | 1638: exit 0 21:33:46 INFO - TEST-OK | dromaeo_css | took 1119381ms 21:33:46 INFO - TEST-START | kraken 21:33:46 INFO - operating with platform_type : mac_ 21:33:46 INFO - Initialising browser for kraken test... 21:33:46 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpI3BR9G/profile http://localhost:49235/getInfo.html) 21:33:49 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 21:33:49 INFO - PROCESS | 1644 | colorDepth:24 21:33:49 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 21:33:49 INFO - PROCESS | 1644 | __metrics 21:33:49 INFO - PROCESS | 1644 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:33:49 INFO - PROCESS | 1644 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:33:50 INFO - TEST-INFO | 1644: exit 0 21:33:50 INFO - Browser initialized. 21:33:50 INFO - Running cycle 1/1 for kraken test... 21:33:50 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpI3BR9G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:34:02 INFO - PROCESS | 1645 | RSS: Main: 239116288 21:34:02 INFO - PROCESS | 1645 | 21:34:05 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 21:34:06 INFO - PROCESS | 1645 | RSS: Main: 286744576 21:34:06 INFO - PROCESS | 1645 | 21:34:08 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 21:34:09 INFO - PROCESS | 1645 | RSS: Main: 297656320 21:34:09 INFO - PROCESS | 1645 | 21:34:12 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 21:34:13 INFO - PROCESS | 1645 | RSS: Main: 390811648 21:34:13 INFO - PROCESS | 1645 | 21:34:15 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 21:34:15 INFO - PROCESS | 1645 | RSS: Main: 292315136 21:34:15 INFO - PROCESS | 1645 | 21:34:17 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:34:18 INFO - PROCESS | 1645 | RSS: Main: 294727680 21:34:18 INFO - PROCESS | 1645 | 21:34:21 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 21:34:21 INFO - PROCESS | 1645 | RSS: Main: 334176256 21:34:21 INFO - PROCESS | 1645 | 21:34:24 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 21:34:25 INFO - PROCESS | 1645 | RSS: Main: 334966784 21:34:25 INFO - PROCESS | 1645 | 21:34:28 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 21:34:28 INFO - PROCESS | 1645 | RSS: Main: 331546624 21:34:28 INFO - PROCESS | 1645 | 21:34:30 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:34:30 INFO - PROCESS | 1645 | RSS: Main: 309071872 21:34:30 INFO - PROCESS | 1645 | 21:34:32 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:34:33 INFO - PROCESS | 1645 | RSS: Main: 312315904 21:34:33 INFO - PROCESS | 1645 | 21:34:35 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:34:36 INFO - PROCESS | 1645 | RSS: Main: 315518976 21:34:36 INFO - PROCESS | 1645 | 21:34:39 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:34:39 INFO - PROCESS | 1645 | RSS: Main: 326438912 21:34:39 INFO - PROCESS | 1645 | 21:34:42 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:34:43 INFO - PROCESS | 1645 | RSS: Main: 326668288 21:34:43 INFO - PROCESS | 1645 | 21:34:45 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 21:34:45 INFO - PROCESS | 1645 | RSS: Main: 370671616 21:34:45 INFO - PROCESS | 1645 | 21:34:45 INFO - PROCESS | 1645 | __start_tp_report 21:34:45 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 21:34:45 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 21:34:45 INFO - PROCESS | 1645 | |i|pagename|runs| 21:34:45 INFO - PROCESS | 1645 | |0;ai-astar;115;115;115;114;114;114;114;116;115;115 21:34:45 INFO - PROCESS | 1645 | |1;audio-beat-detection;145;110;110;139;112;112;112;108;142;110 21:34:45 INFO - PROCESS | 1645 | |2;audio-dft;185;185;184;182;185;185;198;266;196;184 21:34:45 INFO - PROCESS | 1645 | |3;audio-fft;81;60;60;90;62;59;61;58;83;58 21:34:45 INFO - PROCESS | 1645 | |4;audio-oscillator;85;72;95;69;67;70;92;68;69;93 21:34:45 INFO - PROCESS | 1645 | |5;imaging-gaussian-blur;90;87;90;89;90;85;91;88;89;87 21:34:45 INFO - PROCESS | 1645 | |6;imaging-darkroom;98;102;98;97;97;97;97;99;97;97 21:34:45 INFO - PROCESS | 1645 | |7;imaging-desaturate;82;83;81;82;95;129;128;84;82;82 21:34:45 INFO - PROCESS | 1645 | |8;json-parse-financial;57;55;56;53;57;59;58;59;58;58 21:34:45 INFO - PROCESS | 1645 | |9;json-stringify-tinderbox;72;71;65;76;73;71;71;73;75;72 21:34:45 INFO - PROCESS | 1645 | |10;stanford-crypto-aes;84;84;84;81;83;83;80;84;87;73 21:34:45 INFO - PROCESS | 1645 | |11;stanford-crypto-ccm;145;146;151;143;138;141;137;166;178;148 21:34:45 INFO - PROCESS | 1645 | |12;stanford-crypto-pbkdf2;156;167;166;164;165;164;163;162;164;166 21:34:45 INFO - PROCESS | 1645 | |13;stanford-crypto-sha256-iterative;69;68;67;67;67;67;67;67;65;68 21:34:45 INFO - PROCESS | 1645 | __end_tp_report 21:34:45 INFO - PROCESS | 1645 | __start_cc_report 21:34:45 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,2021 21:34:45 INFO - PROCESS | 1645 | __end_cc_report 21:34:45 INFO - PROCESS | 1645 | __startTimestamp1484026485270__endTimestamp 21:34:45 INFO - PROCESS | 1645 | 21:34:45 INFO - PROCESS | 1645 | ------- Summary: start ------- 21:34:45 INFO - PROCESS | 1645 | Number of tests: 14 21:34:45 INFO - PROCESS | 1645 | 21:34:45 INFO - PROCESS | 1645 | [#0] ai-astar Cycles:10 Average:114.70 Median:115.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 21:34:45 INFO - PROCESS | 1645 | Values: 115.0 115.0 115.0 114.0 114.0 114.0 114.0 116.0 115.0 115.0 21:34:45 INFO - PROCESS | 1645 | 21:34:45 INFO - PROCESS | 1645 | [#1] audio-beat-detection Cycles:10 Average:120.00 Median:112.00 stddev:15.30 (13.7%) stddev-sans-first:13.28 21:34:45 INFO - PROCESS | 1645 | Values: 145.0 110.0 110.0 139.0 112.0 112.0 112.0 108.0 142.0 110.0 21:34:45 INFO - PROCESS | 1645 | 21:34:45 INFO - PROCESS | 1645 | [#2] audio-dft Cycles:10 Average:195.00 Median:185.00 stddev:25.52 (13.8%) stddev-sans-first:26.81 21:34:45 INFO - PROCESS | 1645 | Values: 185.0 185.0 184.0 182.0 185.0 185.0 198.0 266.0 196.0 184.0 21:34:45 INFO - PROCESS | 1645 | 21:34:45 INFO - PROCESS | 1645 | [#3] audio-fft Cycles:10 Average:67.20 Median:61.50 stddev:12.32 (20.0%) stddev-sans-first:12.01 21:34:45 INFO - PROCESS | 1645 | Values: 81.0 60.0 60.0 90.0 62.0 59.0 61.0 58.0 83.0 58.0 21:34:45 INFO - PROCESS | 1645 | 21:34:45 INFO - PROCESS | 1645 | [#4] audio-oscillator Cycles:10 Average:78.00 Median:78.50 stddev:11.75 (15.0%) stddev-sans-first:12.18 21:34:45 INFO - PROCESS | 1645 | Values: 85.0 72.0 95.0 69.0 67.0 70.0 92.0 68.0 69.0 93.0 21:34:45 INFO - PROCESS | 1645 | 21:34:45 INFO - PROCESS | 1645 | [#5] imaging-gaussian-blur Cycles:10 Average:88.60 Median:89.50 stddev:1.84 (2.1%) stddev-sans-first:1.88 21:34:45 INFO - PROCESS | 1645 | Values: 90.0 87.0 90.0 89.0 90.0 85.0 91.0 88.0 89.0 87.0 21:34:45 INFO - PROCESS | 1645 | 21:34:45 INFO - PROCESS | 1645 | [#6] imaging-darkroom Cycles:10 Average:97.90 Median:97.00 stddev:1.60 (1.6%) stddev-sans-first:1.69 21:34:45 INFO - PROCESS | 1645 | Values: 98.0 102.0 98.0 97.0 97.0 97.0 97.0 99.0 97.0 97.0 21:34:45 INFO - PROCESS | 1645 | 21:34:45 INFO - PROCESS | 1645 | [#7] imaging-desaturate Cycles:10 Average:92.80 Median:82.00 stddev:19.25 (23.5%) stddev-sans-first:20.01 21:34:45 INFO - PROCESS | 1645 | Values: 82.0 83.0 81.0 82.0 95.0 129.0 128.0 84.0 82.0 82.0 21:34:45 INFO - PROCESS | 1645 | 21:34:45 INFO - PROCESS | 1645 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:58.00 stddev:1.89 (3.3%) stddev-sans-first:2.00 21:34:45 INFO - PROCESS | 1645 | Values: 57.0 55.0 56.0 53.0 57.0 59.0 58.0 59.0 58.0 58.0 21:34:45 INFO - PROCESS | 1645 | 21:34:45 INFO - PROCESS | 1645 | [#9] json-stringify-tinderbox Cycles:10 Average:71.90 Median:72.50 stddev:2.96 (4.1%) stddev-sans-first:3.14 21:34:45 INFO - PROCESS | 1645 | Values: 72.0 71.0 65.0 76.0 73.0 71.0 71.0 73.0 75.0 72.0 21:34:45 INFO - PROCESS | 1645 | 21:34:45 INFO - PROCESS | 1645 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:84.00 stddev:3.77 (4.5%) stddev-sans-first:3.95 21:34:45 INFO - PROCESS | 1645 | Values: 84.0 84.0 84.0 81.0 83.0 83.0 80.0 84.0 87.0 73.0 21:34:45 INFO - PROCESS | 1645 | 21:34:45 INFO - PROCESS | 1645 | [#11] stanford-crypto-ccm Cycles:10 Average:149.30 Median:147.00 stddev:13.01 (8.9%) stddev-sans-first:13.71 21:34:45 INFO - PROCESS | 1645 | Values: 145.0 146.0 151.0 143.0 138.0 141.0 137.0 166.0 178.0 148.0 21:34:45 INFO - PROCESS | 1645 | 21:34:45 INFO - PROCESS | 1645 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.70 Median:164.50 stddev:3.09 (1.9%) stddev-sans-first:1.59 21:34:45 INFO - PROCESS | 1645 | Values: 156.0 167.0 166.0 164.0 165.0 164.0 163.0 162.0 164.0 166.0 21:34:45 INFO - PROCESS | 1645 | 21:34:45 INFO - PROCESS | 1645 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:1.03 (1.5%) stddev-sans-first:0.87 21:34:45 INFO - PROCESS | 1645 | Values: 69.0 68.0 67.0 67.0 67.0 67.0 67.0 67.0 65.0 68.0 21:34:45 INFO - PROCESS | 1645 | -------- Summary: end -------- 21:34:45 INFO - PROCESS | 1645 | 21:34:46 INFO - TEST-INFO | 1645: exit 0 21:34:46 INFO - TEST-OK | kraken | took 59601ms 21:34:46 INFO - SUITE-END | took 1178s 21:34:46 INFO - Completed test suite (00:19:39) 21:34:46 INFO - javascript benchmark 21:34:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3267.950980735289, 3294.868205271789, 3327.48423994281, 3338.265581572053, 3373.3421982713367, 5531.778728850846, 5587.916181257279, 5590.496855283024, 5600.52395546378, 5611.186377975197, 5524.254225679532, 5581.162825576165, 5599.356074051485, 5599.916001259984, 5652.773889044433, 5075.441701412851, 5087.262346959688, 5104.617153713468, 5164.612654050942, 5213.921791173136, 5081.8221362252325, 5084.618653600995, 5114.693118412907, 5162.1482455395, 5179.896402071975, 5117.513836185556, 5150.1759718445055, 5160.741962901859, 5184.326037615105, 5189.455107213745, 5111.2333150027425, 5125.154349532323, 5134.0758663440565, 5148.485151484859, 5176.197689358156, 4058.5535591085254, 5064.189729643276, 5129.948700512984, 5133.614978876599, 5141.5115564021735, 5466.590005749585, 5500.367457742331, 5528.06022976095, 5540.445955404468, 5560.2493663355335, 6043.093535969596, 6119.388061193845, 6129.785457508966, 6130.887362651042, 6139.969300153471, 6178.581052085296, 6198.194234749454, 6199.473044791198, 6219.87560248797, 6236.594621349643, 5455.890882182334, 5520.06158952979, 5520.337559492887, 5701.087825947829, 5714.771409143629, 6219.284782250009, 6276.592021518678, 6302.747890084437, 6323.0, 6339.366063393623, 5975.462208401264, 5981.581289309706, 5982.551308651781, 5992.58051936369, 6029.909551356734, 5048.7728052237735, 6010.579259451796, 6032.245969253843, 6174.845628859224, 6204.751809927642, 5908.497777688945, 5981.491573216325, 5994.67029313392, 6037.396260374016, 6054.39456054391, 6114.052321890114, 6115.969420152871, 6117.388261173847, 6117.785877494266, 6122.479589234876, 4834.806607735722, 4864.294677271776, 4865.489123642037, 4866.31871537985, 4888.26675998596, 4165.166966606691, 4177.26897792885, 4216.47294088239, 4298.290782020994, 4311.978440107842, 5561.221428999943, 5561.58288128392, 5606.243157173811, 5636.070048442043, 5646.0, 6148.600340977822, 6148.877022459616, 6156.846078848064, 6165.383461653799, 6171.691415429211, 5479.150731636602, 5495.340559132929, 5567.66594004361, 5583.692896890629, 5590.748416321276, 5243.9213411798855, 5246.921296180561, 5281.15501519755, 5325.147976323847, 5343.67937923718, 6253.593516421418, 6302.054691796084, 6365.872682546323, 6375.681215939092, 6377.394147555975, 4872.829450969199, 6213.471854892385, 6214.533909956681, 6226.283977342664, 6240.4071613196675, 6129.175413489998, 6182.072689096672, 6185.319614842274, 6236.844467942761, 6265.185525881606, 5984.251968503937, 5986.790462333797, 5999.790007349722, 6008.1588577598295, 6027.156198132353, 6040.275166979991, 6088.147659327609, 6097.634141951497, 6099.786507472217, 6124.724387402666, 5723.627964182481, 5757.5681823864215, 5768.365479797303, 5834.737436815269, 5862.149988251595, 5895.64626122434, 5899.351071382059, 5900.43945825146, 5909.645421274738, 5923.881522369615, 5668.546516278605, 5738.540916726735, 5741.511971482304, 5742.0, 5752.0, 4672.9532704673875, 5575.442455754554, 5619.971900140473, 5761.308642962704, 5901.734421950937, 4836.516348365135, 5662.943370566241, 5801.854953626024, 5804.303483581997, 5809.157672137432], "value": 5548.850448853464, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.83936329942975, 506.7111746304606, 510.55581643969754, 523.3353640876085, 593.6764463367464, 26356.86821565892, 31418.842905785496, 31482.52776208356, 31492.740290388385, 31561.68438315616, 40772.59227407725, 41930.58069419305, 41933.58066419335, 42960.78519607405, 43137.137257254835, 9055.275577953764, 9215.95392023039, 9220.5850736717, 9239.907600923972, 9241.49171795551, 9195.816083678323, 9275.721728348126, 9279.443233405984, 9296.070392960717, 9299.95350023249, 9251.814963700723, 9309.301802364816, 9309.975902650704, 9315.953420232889, 9331.860022099674, 9160.717499550068, 9196.770080747969, 9272.999999999965, 9281.489518076503, 9286.90713092874, 7816.8827467588035, 8927.910720892838, 8930.687425940127, 9014.684486042957, 9158.404703694305, 38568.80715596404, 39012.41481377782, 39057.609423905684, 39127.60872391296, 39175.80412097921, 3055.3125546752026, 3067.2025273428844, 3193.1857376368876, 3346.665333466658, 3403.149212696826, 28889.855550722114, 29150.0, 29339.266518337212, 29802.254943626365, 29969.70030299691, 3163.335699503107, 3172.730317922956, 3213.7268332191793, 3225.225945773021, 3290.2596915694016, 345424.0, 357202.0, 381573.0, 382819.0, 383105.0, 58234.0, 58438.41561584415, 58605.41394586, 58606.41393586095, 58810.70594646999, 34489.82755086259, 35213.64786352104, 35554.46668299977, 35866.0, 35907.4613880792, 15504.30230639624, 15642.374305027672, 15649.217539122998, 15656.608584785243, 15692.0, 11897.70255743596, 11899.643010709693, 11930.403479825975, 11937.403129843473, 11954.342511161969, 18801.435956921316, 18838.811611883706, 18869.62260754777, 18931.716024259647, 18939.90530047341, 7749.690012399554, 7910.644021019068, 7927.5243485391065, 8006.919930800617, 8051.315638170821, 848.1815048478124, 912.0879120879121, 930.1303281431748, 988.2341185581089, 991.3062442380284, 28770.136895893156, 29035.0, 29810.55284170739, 29867.551986720217, 30424.54363184554, 857.2242120880613, 864.4985908173245, 1068.257560995101, 1082.3451811653993, 1110.294962698676, 14468.855311446961, 15048.849511504965, 15089.094654320776, 15347.539573812803, 15356.232188390535, 661730.0, 666244.0, 666296.0, 666772.0, 667980.0, 57604.0, 57831.71084144552, 57953.0, 58097.70951145217, 58174.0, 1234.4259919137644, 1267.0, 1349.048920511057, 1362.4958765256918, 1392.046448182998, 29867.0, 30241.2841984938, 30720.0, 30947.0, 31306.68693313129, 49304.01391972212, 49906.50093499019, 49996.25005624991, 50034.0, 50111.0, 528468.0, 529677.0, 531630.0, 532015.0, 669559.0, 39759.403608946464, 40727.79636101801, 41551.96120097022, 41574.96062598459, 41753.58246417497, 44982.325265121704, 45094.0, 45112.09775804531, 45124.0975180488, 45402.31896521621, 37021.62978370182, 37147.62852371442, 37953.051173719774, 38891.0, 38951.22097557976, 37219.00693012721, 37548.43677344787, 38060.619393805704, 38268.61731382762, 38916.61083389243, 36271.818640906626, 36703.0, 37265.25469490541, 37639.81180094082, 37791.811040944616, 32294.677053229167, 33905.0, 34264.44505508251, 34487.0, 34613.480797787546, 24891.50216995686, 25047.248582542554, 25115.0, 25435.0, 25713.971441142894], "value": 19236.249809848046, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.42568737741, 330.1350461790107, 342.39054483020215, 357.8157249016756, 399.18566125104786, 15098.924505377472, 16003.839961600395, 19304.324348647784, 19651.410457686292, 20410.693839592383, 19857.0, 20282.898585507053, 20392.0, 20425.387238382835, 20592.8970355148, 4632.934425082233, 5809.622374545662, 5968.224130862982, 5978.22283103196, 5978.432048955342, 5626.268585083933, 5842.357340692521, 5877.559183061266, 5890.440408161217, 5926.111083337512, 5839.5620328475325, 5844.415558444164, 5844.736986835603, 5845.824625261249, 5853.736581853806, 5575.749091290902, 5759.798407055775, 5823.79616713413, 5829.067349224104, 5842.5618078644275, 5124.128898087334, 5126.359205099363, 5127.9230811537855, 5132.28148059272, 5136.409312929024, 24673.0, 24783.88472518723, 24887.875560622262, 24962.251132465874, 25246.62130068032, 2268.7164104486938, 2404.7354790972977, 2425.866577338246, 2599.5450796110604, 2760.4479104179045, 14500.492482763053, 15172.620684482867, 15334.0, 15741.527754167393, 15891.92054039734, 1770.530809335527, 1824.4617837737899, 1827.0316732131992, 1852.2961274715656, 1914.349121298765, 112891.0, 118144.0, 120278.0, 121283.3935830324, 121611.39194304061, 10499.68500944973, 10531.420771857469, 10603.575856965635, 10629.0, 11005.504752286166, 13477.989150813728, 13656.317184140753, 13806.309684515734, 13844.930775346058, 13854.792178117335, 8271.2142346477, 8339.291160251447, 8359.623816928131, 8364.330853531703, 8503.234708876107, 8268.338532917352, 8316.251537361666, 8426.862373579488, 8440.155984401634, 8504.532250726146, 6539.051837483538, 6544.280129185786, 6675.365840245266, 6678.232003319583, 6688.097106890605, 1523.2612183091192, 1769.991060146717, 1808.7467754514378, 1814.219885449243, 1816.7456556082159, 851.5784686580058, 954.370115723619, 974.2254907348674, 1012.1801340913884, 1023.3552861697083, 21890.0, 22353.776462235168, 22421.55156896853, 22468.101275949106, 22580.0, 959.9616015359308, 974.2449601558849, 999.915092125038, 1011.4942528735633, 1022.0954455306958, 10188.134008609202, 10565.151098557722, 10921.508532116073, 11429.771404571862, 11528.711782205512, 572857.6285422804, 584878.0, 590661.0466947723, 595606.0, 600557.0, 113207.0, 115902.8409715909, 117761.05597359964, 120598.0, 120826.0, 947.2611363136764, 976.702105857706, 992.771662517625, 993.4039576254189, 993.557866749304, 18224.45326640203, 19316.034198290312, 19687.507812304808, 19722.915239661957, 19754.81471111738, 51630.967380652924, 52521.0, 52559.0, 52814.47185528249, 53779.462205377444, 67626.0, 69610.0, 69990.65004675147, 70373.0, 70638.94041589278, 6880.552764070319, 7350.154732205651, 7399.186089530255, 7572.962135189288, 8355.0, 11749.29504229749, 11922.284662919905, 12000.63998080059, 12677.30274834893, 12810.295433751233, 9332.580033898626, 10809.297395669257, 11007.944960275468, 11275.041621462267, 11320.320780753182, 10791.892081079088, 10955.452227388758, 10968.561257549609, 11311.264767790068, 11384.089272858317, 10652.786944260917, 10887.727806804893, 11217.943910280723, 11708.004819590431, 11719.0, 8111.067227268703, 8148.592570371577, 8150.592470376576, 8336.791580210544, 8367.456115352483, 9751.60993560278, 10935.125189984941, 10979.725506862393, 11072.889271107508, 11128.888711112786], "value": 9592.761108657263, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1319.8548159702436, 1411.0968979852896, 1446.4503488674302, 1489.9925500372497, 1820.3719716697735, 7419.777406677795, 7734.265244801742, 7919.445638805286, 8268.710595129156, 8306.83386332273, 7734.613269336539, 7966.760997170094, 7971.003624546932, 7981.600919953994, 7984.24149705777, 1937.3994061840804, 2281.634938409859, 2321.6401457774073, 2327.8836058197107, 2328.790408863202, 2313.4910319729715, 2361.445060410802, 2371.122684606698, 2373.32360277321, 2376.1089591403224, 2304.458452263725, 2328.557574060923, 2339.578875802355, 2340.2979106268053, 2343.179887039531, 1897.8671492995495, 1916.597514521952, 2271.284545368212, 2302.1712183613886, 2305.654151877232, 2328.1153161798406, 2345.812335013195, 2350.17743789674, 2354.8587084774967, 2354.929352119439, 8039.07550631679, 8217.753467395987, 8243.216894395024, 8255.380846436541, 8260.463069900497, 5043.646944713872, 5211.530962213381, 5227.085260079509, 5236.188390799432, 5247.606429517801, 2904.4917139500712, 3541.8937431877084, 3547.4146765783617, 3600.963990360089, 3617.222297206087, 1077.3212875888141, 1098.6703988803326, 1413.441690532234, 1731.203646322693, 1820.8543316534644, 10484.161267098614, 10696.358218506915, 10700.14398848098, 10702.946485267601, 10725.570977160904, 4618.930716039262, 4626.329182268552, 4678.1813182692895, 4724.385829842098, 4732.0, 9371.625134994523, 9378.343515953955, 9387.62449502026, 9388.718338449857, 9391.342606017513, 5206.349206349207, 5206.453322401169, 5218.478152184827, 5219.451957544479, 5228.424873263938, 4031.737937034083, 4274.572542745763, 4430.645548356124, 4691.929621055687, 4767.713937163781, 3120.625524937022, 3832.137769002008, 3896.376579747227, 3921.215756848642, 3934.213157368538, 1234.3026190202686, 1248.4881198708485, 1251.4931452761646, 1263.7030297879992, 1263.7788387032233, 798.7124635131464, 815.0097631377904, 895.0870112485229, 909.5179554835947, 917.4862077236769, 4790.01804630057, 5277.287566178594, 5349.598780091509, 5496.422875598005, 5604.6917419542315, 443.3726277317624, 448.15299084729884, 458.7178884985776, 729.7810656802938, 1015.6902144845893, 3148.937021259562, 3329.550510681027, 3488.860445582199, 3600.2439487707875, 3621.0, 9803.509824508888, 10058.446785426871, 10160.23798215122, 10193.847092293621, 10231.48842557884, 10116.949415252877, 10124.493775311204, 10129.240306977006, 10130.544125514369, 10136.695899123039, 7174.426045916314, 7387.409007279405, 7595.620218989028, 7690.461667683208, 7706.73026444083, 5427.918581221206, 5553.194786755817, 5558.944410555842, 5630.971845140748, 5793.188953546422, 9131.360804743605, 9298.674546390845, 9339.346245763003, 9423.19902808269, 9440.622375104918, 8034.718784842503, 8560.91439085626, 9244.907550924405, 9448.007959164188, 9464.668736594185, 7072.151341839012, 7097.680604372919, 7211.747588834365, 7256.2018178001435, 7267.7819665410125, 7149.60677162761, 7299.927000729925, 7762.5730584818375, 7856.175101614248, 7859.52842829432, 7005.474589405917, 7083.539569927938, 7132.750353737594, 7138.357547820721, 7270.890936635848, 5768.336641286306, 6976.476764242803, 6978.441724662116, 6980.336867997532, 7042.7887163385185, 6521.380468855451, 6574.638394888136, 6656.866862662623, 6684.799456016327, 6693.966530167318, 4798.640101992295, 4826.203676393356, 4848.80604775805, 4903.828366007173, 4944.381952255968, 4453.599176074169, 4498.8425405111975, 4611.216093264086, 4614.054118905683, 4759.833405830779], "value": 4333.4285173028475, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.3075039033466, 303.8374469658733, 304.79121801565924, 310.93314937288477, 314.63816610897453, 4480.661906879372, 5214.348206474191, 5227.634065615413, 5263.842084737464, 5270.841874743759, 4593.655475839317, 4892.951070489294, 5059.949400505994, 5131.767681058742, 5138.845834624958, 3743.929977418518, 3831.578526362098, 3852.614738526139, 3910.0, 3938.940915886264, 3660.450932360154, 3878.941815872764, 3910.804459777014, 3915.4714113594587, 3971.7616942983514, 3337.1657085728566, 3865.5747867734526, 3877.8448862045484, 3893.9221215575812, 3920.607939206085, 3312.287858110518, 3511.455724362728, 3543.9291214175573, 3914.5693973662874, 3944.6252606002386, 3409.710174635134, 3422.9657703422895, 3447.77589456687, 3450.3783221885674, 3458.39478091333, 4055.9797201013807, 4288.842012656565, 4548.749818759967, 4985.651004429691, 5014.648974571782, 4289.399484072233, 4434.337123578658, 4447.710898791568, 4456.3538286948215, 4457.130859482402, 4626.58360747531, 5270.736463176864, 5302.761375738101, 5315.033437628103, 5341.359036915556, 3135.2945587242916, 3757.3236817372863, 3775.2449510097817, 3792.412176112707, 3797.791121488317, 5394.703291319015, 5617.915731263994, 5639.520640745542, 5641.445889089847, 5719.71401429931, 3166.9683303167135, 3770.604876195825, 3809.5238095238096, 3825.024618722208, 3843.7706130444276, 3880.941785873214, 3886.8639597613947, 3893.8053097345587, 3901.668358189529, 3910.354791459434, 3334.0, 3674.254729003755, 3740.1023754299317, 4458.308962110878, 4493.865184044484, 4317.352397140454, 4677.906441871143, 4871.926921096187, 5297.437256009486, 5439.864003399867, 1116.8268918317674, 1194.832723418722, 1198.5086114692933, 1260.9936950315373, 1262.5013119817804, 824.4599787139433, 835.9832803343899, 865.5455885659953, 869.6434461870729, 877.2674816528142, 4730.692504987165, 4789.976050119797, 4886.706797592155, 4895.7062576245535, 4914.36113305268, 4819.7108173509705, 5471.781128754885, 5483.666365348029, 5497.47773961473, 5500.889982200333, 4197.643200327945, 4973.458227949275, 4994.975025124923, 4995.001999200349, 5050.0, 2600.54490464168, 2613.359726866892, 2661.4144888124583, 2734.3164208947765, 2750.0, 4441.666874984389, 4555.840545580955, 5305.0, 5310.575153987672, 5473.9325831463275, 4954.628402869799, 5327.973360133252, 5335.439778823245, 5362.463753624685, 5432.674039557639, 4752.360435649695, 5225.738713064332, 5280.732624170171, 5298.894022119536, 5327.786888524415, 5020.422651395136, 5148.382194136728, 5155.0, 5226.895462090661, 5262.789488420573, 4767.523247675204, 4832.565069143794, 5162.483751624807, 5220.817271395483, 5264.447233040476, 5006.374203224597, 5216.165413533817, 5464.26232458613, 5482.038754926798, 5482.972585137049, 3092.567040614271, 3493.8206232329476, 3579.624139465423, 3657.5428071491065, 3659.0852286928266, 4905.285715690084, 5189.299444575085, 5200.245964335075, 5202.918832467043, 5255.687497501087, 4177.496101403553, 4811.1820990431015, 4969.627277954096, 5013.623978201723, 5037.496250374933, 4812.25410061441, 4988.725620090785, 4995.402390756713, 5007.119482401168, 5025.874353141055, 4123.670106391542, 4259.97870010648, 4789.880252993703, 4812.614990800657, 4903.0, 5092.745362731923, 5282.656627319212, 5293.9205911910585, 5328.014317351302, 5387.703676297684, 5098.0, 5231.346081739783, 5243.606729495227, 5249.632525723163, 5252.7898884045735], "value": 3847.350497977513, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.5191488086017, 685.773694680755, 719.2304234469118, 723.2767232767233, 750.1036261667309, 13863.23752193629, 14337.426502939896, 14338.42646294147, 14359.35382907769, 14362.928185359071, 12599.0, 12683.175593586411, 12728.61814145577, 12738.0, 12745.936270318658, 635.8982562789954, 663.141232104426, 667.9031540426636, 804.9798755031112, 815.4984684419098, 799.2087833045301, 821.8931538899965, 823.9052508961486, 823.9217274358926, 830.6345208108413, 868.587420975035, 870.4603146049458, 871.6208449324564, 873.7204094689702, 873.8252349530088, 669.7454967112515, 695.523566357047, 821.8191997760483, 851.7189327521903, 865.3596338709373, 643.2570381209711, 643.5045015338163, 644.8742495213435, 645.1000853808957, 645.6223109480959, 13963.441462341494, 14106.224157671324, 14117.294135293298, 14124.435022599084, 14162.575122746333, 13035.543755968496, 13103.737925241441, 13202.933985330108, 13247.07270491066, 13340.33298335089, 12021.0, 12237.143399962006, 12324.32216228107, 12351.505939762399, 12670.493180272779, 4384.408104905829, 4393.297072468422, 4417.867463976054, 4431.335299705038, 4578.656600754956, 78830.0, 80699.5965020177, 81196.0, 85226.14773852307, 93177.06822931752, 10906.72733181661, 10944.890551094546, 11015.724606884733, 11115.777684446428, 11164.609238676607, 21256.893715531325, 21287.574248514942, 21497.67753483699, 21580.89209553942, 21587.2444464443, 7646.732364367221, 7853.371730261565, 7889.723859664999, 8137.837243255101, 8146.959265203636, 4219.6202341789385, 4237.576242375738, 4304.246756817544, 4367.541408152162, 4380.452443444569, 3375.8987230383127, 3477.530533378012, 3481.89554313371, 3499.807510586942, 3503.2292895562937, 460.3348161906014, 640.2796853539768, 646.3697894552773, 646.4214527997416, 648.1185587600859, 486.6714967396993, 566.1931747260138, 580.5036693626972, 596.3172167867767, 624.1262232873922, 7045.921453171327, 8509.744707658656, 8679.435836670596, 8786.956065219632, 8988.235999939947, 567.3447168520365, 590.3859985614912, 597.6066004311041, 641.0800501280677, 666.1406785247074, 4262.168877069003, 4397.978010109929, 4451.198784218807, 4466.687331886802, 4479.602079494267, 61967.690161548904, 78284.0, 100592.0, 110499.89500104896, 117052.41473792576, 92124.0, 96671.0, 97093.51453242688, 99667.00332996722, 104965.47517262364, 79928.0, 81685.18314816894, 83664.58167709244, 84367.0, 84918.5754071238, 8274.627641756257, 8518.78703032429, 8524.659013639633, 8568.143185681382, 8723.389362744547, 52224.47775522196, 54008.0, 54452.455475446324, 54878.0, 55274.72362638322, 70708.0, 73939.0, 74859.25140748522, 75705.62147189229, 76178.0, 11500.884991150317, 11513.424328783694, 11767.88232117668, 11813.645590632295, 11869.347185904859, 11883.940580297043, 12014.519419223134, 12153.392330383269, 12258.20321679088, 12650.936745316214, 11654.533818647498, 11904.285742855456, 11917.225380350596, 12115.636530904087, 12203.389830508617, 11599.0, 11756.294622322688, 11827.586034488751, 12065.698357541132, 12093.57672481459, 11100.500477478694, 11400.087992960709, 11553.942230288794, 11898.821517677416, 12337.259764414164, 9431.245500359817, 9706.9029309706, 9837.262205334486, 9845.163161131384, 9875.604975800887, 7975.481593696391, 9220.815583688423, 9757.26820488452, 9873.456959867277, 9892.060254275832], "value": 7056.188046299233, "unit": "score"}], "name": "dromaeo_css", "value": 7027.703444532403, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 115.0, 114.0, 114.0, 114.0, 114.0, 116.0, 115.0, 115.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 110.0, 110.0, 139.0, 112.0, 112.0, 112.0, 108.0, 142.0, 110.0], "value": 120.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 184.0, 182.0, 185.0, 185.0, 198.0, 266.0, 196.0, 184.0], "value": 195.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 60.0, 90.0, 62.0, 59.0, 61.0, 58.0, 83.0, 58.0], "value": 67.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 72.0, 95.0, 69.0, 67.0, 70.0, 92.0, 68.0, 69.0, 93.0], "value": 78.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 90.0, 89.0, 90.0, 85.0, 91.0, 88.0, 89.0, 87.0], "value": 88.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 102.0, 98.0, 97.0, 97.0, 97.0, 97.0, 99.0, 97.0, 97.0], "value": 97.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 81.0, 82.0, 95.0, 129.0, 128.0, 84.0, 82.0, 82.0], "value": 92.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 56.0, 53.0, 57.0, 59.0, 58.0, 59.0, 58.0, 58.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 65.0, 76.0, 73.0, 71.0, 71.0, 73.0, 75.0, 72.0], "value": 71.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 81.0, 83.0, 83.0, 80.0, 84.0, 87.0, 73.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 151.0, 143.0, 138.0, 141.0, 137.0, 166.0, 178.0, 148.0], "value": 149.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 167.0, 166.0, 164.0, 165.0, 164.0, 163.0, 162.0, 164.0, 166.0], "value": 163.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 65.0, 68.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1445.6, "alertThreshold": 2.0}]} 21:34:46 INFO - Return code: 0 21:34:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:34:46 INFO - # TBPL SUCCESS # 21:34:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:34:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:34:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:34:46 INFO - 2017-01-09 21:34:46.603 screenresolution[1649:10421] starting screenresolution argv=screenresolution get 21:34:46 INFO - 2017-01-09 21:34:46.606 screenresolution[1649:10421] Display 0: 1600x1200x32@60 21:34:46 INFO - 2017-01-09 21:34:46.612 screenresolution[1650:10424] starting screenresolution argv=screenresolution list 21:34:46 INFO - Available Modes on Display 0 21:34:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:34:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:34:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:34:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:34:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:34:46 INFO - Intel Iris: 21:34:46 INFO - Chipset Model: Intel Iris 21:34:46 INFO - Type: GPU 21:34:46 INFO - Bus: Built-In 21:34:46 INFO - VRAM (Dynamic, Max): 1536 MB 21:34:46 INFO - Vendor: Intel (0x8086) 21:34:46 INFO - Device ID: 0x0a2e 21:34:46 INFO - Revision ID: 0x0009 21:34:46 INFO - Displays: 21:34:46 INFO - Display: 21:34:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:34:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:34:46 INFO - Display Serial Number: 1600x1200 60 21:34:46 INFO - Main Display: Yes 21:34:46 INFO - Mirror: Off 21:34:46 INFO - Online: Yes 21:34:46 INFO - Rotation: Supported 21:34:46 INFO - Return code: 0 21:34:46 INFO - Running post-action listener: _resource_record_post_action 21:34:46 INFO - [mozharness: 2017-01-10 05:34:46.859517Z] Finished run-tests step (success) 21:34:46 INFO - Running post-run listener: _resource_record_post_run 21:34:46 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 33528832; Write bytes: 660752384; Read time: 313; Write time: 1905 21:34:46 INFO - TinderboxPrint: CPU usage
53.3% 21:34:46 INFO - TinderboxPrint: I/O read bytes / time
33,528,832 / 313 21:34:46 INFO - TinderboxPrint: I/O write bytes / time
660,752,384 / 1,905 21:34:46 INFO - TinderboxPrint: CPU idle
2,260.5 (46.6%) 21:34:46 INFO - TinderboxPrint: CPU system
970.8 (20.0%) 21:34:46 INFO - TinderboxPrint: CPU user
1,614.5 (33.3%) 21:34:46 INFO - TinderboxPrint: Swap in / out
378,261,504 / 0 21:34:46 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 338899456; Write bytes: 334936064; Read time: 26827; Write time: 624 21:34:46 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 32553984; Write bytes: 308113408; Read time: 296; Write time: 1204 21:34:47 INFO - Running post-run listener: _upload_blobber_files 21:34:47 INFO - Blob upload gear active. 21:34:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:34:47 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 21:34:47 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'] 21:34:47 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 21:34:47 INFO - (blobuploader) - INFO - Open directory for files ... 21:34:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:34:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:34:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:34:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:34:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:34:48 INFO - (blobuploader) - INFO - Done attempting. 21:34:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:34:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:34:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:34:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:34:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:34:49 INFO - (blobuploader) - INFO - Done attempting. 21:34:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:34:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:34:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:34:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:34:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:34:51 INFO - (blobuploader) - INFO - Done attempting. 21:34:51 INFO - (blobuploader) - INFO - Iteration through files over. 21:34:51 INFO - Return code: 0 21:34:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:34:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:34:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/867d00b8cd3f06fb8cd8377ce2bec7654cb38ece8ca823d66406450d8d354db0f29fcf8c68abe5ba655ea4db5ba3fbaa98bb5affdde75d24a3a259fbdc9255a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b304489824f939d789d900d3cb0f76c448d413e59e0446feee27f5efd8dc34d27aa0265196261e049d2fc6fe3beb4ea0eeffc52566ebdcc501a9d997e5aa95f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e9641fa8ac0d6c25ca5e5a1ada329fa0a688b60290e019bcad80f45949060450850734b4596afc316f4969fcd73071e56782f7ec8fa94b6a958cd72b2a903c34"} 21:34:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:34:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:34:51 INFO - Contents: 21:34:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/867d00b8cd3f06fb8cd8377ce2bec7654cb38ece8ca823d66406450d8d354db0f29fcf8c68abe5ba655ea4db5ba3fbaa98bb5affdde75d24a3a259fbdc9255a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b304489824f939d789d900d3cb0f76c448d413e59e0446feee27f5efd8dc34d27aa0265196261e049d2fc6fe3beb4ea0eeffc52566ebdcc501a9d997e5aa95f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e9641fa8ac0d6c25ca5e5a1ada329fa0a688b60290e019bcad80f45949060450850734b4596afc316f4969fcd73071e56782f7ec8fa94b6a958cd72b2a903c34"} 21:34:51 INFO - Running post-run listener: copy_logs_to_upload_dir 21:34:51 INFO - Copying logs to upload dir... 21:34:51 INFO - mkdir: /builds/slave/test/build/upload/logs 21:34:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.428935 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2017-01-09 21:34:51.692263) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 21:34:51.696230) ========= 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.sTy2lP05LE/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.8jSyTwY8sf/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/867d00b8cd3f06fb8cd8377ce2bec7654cb38ece8ca823d66406450d8d354db0f29fcf8c68abe5ba655ea4db5ba3fbaa98bb5affdde75d24a3a259fbdc9255a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b304489824f939d789d900d3cb0f76c448d413e59e0446feee27f5efd8dc34d27aa0265196261e049d2fc6fe3beb4ea0eeffc52566ebdcc501a9d997e5aa95f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e9641fa8ac0d6c25ca5e5a1ada329fa0a688b60290e019bcad80f45949060450850734b4596afc316f4969fcd73071e56782f7ec8fa94b6a958cd72b2a903c34"} build_url:https://queue.taskcluster.net/v1/task/HqIf4kSiTxSu_98az9YCCw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010960 build_url: 'https://queue.taskcluster.net/v1/task/HqIf4kSiTxSu_98az9YCCw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/867d00b8cd3f06fb8cd8377ce2bec7654cb38ece8ca823d66406450d8d354db0f29fcf8c68abe5ba655ea4db5ba3fbaa98bb5affdde75d24a3a259fbdc9255a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b304489824f939d789d900d3cb0f76c448d413e59e0446feee27f5efd8dc34d27aa0265196261e049d2fc6fe3beb4ea0eeffc52566ebdcc501a9d997e5aa95f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e9641fa8ac0d6c25ca5e5a1ada329fa0a688b60290e019bcad80f45949060450850734b4596afc316f4969fcd73071e56782f7ec8fa94b6a958cd72b2a903c34"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 21:34:51.731099) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 21:34:51.731470) ========= 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.sTy2lP05LE/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.8jSyTwY8sf/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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.005175 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 21:34:51.781146) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 21:34:51.781529) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 21:34:51.781917) ========= ========= Total master_lag: 0.19 =========