builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0357 starttime: 1479491934.92 results: success (0) buildid: 20161118074928 builduid: bc1731146fac4991b29c8a60d76a2f4c revision: 6186126f502ba47e4fb2b6f4d971ea6fd3e66a02 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 09:58:54.918003) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 09:58:54.918424) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 09:58:54.918698) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 09:58:54.943839) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 09:58:54.944153) ========= 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.RVs8bfd85M/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.txDobCJWS6/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-18 09:58:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 147M=0s 2016-11-18 09:58:55 (147 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.081891 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 09:58:55.048685) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 09:58:55.049016) ========= 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.RVs8bfd85M/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.txDobCJWS6/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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.024234 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 09:58:55.097660) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-18 09:58:55.098023) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6186126f502ba47e4fb2b6f4d971ea6fd3e66a02 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 6186126f502ba47e4fb2b6f4d971ea6fd3e66a02 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RVs8bfd85M/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.txDobCJWS6/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-18 09:58:55,203 truncating revision to first 12 chars 2016-11-18 09:58:55,203 Setting DEBUG logging. 2016-11-18 09:58:55,203 attempt 1/10 2016-11-18 09:58:55,203 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6186126f502b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-18 09:58:56,170 unpacking tar archive at: mozilla-central-6186126f502b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.234163 ========= master_lag: 0.24 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-18 09:58:56.577154) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 09:58:56.577563) ========= script_repo_revision: 6186126f502ba47e4fb2b6f4d971ea6fd3e66a02 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 09:58:56.577991) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 09:58:56.578284) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 09:58:56.596271) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-11-18 09:58:56.596649) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RVs8bfd85M/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.txDobCJWS6/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 09:58:56 INFO - MultiFileLogger online at 20161118 09:58:56 in /builds/slave/test 09:58:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:58:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:58:56 INFO - {'append_to_log': False, 09:58:56 INFO - 'base_work_dir': '/builds/slave/test', 09:58:56 INFO - 'blob_upload_branch': 'Firefox', 09:58:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:58:56 INFO - 'branch': 'Firefox', 09:58:56 INFO - 'buildbot_json_path': 'buildprops.json', 09:58:56 INFO - 'config_files': ('talos/mac_config.py',), 09:58:56 INFO - 'default_actions': ('clobber', 09:58:56 INFO - 'read-buildbot-config', 09:58:56 INFO - 'download-and-extract', 09:58:56 INFO - 'populate-webroot', 09:58:56 INFO - 'create-virtualenv', 09:58:56 INFO - 'install', 09:58:56 INFO - 'run-tests'), 09:58:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:58:56 INFO - 'download_minidump_stackwalk': True, 09:58:56 INFO - 'download_symbols': 'ondemand', 09:58:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:58:56 INFO - 'tooltool.py': '/tools/tooltool.py', 09:58:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:58:56 INFO - '/tools/misc-python/virtualenv.py')}, 09:58:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:58:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:58:56 INFO - 'installer_path': 'installer.exe', 09:58:56 INFO - 'log_level': 'info', 09:58:56 INFO - 'log_name': 'talos', 09:58:56 INFO - 'log_to_console': True, 09:58:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:58:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:58:56 INFO - 'opt_config_files': (), 09:58:56 INFO - 'pip_index': False, 09:58:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:58:56 INFO - 'cmd': ('bash', 09:58:56 INFO - '-c', 09:58:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:58:56 INFO - 'enabled': True, 09:58:56 INFO - 'halt_on_failure': False, 09:58:56 INFO - 'name': 'check_screen_resolution'},), 09:58:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:58:56 INFO - 'cmd': ('bash', 09:58:56 INFO - '-c', 09:58:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:58:56 INFO - 'enabled': True, 09:58:56 INFO - 'halt_on_failure': False, 09:58:56 INFO - 'name': 'check_screen_resolution'},), 09:58:56 INFO - 'run_cmd_checks_enabled': True, 09:58:56 INFO - 'sps_profile': False, 09:58:56 INFO - 'sps_profile_interval': 0, 09:58:56 INFO - 'suite': 'dromaeojs', 09:58:56 INFO - 'system_bits': '32', 09:58:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:58:56 INFO - 'title': 't-yosemite-r7-0357', 09:58:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:58:56 INFO - 'use_talos_json': True, 09:58:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:58:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:58:56 INFO - 'work_dir': 'build'} 09:58:56 INFO - [mozharness: 2016-11-18 17:58:56.807687Z] Running clobber step. 09:58:56 INFO - Running pre-action listener: _resource_record_pre_action 09:58:56 INFO - Running main action method: clobber 09:58:56 INFO - rmtree: /builds/slave/test/build 09:58:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:58:59 INFO - Running post-action listener: _resource_record_post_action 09:58:59 INFO - [mozharness: 2016-11-18 17:58:59.099178Z] Finished clobber step (success) 09:58:59 INFO - [mozharness: 2016-11-18 17:58:59.099301Z] Running read-buildbot-config step. 09:58:59 INFO - Running pre-action listener: _resource_record_pre_action 09:58:59 INFO - Running main action method: read_buildbot_config 09:58:59 INFO - Using buildbot properties: 09:58:59 INFO - { 09:58:59 INFO - "project": "", 09:58:59 INFO - "product": "firefox", 09:58:59 INFO - "script_repo_revision": "production", 09:58:59 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 09:58:59 INFO - "repository": "", 09:58:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 09:58:59 INFO - "buildid": "20161118074928", 09:58:59 INFO - "pgo_build": "False", 09:58:59 INFO - "basedir": "/builds/slave/test", 09:58:59 INFO - "buildnumber": 31, 09:58:59 INFO - "slavename": "t-yosemite-r7-0357", 09:58:59 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 09:58:59 INFO - "platform": "yosemite_r7", 09:58:59 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:58:59 INFO - "branch": "mozilla-central", 09:58:59 INFO - "repo_path": "mozilla-central", 09:58:59 INFO - "revision": "6186126f502ba47e4fb2b6f4d971ea6fd3e66a02", 09:58:59 INFO - "stage_platform": "macosx64", 09:58:59 INFO - "builduid": "bc1731146fac4991b29c8a60d76a2f4c", 09:58:59 INFO - "slavebuilddir": "test" 09:58:59 INFO - } 09:58:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/a1SPFV2yQfqn2-GgHpb2rA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 09:58:59 INFO - Running post-action listener: _resource_record_post_action 09:58:59 INFO - [mozharness: 2016-11-18 17:58:59.102750Z] Finished read-buildbot-config step (success) 09:58:59 INFO - [mozharness: 2016-11-18 17:58:59.102854Z] Running download-and-extract step. 09:58:59 INFO - Running pre-action listener: _resource_record_pre_action 09:58:59 INFO - Running main action method: download_and_extract 09:58:59 INFO - mkdir: /builds/slave/test/build/tests 09:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:59 INFO - trying https://queue.taskcluster.net/v1/task/a1SPFV2yQfqn2-GgHpb2rA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 09:58:59 INFO - Downloading https://queue.taskcluster.net/v1/task/a1SPFV2yQfqn2-GgHpb2rA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 09:58:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a1SPFV2yQfqn2-GgHpb2rA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 09:59:00 INFO - Downloaded 1199 bytes. 09:59:00 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 09:59:00 INFO - Using the following test package requirements: 09:59:00 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 09:59:00 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:59:00 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 09:59:00 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:59:00 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 09:59:00 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:59:00 INFO - u'jsshell-mac.zip'], 09:59:00 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:59:00 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 09:59:00 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 09:59:00 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:59:00 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 09:59:00 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:59:00 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 09:59:00 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:59:00 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 09:59:00 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:59:00 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 09:59:00 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:59:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a1SPFV2yQfqn2-GgHpb2rA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 09:59:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a1SPFV2yQfqn2-GgHpb2rA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:59:00 INFO - Fetch https://queue.taskcluster.net/v1/task/a1SPFV2yQfqn2-GgHpb2rA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 09:59:00 INFO - Http code: 200 09:59:00 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 09:59:00 INFO - x-amz-cf-id: QApFR969QqNoRYBxZe7bdYlDMp0CqcJcUj6oT_mcvQDc07BZrkMmYw== 09:59:00 INFO - x-amz-version-id: mBkb5EQUKsvk7eDBIhcrfybQPFNubrqQ 09:59:01 INFO - Expected file size: 16223098 09:59:01 INFO - Obtained file size: 16223098 09:59:08 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:59:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a1SPFV2yQfqn2-GgHpb2rA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 09:59:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a1SPFV2yQfqn2-GgHpb2rA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:59:08 INFO - Fetch https://queue.taskcluster.net/v1/task/a1SPFV2yQfqn2-GgHpb2rA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 09:59:08 INFO - Http code: 200 09:59:08 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 09:59:08 INFO - x-amz-cf-id: jZBGJan2om3LTzLs5DvtUKyVeaSCG230H2JX8b9pFzdCCLSk0u8gyA== 09:59:08 INFO - x-amz-version-id: mBkb5EQUKsvk7eDBIhcrfybQPFNubrqQ 09:59:08 INFO - Expected file size: 16223098 09:59:08 INFO - Obtained file size: 16223098 09:59:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a1SPFV2yQfqn2-GgHpb2rA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 09:59:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a1SPFV2yQfqn2-GgHpb2rA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:59:15 INFO - Fetch https://queue.taskcluster.net/v1/task/a1SPFV2yQfqn2-GgHpb2rA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 09:59:16 INFO - Http code: 200 09:59:16 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 09:59:16 INFO - x-amz-cf-id: t7XNunssQ3BZarnHl6cXTJwlDIYTBIakbiBrux5DPtiSS4sVMo1EMQ== 09:59:16 INFO - x-amz-version-id: d497YaCtKygGBoHq.L.MjINs_TzQ3fX4 09:59:16 INFO - Expected file size: 14409392 09:59:16 INFO - Obtained file size: 14409392 09:59:16 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')]} 09:59:16 INFO - trying https://queue.taskcluster.net/v1/task/a1SPFV2yQfqn2-GgHpb2rA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 09:59:16 INFO - Downloading https://queue.taskcluster.net/v1/task/a1SPFV2yQfqn2-GgHpb2rA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 09:59:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a1SPFV2yQfqn2-GgHpb2rA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 09:59:19 INFO - Downloaded 107474615 bytes. 09:59:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a1SPFV2yQfqn2-GgHpb2rA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 09:59:19 INFO - mkdir: /builds/slave/test/properties 09:59:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:59:19 INFO - Writing to file /builds/slave/test/properties/build_url 09:59:19 INFO - Contents: 09:59:19 INFO - build_url:https://queue.taskcluster.net/v1/task/a1SPFV2yQfqn2-GgHpb2rA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 09:59:20 INFO - Running post-action listener: _resource_record_post_action 09:59:20 INFO - Running post-action listener: set_extra_try_arguments 09:59:20 INFO - [mozharness: 2016-11-18 17:59:20.302058Z] Finished download-and-extract step (success) 09:59:20 INFO - [mozharness: 2016-11-18 17:59:20.302176Z] Running populate-webroot step. 09:59:20 INFO - Running pre-action listener: _resource_record_pre_action 09:59:20 INFO - Running main action method: populate_webroot 09:59:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:59:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:59:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:59:20 INFO - '--tppagecycles', 09:59:20 INFO - '7'], 09:59:20 INFO - 'tests': ['tsvgm']}}, 09:59:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:59:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:59:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:59:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:59:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:59:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:59:20 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:59:20 INFO - 'talos_options': ['--disable-e10s'], 09:59:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:59:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:59:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:59:20 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:59:20 INFO - 'talos_options': ['--disable-e10s'], 09:59:20 INFO - 'tests': ['damp', 'tps']}, 09:59:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:59:20 INFO - 'tests': ['damp', 'tps']}, 09:59:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:59:20 INFO - 'tests': ['dromaeo_dom']}, 09:59:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:59:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:59:20 INFO - 'tests': ['basic_compositor_video']}, 09:59:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:59:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:59:20 INFO - 'tests': ['a11yr', 09:59:20 INFO - 'ts_paint', 09:59:20 INFO - 'tpaint', 09:59:20 INFO - 'sessionrestore', 09:59:20 INFO - 'sessionrestore_no_auto_restore', 09:59:20 INFO - 'tabpaint']}, 09:59:20 INFO - 'other-e10s': {'tests': ['a11yr', 09:59:20 INFO - 'ts_paint', 09:59:20 INFO - 'tpaint', 09:59:20 INFO - 'sessionrestore', 09:59:20 INFO - 'sessionrestore_no_auto_restore', 09:59:20 INFO - 'tabpaint']}, 09:59:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:59:20 INFO - 'ts_paint', 09:59:20 INFO - 'tpaint', 09:59:20 INFO - 'sessionrestore', 09:59:20 INFO - 'sessionrestore_no_auto_restore', 09:59:20 INFO - 'tabpaint']}, 09:59:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:59:20 INFO - 'ts_paint', 09:59:20 INFO - 'tpaint', 09:59:20 INFO - 'sessionrestore', 09:59:20 INFO - 'sessionrestore_no_auto_restore', 09:59:20 INFO - 'tabpaint']}, 09:59:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:59:20 INFO - 'tests': ['a11yr', 09:59:20 INFO - 'ts_paint', 09:59:20 INFO - 'tpaint', 09:59:20 INFO - 'sessionrestore', 09:59:20 INFO - 'sessionrestore_no_auto_restore', 09:59:20 INFO - 'tabpaint']}, 09:59:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:59:20 INFO - 'tests': ['a11yr', 09:59:20 INFO - 'ts_paint', 09:59:20 INFO - 'tpaint', 09:59:20 INFO - 'sessionrestore', 09:59:20 INFO - 'sessionrestore_no_auto_restore', 09:59:20 INFO - 'tabpaint']}, 09:59:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:59:20 INFO - 'tests': ['tsvgx', 09:59:20 INFO - 'tsvgr_opacity', 09:59:20 INFO - 'tart', 09:59:20 INFO - 'tscrollx', 09:59:20 INFO - 'cart']}, 09:59:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:59:20 INFO - 'tsvgr_opacity', 09:59:20 INFO - 'tart', 09:59:20 INFO - 'tscrollx', 09:59:20 INFO - 'cart']}, 09:59:20 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:59:20 INFO - 'talos_options': ['--disable-e10s'], 09:59:20 INFO - 'tests': ['tp5o']}, 09:59:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:59:20 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:59:20 INFO - 'talos_options': ['--disable-e10s', 09:59:20 INFO - '--xperf_path', 09:59:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:59:20 INFO - 'tests': ['tp5n']}, 09:59:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:59:20 INFO - 'talos_options': ['--xperf_path', 09:59:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:59:20 INFO - 'tests': ['tp5n']}}, 09:59:20 INFO - 'talos.zip': {'path': '', 09:59:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:59:20 INFO - Running post-action listener: _resource_record_post_action 09:59:20 INFO - [mozharness: 2016-11-18 17:59:20.320616Z] Finished populate-webroot step (success) 09:59:20 INFO - [mozharness: 2016-11-18 17:59:20.320755Z] Running create-virtualenv step. 09:59:20 INFO - Running pre-action listener: _resource_record_pre_action 09:59:20 INFO - Running main action method: create_virtualenv 09:59:20 INFO - Creating virtualenv /builds/slave/test/build/venv 09:59:20 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 09:59:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:59:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:59:20 INFO - Using real prefix '/tools/python27' 09:59:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:59:21 INFO - Installing distribute.............................................................................................................................................................................................done. 09:59:24 INFO - Installing pip.................done. 09:59:24 INFO - Return code: 0 09:59:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:59:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:59:24 INFO - Reading from file tmpfile_stdout 09:59:24 INFO - Output received: 09:59:24 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) 09:59:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:59: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')]} 09:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59: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')]} 09:59:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:24 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 0x1009553f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008cb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc73ad89b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10076bd30>, '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 0x1005d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100763b20>, '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.RVs8bfd85M/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.txDobCJWS6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 09:59:24 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 09:59:24 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 09:59:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RVs8bfd85M/Render', 09:59:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:24 INFO - 'HOME': '/Users/cltbld', 09:59:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:24 INFO - 'LOGNAME': 'cltbld', 09:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:24 INFO - 'MOZ_NO_REMOTE': '1', 09:59:24 INFO - 'NO_EM_RESTART': '1', 09:59:24 INFO - 'PAGER': '/bin/cat', 09:59:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:24 INFO - 'PWD': '/builds/slave/test', 09:59:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:24 INFO - 'SHELL': '/bin/bash', 09:59:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.txDobCJWS6/Listeners', 09:59:24 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 09:59:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:24 INFO - 'USER': 'cltbld', 09:59:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:24 INFO - 'XPC_FLAGS': '0x0', 09:59:24 INFO - 'XPC_SERVICE_NAME': '0', 09:59:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:24 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 09:59:24 INFO - Cleaning up... 09:59:24 INFO - Return code: 0 09:59:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:59: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')]} 09:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59: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')]} 09:59:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:24 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 0x1009553f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008cb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc73ad89b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10076bd30>, '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 0x1005d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100763b20>, '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.RVs8bfd85M/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.txDobCJWS6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 09:59:24 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 09:59:24 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 09:59:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RVs8bfd85M/Render', 09:59:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:24 INFO - 'HOME': '/Users/cltbld', 09:59:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:24 INFO - 'LOGNAME': 'cltbld', 09:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:24 INFO - 'MOZ_NO_REMOTE': '1', 09:59:24 INFO - 'NO_EM_RESTART': '1', 09:59:24 INFO - 'PAGER': '/bin/cat', 09:59:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:24 INFO - 'PWD': '/builds/slave/test', 09:59:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:24 INFO - 'SHELL': '/bin/bash', 09:59:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.txDobCJWS6/Listeners', 09:59:24 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 09:59:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:24 INFO - 'USER': 'cltbld', 09:59:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:24 INFO - 'XPC_FLAGS': '0x0', 09:59:24 INFO - 'XPC_SERVICE_NAME': '0', 09:59:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:24 INFO - Downloading/unpacking psutil>=3.1.1 09:59:24 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 09:59:24 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 09:59:24 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 09:59:24 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 09:59:24 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 09:59:24 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 09:59:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:59:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:59:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:59:28 INFO - Installing collected packages: psutil 09:59:28 INFO - Running setup.py install for psutil 09:59:28 INFO - building 'psutil._psutil_osx' extension 09:59:28 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 09:59:28 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 09:59:28 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 09:59:29 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 09:59:29 INFO - building 'psutil._psutil_posix' extension 09:59:29 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 09:59:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:59:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:59:29 INFO - ^ 09:59:29 INFO - 1 warning generated. 09:59:29 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 09:59:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:59:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:59:29 INFO - Successfully installed psutil 09:59:29 INFO - Cleaning up... 09:59:29 INFO - Return code: 0 09:59:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:59:29 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')]} 09:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:29 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')]} 09:59:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:29 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 0x1009553f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008cb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc73ad89b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10076bd30>, '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 0x1005d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100763b20>, '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.RVs8bfd85M/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.txDobCJWS6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 09:59:29 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 09:59:29 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 09:59:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RVs8bfd85M/Render', 09:59:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:29 INFO - 'HOME': '/Users/cltbld', 09:59:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:29 INFO - 'LOGNAME': 'cltbld', 09:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:29 INFO - 'MOZ_NO_REMOTE': '1', 09:59:29 INFO - 'NO_EM_RESTART': '1', 09:59:29 INFO - 'PAGER': '/bin/cat', 09:59:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:29 INFO - 'PWD': '/builds/slave/test', 09:59:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:29 INFO - 'SHELL': '/bin/bash', 09:59:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.txDobCJWS6/Listeners', 09:59:29 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 09:59:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:29 INFO - 'USER': 'cltbld', 09:59:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:29 INFO - 'XPC_FLAGS': '0x0', 09:59:29 INFO - 'XPC_SERVICE_NAME': '0', 09:59:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:59:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:59:32 INFO - Installing collected packages: mozsystemmonitor 09:59:32 INFO - Running setup.py install for mozsystemmonitor 09:59:32 INFO - Successfully installed mozsystemmonitor 09:59:32 INFO - Cleaning up... 09:59:32 INFO - Return code: 0 09:59:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:59:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1009553f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008cb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc73ad89b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10076bd30>, '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 0x1005d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100763b20>, '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.RVs8bfd85M/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.txDobCJWS6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 09:59:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:59:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:59:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RVs8bfd85M/Render', 09:59:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:32 INFO - 'HOME': '/Users/cltbld', 09:59:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:32 INFO - 'LOGNAME': 'cltbld', 09:59:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:32 INFO - 'MOZ_NO_REMOTE': '1', 09:59:32 INFO - 'NO_EM_RESTART': '1', 09:59:32 INFO - 'PAGER': '/bin/cat', 09:59:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:32 INFO - 'PWD': '/builds/slave/test', 09:59:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:32 INFO - 'SHELL': '/bin/bash', 09:59:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.txDobCJWS6/Listeners', 09:59:32 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 09:59:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:32 INFO - 'USER': 'cltbld', 09:59:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:32 INFO - 'XPC_FLAGS': '0x0', 09:59:32 INFO - 'XPC_SERVICE_NAME': '0', 09:59:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:32 INFO - Downloading/unpacking jsonschema==2.5.1 09:59:32 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 09:59:32 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 09:59:32 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 09:59:32 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 09:59:32 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 09:59:32 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 09:59:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:59:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:35 INFO - Downloading functools32-3.2.3-2.tar.gz 09:59:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:59:35 INFO - warning: no files found matching '*.txt' 09:59:35 INFO - no previously-included directories found matching 'build' 09:59:35 INFO - no previously-included directories found matching 'dist' 09:59:35 INFO - no previously-included directories found matching '.git*' 09:59:35 INFO - Installing collected packages: jsonschema, functools32 09:59:35 INFO - Running setup.py install for functools32 09:59:36 INFO - warning: no files found matching '*.txt' 09:59:36 INFO - no previously-included directories found matching 'build' 09:59:36 INFO - no previously-included directories found matching 'dist' 09:59:36 INFO - no previously-included directories found matching '.git*' 09:59:36 INFO - Successfully installed jsonschema functools32 09:59:36 INFO - Cleaning up... 09:59:36 INFO - Return code: 0 09:59:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:59:36 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')]} 09:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:36 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')]} 09:59:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:36 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 0x1009553f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008cb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc73ad89b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10076bd30>, '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 0x1005d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100763b20>, '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.RVs8bfd85M/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.txDobCJWS6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 09:59:36 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 09:59:36 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 09:59:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RVs8bfd85M/Render', 09:59:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:36 INFO - 'HOME': '/Users/cltbld', 09:59:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:36 INFO - 'LOGNAME': 'cltbld', 09:59:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:36 INFO - 'MOZ_NO_REMOTE': '1', 09:59:36 INFO - 'NO_EM_RESTART': '1', 09:59:36 INFO - 'PAGER': '/bin/cat', 09:59:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:36 INFO - 'PWD': '/builds/slave/test', 09:59:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:36 INFO - 'SHELL': '/bin/bash', 09:59:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.txDobCJWS6/Listeners', 09:59:36 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 09:59:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:36 INFO - 'USER': 'cltbld', 09:59:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:36 INFO - 'XPC_FLAGS': '0x0', 09:59:36 INFO - 'XPC_SERVICE_NAME': '0', 09:59:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:59:36 INFO - Cleaning up... 09:59:36 INFO - Return code: 0 09:59:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:59:36 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')]} 09:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:36 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')]} 09:59:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:36 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 0x1009553f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008cb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc73ad89b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10076bd30>, '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 0x1005d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100763b20>, '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.RVs8bfd85M/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.txDobCJWS6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 09:59:36 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 09:59:36 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 09:59:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RVs8bfd85M/Render', 09:59:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:36 INFO - 'HOME': '/Users/cltbld', 09:59:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:36 INFO - 'LOGNAME': 'cltbld', 09:59:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:36 INFO - 'MOZ_NO_REMOTE': '1', 09:59:36 INFO - 'NO_EM_RESTART': '1', 09:59:36 INFO - 'PAGER': '/bin/cat', 09:59:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:36 INFO - 'PWD': '/builds/slave/test', 09:59:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:36 INFO - 'SHELL': '/bin/bash', 09:59:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.txDobCJWS6/Listeners', 09:59:36 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 09:59:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:36 INFO - 'USER': 'cltbld', 09:59:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:36 INFO - 'XPC_FLAGS': '0x0', 09:59:36 INFO - 'XPC_SERVICE_NAME': '0', 09:59:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:36 INFO - Downloading/unpacking blobuploader==1.2.4 09:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:39 INFO - Downloading blobuploader-1.2.4.tar.gz 09:59:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:59:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:59:39 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 09:59:39 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 09:59:39 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 09:59:39 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 09:59:39 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 09:59:39 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 09:59:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:59:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:59:39 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 09:59:39 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 09:59:39 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 09:59:39 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 09:59:39 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 09:59:39 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 09:59:40 INFO - Downloading docopt-0.6.1.tar.gz 09:59:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:59:40 INFO - Installing collected packages: blobuploader, requests, docopt 09:59:40 INFO - Running setup.py install for blobuploader 09:59:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:59:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:59:40 INFO - Running setup.py install for requests 09:59:41 INFO - Running setup.py install for docopt 09:59:41 INFO - Successfully installed blobuploader requests docopt 09:59:41 INFO - Cleaning up... 09:59:41 INFO - Return code: 0 09:59:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:59:41 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')]} 09:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:41 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')]} 09:59:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:41 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 0x1009553f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008cb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc73ad89b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10076bd30>, '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 0x1005d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100763b20>, '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.RVs8bfd85M/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.txDobCJWS6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 09:59:41 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 09:59:41 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 09:59:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RVs8bfd85M/Render', 09:59:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:41 INFO - 'HOME': '/Users/cltbld', 09:59:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:41 INFO - 'LOGNAME': 'cltbld', 09:59:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:41 INFO - 'MOZ_NO_REMOTE': '1', 09:59:41 INFO - 'NO_EM_RESTART': '1', 09:59:41 INFO - 'PAGER': '/bin/cat', 09:59:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:41 INFO - 'PWD': '/builds/slave/test', 09:59:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:41 INFO - 'SHELL': '/bin/bash', 09:59:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.txDobCJWS6/Listeners', 09:59:41 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 09:59:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:41 INFO - 'USER': 'cltbld', 09:59:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:41 INFO - 'XPC_FLAGS': '0x0', 09:59:41 INFO - 'XPC_SERVICE_NAME': '0', 09:59:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:59:41 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-ydkAhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:59:41 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-N1XCEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:59:41 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-eDzjOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:59:42 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-VlnJrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:59:42 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-l1UkjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:59:42 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-IidUXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:59:42 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-Lu1GAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:59:42 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-lu0a0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:59:42 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-Fcua6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:59:42 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-bBxld3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:59:42 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-VEmqn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:59:42 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-qMjx0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:59:42 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-xTsDvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:59:43 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-4DnAWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:59:43 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-alUpP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:59:43 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-aBk2Dm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:59:43 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-1gjdup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:59:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:59:43 INFO - Running setup.py install for manifestparser 09:59:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:59:43 INFO - Running setup.py install for mozcrash 09:59:43 INFO - Running setup.py install for mozdebug 09:59:43 INFO - Running setup.py install for mozdevice 09:59:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:59:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:59:44 INFO - Running setup.py install for mozfile 09:59:44 INFO - Running setup.py install for mozhttpd 09:59:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:59:44 INFO - Running setup.py install for mozinfo 09:59:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:59:44 INFO - Running setup.py install for mozInstall 09:59:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:59:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:59:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:59:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:59:44 INFO - Running setup.py install for mozleak 09:59:44 INFO - Running setup.py install for mozlog 09:59:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:59:44 INFO - Running setup.py install for moznetwork 09:59:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:59:45 INFO - Running setup.py install for mozprocess 09:59:45 INFO - Running setup.py install for mozprofile 09:59:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:59:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:59:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:59:45 INFO - Running setup.py install for mozrunner 09:59:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:59:45 INFO - Running setup.py install for mozscreenshot 09:59:45 INFO - Running setup.py install for moztest 09:59:45 INFO - Running setup.py install for mozversion 09:59:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:59:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:59:46 INFO - Cleaning up... 09:59:46 INFO - Return code: 0 09:59:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:59:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:46 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 0x1009553f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008cb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc73ad89b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10076bd30>, '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 0x1005d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100763b20>, '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.RVs8bfd85M/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.txDobCJWS6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 09:59:46 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 09:59:46 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 09:59:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RVs8bfd85M/Render', 09:59:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:46 INFO - 'HOME': '/Users/cltbld', 09:59:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:46 INFO - 'LOGNAME': 'cltbld', 09:59:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:46 INFO - 'MOZ_NO_REMOTE': '1', 09:59:46 INFO - 'NO_EM_RESTART': '1', 09:59:46 INFO - 'PAGER': '/bin/cat', 09:59:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:46 INFO - 'PWD': '/builds/slave/test', 09:59:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:46 INFO - 'SHELL': '/bin/bash', 09:59:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.txDobCJWS6/Listeners', 09:59:46 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 09:59:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:46 INFO - 'USER': 'cltbld', 09:59:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:46 INFO - 'XPC_FLAGS': '0x0', 09:59:46 INFO - 'XPC_SERVICE_NAME': '0', 09:59:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:59:46 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-WcHS7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:59:46 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)) 09:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:59:46 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-WRfsuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:59:46 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)) 09:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:59:46 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-NMI900-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:59:46 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)) 09:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:59:46 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-TzSg3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:59:46 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)) 09:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:59:46 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-dCPYxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:59:46 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)) 09:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:59:46 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-Cs5MaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:59:47 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)) 09:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:59:47 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-5cczLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:59:47 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)) 09:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:59:47 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-_vy6Ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:59:47 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)) 09:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:59:47 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-tuMNs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:59:47 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)) 09:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:59:47 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-iapqhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:59:47 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)) 09:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:59:47 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-euF8Jw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:59:47 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)) 09:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:59:47 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-dPt9vw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:59:47 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)) 09:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:59:47 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-j2ziuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:59:47 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)) 09:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:59:47 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-ZxwfGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:59:47 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)) 09:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:59:47 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-CrNeLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:59:47 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)) 09:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:59:47 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-BTigHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:59:48 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-hUgVOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:59:48 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)) 09:59:48 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)) 09:59:48 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)) 09:59:48 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)) 09:59:48 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)) 09:59:48 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)) 09:59:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:59:48 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 09:59:48 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 09:59:48 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 09:59:48 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 09:59:48 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 09:59:48 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 09:59:50 INFO - Downloading blessings-1.6.tar.gz 09:59:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:59:50 INFO - Installing collected packages: blessings 09:59:50 INFO - Running setup.py install for blessings 09:59:50 INFO - Successfully installed blessings 09:59:50 INFO - Cleaning up... 09:59:51 INFO - Return code: 0 09:59:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:59:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:59:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:59:51 INFO - Reading from file tmpfile_stdout 09:59:51 INFO - Current package versions: 09:59:51 INFO - blessings == 1.6 09:59:51 INFO - blobuploader == 1.2.4 09:59:51 INFO - docopt == 0.6.1 09:59:51 INFO - functools32 == 3.2.3-2 09:59:51 INFO - jsonschema == 2.5.1 09:59:51 INFO - manifestparser == 1.1 09:59:51 INFO - mozInstall == 1.12 09:59:51 INFO - mozcrash == 1.0 09:59:51 INFO - mozdebug == 0.1 09:59:51 INFO - mozdevice == 0.48 09:59:51 INFO - mozfile == 1.2 09:59:51 INFO - mozhttpd == 0.7 09:59:51 INFO - mozinfo == 0.9 09:59:51 INFO - mozleak == 0.1 09:59:51 INFO - mozlog == 3.4 09:59:51 INFO - moznetwork == 0.27 09:59:51 INFO - mozprocess == 0.23 09:59:51 INFO - mozprofile == 0.28 09:59:51 INFO - mozrunner == 6.13 09:59:51 INFO - mozscreenshot == 0.1 09:59:51 INFO - mozsystemmonitor == 0.3 09:59:51 INFO - moztest == 0.7 09:59:51 INFO - mozversion == 1.4 09:59:51 INFO - psutil == 3.1.1 09:59:51 INFO - requests == 1.2.3 09:59:51 INFO - wsgiref == 0.1.2 09:59:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:59:51 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')]} 09:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:52 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 0x1009553f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008cb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc73ad89b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10076bd30>, '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 0x1005d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100763b20>, '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.RVs8bfd85M/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.txDobCJWS6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 09:59:52 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 09:59:52 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 09:59:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RVs8bfd85M/Render', 09:59:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:52 INFO - 'HOME': '/Users/cltbld', 09:59:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:52 INFO - 'LOGNAME': 'cltbld', 09:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:52 INFO - 'MOZ_NO_REMOTE': '1', 09:59:52 INFO - 'NO_EM_RESTART': '1', 09:59:52 INFO - 'PAGER': '/bin/cat', 09:59:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:52 INFO - 'PWD': '/builds/slave/test', 09:59:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:52 INFO - 'SHELL': '/bin/bash', 09:59:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.txDobCJWS6/Listeners', 09:59:52 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 09:59:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:52 INFO - 'USER': 'cltbld', 09:59:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:52 INFO - 'XPC_FLAGS': '0x0', 09:59:52 INFO - 'XPC_SERVICE_NAME': '0', 09:59:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:52 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)) 09:59:52 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)) 09:59:52 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)) 09:59:52 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)) 09:59:52 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)) 09:59:52 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)) 09:59:52 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)) 09:59:52 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)) 09:59:52 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)) 09:59:52 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)) 09:59:52 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)) 09:59:52 INFO - Cleaning up... 09:59:52 INFO - Return code: 0 09:59:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1009553f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008cb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc73ad89b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10076bd30>, '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 0x1005d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100763b20>, '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.RVs8bfd85M/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.txDobCJWS6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 09:59:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:59:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:59:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RVs8bfd85M/Render', 09:59:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:53 INFO - 'HOME': '/Users/cltbld', 09:59:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:53 INFO - 'LOGNAME': 'cltbld', 09:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:53 INFO - 'MOZ_NO_REMOTE': '1', 09:59:53 INFO - 'NO_EM_RESTART': '1', 09:59:53 INFO - 'PAGER': '/bin/cat', 09:59:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:53 INFO - 'PWD': '/builds/slave/test', 09:59:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:53 INFO - 'SHELL': '/bin/bash', 09:59:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.txDobCJWS6/Listeners', 09:59:53 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 09:59:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:53 INFO - 'USER': 'cltbld', 09:59:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:53 INFO - 'XPC_FLAGS': '0x0', 09:59:53 INFO - 'XPC_SERVICE_NAME': '0', 09:59:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:59:53 INFO - Cleaning up... 09:59:53 INFO - Return code: 0 09:59:53 INFO - Running post-action listener: _resource_record_post_action 09:59:53 INFO - Running post-action listener: _start_resource_monitoring 09:59:53 INFO - Starting resource monitoring. 09:59:53 INFO - [mozharness: 2016-11-18 17:59:53.588629Z] Finished create-virtualenv step (success) 09:59:53 INFO - [mozharness: 2016-11-18 17:59:53.589662Z] Running install step. 09:59:53 INFO - Running pre-action listener: _resource_record_pre_action 09:59:53 INFO - Running main action method: install 09:59:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:59:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:59:53 INFO - Reading from file tmpfile_stdout 09:59:53 INFO - Detecting whether we're running mozinstall >=1.0... 09:59:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:59:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:59:53 INFO - Reading from file tmpfile_stdout 09:59:53 INFO - Output received: 09:59:53 INFO - Usage: mozinstall [options] installer 09:59:53 INFO - Options: 09:59:53 INFO - -h, --help show this help message and exit 09:59:53 INFO - -d DEST, --destination=DEST 09:59:53 INFO - Directory to install application into. [default: 09:59:53 INFO - "/builds/slave/test"] 09:59:53 INFO - --app=APP Application being installed. [default: firefox] 09:59:53 INFO - mkdir: /builds/slave/test/build/application 09:59:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:59:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:00:26 INFO - Reading from file tmpfile_stdout 10:00:26 INFO - Output received: 10:00:26 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:00:26 INFO - Running post-action listener: _resource_record_post_action 10:00:26 INFO - [mozharness: 2016-11-18 18:00:26.472492Z] Finished install step (success) 10:00:26 INFO - [mozharness: 2016-11-18 18:00:26.472632Z] Running run-tests step. 10:00:26 INFO - Running pre-action listener: _resource_record_pre_action 10:00:26 INFO - Running main action method: run_tests 10:00:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:00:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:00:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:00:26 INFO - 2016-11-18 10:00:26.485 screenresolution[1640:7466] starting screenresolution argv=screenresolution get 10:00:26 INFO - 2016-11-18 10:00:26.487 screenresolution[1640:7466] Display 0: 1600x1200x32@60 10:00:26 INFO - 2016-11-18 10:00:26.493 screenresolution[1641:7468] starting screenresolution argv=screenresolution list 10:00:26 INFO - Available Modes on Display 0 10:00:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:00:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:00:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:00:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:00:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:00:26 INFO - Intel Iris: 10:00:26 INFO - Chipset Model: Intel Iris 10:00:26 INFO - Type: GPU 10:00:26 INFO - Bus: Built-In 10:00:26 INFO - VRAM (Dynamic, Max): 1536 MB 10:00:26 INFO - Vendor: Intel (0x8086) 10:00:26 INFO - Device ID: 0x0a2e 10:00:26 INFO - Revision ID: 0x0009 10:00:26 INFO - Displays: 10:00:26 INFO - Display: 10:00:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:00:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:00:26 INFO - Display Serial Number: 1600x1200 60 10:00:26 INFO - Main Display: Yes 10:00:26 INFO - Mirror: Off 10:00:26 INFO - Online: Yes 10:00:26 INFO - Rotation: Supported 10:00:26 INFO - Return code: 0 10:00:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:00:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:00:26 INFO - Python 2.7.3 10:00:26 INFO - Return code: 0 10:00:26 INFO - grabbing minidump binary from tooltool 10:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:26 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 0x10076bd30>, '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 0x1005d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100763b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:00:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:00:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:00:26 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:00:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:00:26 INFO - Return code: 0 10:00:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:00:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:00:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:00:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:00:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:00:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a1SPFV2yQfqn2-GgHpb2rA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0357', '--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 10:00:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a1SPFV2yQfqn2-GgHpb2rA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0357 --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 10:00:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RVs8bfd85M/Render', 10:00:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:00:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:00:26 INFO - 'HOME': '/Users/cltbld', 10:00:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:00:26 INFO - 'LOGNAME': 'cltbld', 10:00:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:00:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:00:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:26 INFO - 'MOZ_NO_REMOTE': '1', 10:00:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:00:26 INFO - 'NO_EM_RESTART': '1', 10:00:26 INFO - 'PAGER': '/bin/cat', 10:00:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:00:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:26 INFO - 'PWD': '/builds/slave/test', 10:00:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:00:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:00:26 INFO - 'SHELL': '/bin/bash', 10:00:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.txDobCJWS6/Listeners', 10:00:26 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 10:00:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:00:26 INFO - 'USER': 'cltbld', 10:00:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:00:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:00:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:26 INFO - 'XPC_FLAGS': '0x0', 10:00:26 INFO - 'XPC_SERVICE_NAME': '0', 10:00:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:00:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a1SPFV2yQfqn2-GgHpb2rA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0357', '--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 10:00:27 INFO - mozversion application_buildid: 20161118074928 10:00:27 INFO - mozversion application_changeset: 6186126f502ba47e4fb2b6f4d971ea6fd3e66a02 10:00:27 INFO - mozversion application_display_name: Nightly 10:00:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:00:27 INFO - mozversion application_name: Firefox 10:00:27 INFO - mozversion application_remotingname: firefox 10:00:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:00:27 INFO - mozversion application_vendor: Mozilla 10:00:27 INFO - mozversion application_version: 53.0a1 10:00:27 INFO - mozversion platform_buildid: 20161118074928 10:00:27 INFO - mozversion platform_changeset: 6186126f502ba47e4fb2b6f4d971ea6fd3e66a02 10:00:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:00:27 INFO - mozversion platform_version: 53.0a1 10:00:27 INFO - using testdate: 1479492027 10:00:27 INFO - actual date: 1479492027 10:00:27 INFO - starting webserver on 'localhost:49243' 10:00:27 INFO - SUITE-START | Running 2 tests 10:00:27 INFO - TEST-START | dromaeo_css 10:00:27 INFO - operating with platform_type : mac_ 10:00:27 INFO - Initialising browser for dromaeo_css test... 10:00:27 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmpbDCsTn/profile http://localhost:49243/getInfo.html) 10:00:29 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 10:00:29 INFO - PROCESS | 1651 | colorDepth:24 10:00:29 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 10:00:29 INFO - PROCESS | 1651 | __metrics 10:00:30 INFO - PROCESS | 1651 | 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" 10:00:30 INFO - PROCESS | 1651 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:00:30 INFO - TEST-INFO | 1651: exit 0 10:00:30 INFO - Browser initialized. 10:00:30 INFO - Running cycle 1/1 for dromaeo_css test... 10:00:30 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmpbDCsTn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:00:43 INFO - PROCESS | 1653 | RSS: Main: 235868160 10:00:43 INFO - PROCESS | 1653 | 10:01:34 INFO - PROCESS | 1653 | 1479492094309 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:03:47 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 10:03:50 INFO - PROCESS | 1653 | RSS: Main: 476106752 10:03:50 INFO - PROCESS | 1653 | 10:06:53 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 10:06:53 INFO - PROCESS | 1653 | RSS: Main: 367759360 10:06:53 INFO - PROCESS | 1653 | 10:09:56 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 10:09:57 INFO - PROCESS | 1653 | RSS: Main: 331780096 10:09:57 INFO - PROCESS | 1653 | 10:12:59 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 10:13:00 INFO - PROCESS | 1653 | RSS: Main: 343945216 10:13:00 INFO - PROCESS | 1653 | 10:16:03 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 10:16:04 INFO - PROCESS | 1653 | RSS: Main: 331100160 10:16:04 INFO - PROCESS | 1653 | 10:19:07 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 10:19:07 INFO - PROCESS | 1653 | RSS: Main: 482426880 10:19:07 INFO - PROCESS | 1653 | 10:19:07 INFO - PROCESS | 1653 | __start_tp_report 10:19:07 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 10:19:07 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 10:19:07 INFO - PROCESS | 1653 | |i|pagename|runs| 10:19:07 INFO - PROCESS | 1653 | |0;dojo.html;2952.92617684558;3266.9999999999995;3307.2228026413804;3338.515915192297;3380.814055226963;5202.583793296537;5489.231507588941;5578.86052848679;5587.580931430139;5594.412586678396;5604.327480702311;5631.352394474637;5701.315842098954;5707.429257074291;5755.827325180241;5143.639945203838;5210.817621383252;5228.424873263938;5229.8169564065265;5253.763580638862;5113.105206588851;5202.479752024805;5254.106801843695;5267.736613169345;5282.31329927109;5278.762455689503;5288.8413347599635;5290.576753859682;5308.893822123555;5347.946520534783;4488.304312831484;5106.66806657566;5126.871828204287;5274.6307758457115;5296.25852380667;5100.489951004907;5176.6117541184185;5182.274481572583;5183.989122121188;5190.039842629126;5643.209950606918;5645.350784659776;5665.518430933375;5668.57485688575;5676.631018983753;6094.085887116968;6095.207623009025;6096.69516524172;6108.144859719643;6134.631922084689;6143.310589587854;6149.954507733696;6152.6308421494405;6162.907556386658;6167.969160154215;5667.086045621127;5703.486686198262;5721.141828725683;5732.484076433141;5745.454181852676;6284.277308109535;6317.084022816758;6322.4942004639515;6328.71520781566;6331.366863313724;5978.469149566272;6073.4837538808815;6074.969625151934;6084.117802918552;6131.049687298476;6177.038695870212;6206.751729930843;6216.191895053614;6216.844578885564;6222.533310001768;5921.289445266596;5957.523398128226;5965.79119730816;6001.459868611846;6035.275766907911;6085.939140608626;6105.8168254952425;6112.663803490762;6113.908291375633;6121.755129794758;4843.539863712942;4909.410870695539;4919.4834542373255;4924.4090709115135;4953.984433191187;4318.5033721121845;4351.369051487517;4352.064306174125;4352.869413917588;4372.562743725602;5682.261306030272;5695.829125126253;5711.371749107595;5765.798197063166;5769.278840144982;6226.034964580497;6226.40849119333;6239.563230573907;6250.968745156336;6259.749610015549;5554.361248456398;5628.352739435018;5689.7724091036725;5705.1727499512335;5714.085746280575;4642.744649044335;5297.708626025606;5314.946850531445;5333.653312534673;5408.323959505062;6255.124282600348;6349.920513512714;6355.364463553793;6365.7135428904885;6390.9041364378645;6091.360407157184;6133.8466538335115;6164.352742961924;6167.876642467036;6190.659513726789;6244.750209991549;6290.119383286435;6312.4634406074165;6327;6333.240011198685;6040.244969378828;6087.482563981934;6101.359357267601;6123.510119190543;6143.324234334309;6176.857281402955;6217.658028808459;6221.253449585897;6243.219597550306;6251.749930002931;5704.771809127588;5814.04068328721;5859.174062217469;6004.87990240184;6052.122442245938;5899.056151015817;5910.083936989773;5916.319623243382;5922.585419020627;5935.228420305332;4981.327520784793;5777.306723193244;5804.94195058044;5817.069268916953;5835.708214589169;5893.322267939242;5928.525717942641;5938.465538101592;5944.1975333331175;5948.553858460719;5784.479396854304;5810.389909059657;5816.563757718103;5817.301923769006;5827.59206855516 10:19:07 INFO - PROCESS | 1653 | |1;ext.html;466.86227562868953;505.60310156527134;517.6505858545482;525.4115390762347;552.7954656776993;38521.42217866731;39607.40588891166;39660.603393966085;41811;41900;41374;41662.7916860416;41751.37372939401;41764.79117604408;41846.37230441546;9222.953885230581;9382.812343753121;9396.81206375872;9397.81204375912;9398.906010939905;9271.675491357804;9366.906330936705;9374.67188648394;9395.107464790834;9397.81204375912;9395.530223488799;9411.200047995928;9423.62305507779;9433.151016408521;9438.905610943906;9347.579358928831;9409.717708468757;9415.858762118574;9416.858747118798;9418.952905235465;9370.85943710845;9437.858432123523;9447.90552094477;9454.290928180346;9466.242700583936;38611.61388386136;38726.612733872586;38755.612443875485;38862.61137388618;39019.8049009756;3171.349873275973;3253.7071663550396;3346.5147553604593;3629.909252268688;3633.654802793757;29130.563041554393;29260.41479170426;30009.69990300113;30350.84824575885;31647.841760791278;3150.5116706910467;3152.952705709416;3164.7784655074156;3206.679332066798;3251.64231934487;430245;454089.72955135343;456329;464406;468973;58711.41288587145;59150.70424647849;59291.70354148201;59442;59606;28108.43783124326;61784.69107654523;61908.69045654743;61942.38057619456;61999.6900015497;14873.553793386216;15603.453879114177;15624.218789060502;15635.296411661502;15677.764833527506;11893.76212475763;12005.63983080509;12007.159498835172;12013.339266340436;12025.977791887788;18139.54651133706;18259.269629214683;18290.81709182891;18294.63410731778;18302.26790928348;7403.370713489414;7679.116901556393;7758;7811.648475818602;7813.492123011986;800.9839803203903;840.7603832907593;981.9263555233387;1013.0730381700808;1053.199568328076;24634.384140396276;27877.721222787917;29379.98405103677;29384.559231611544;29758.107256782332;1038.4963292802984;1052.1530168214508;1077.6713102503654;1112.57165991094;1115.9776804463866;14927;14942.729867961127;14989.775153372708;15022;15280.006799557994;637071;645852;646659;647147;649047;56211;56652.433475664715;56745.14882276769;56937.43062569404;57194.71402643043;1218.2507757728933;1261.0353079893705;1327.3097989045834;1355.1936597724339;1381.530279704905;23950.760492394853;28494.43011139724;28652.42695146044;29853.402931941673;30498.237544061576;47000.529994700984;47656.52343476521;47698;47704;47720;389746;391290;391412;391643;392702;22612.773872261725;23013.53972920566;23277.3016809496;25089.49821003606;26018.528239817188;43616;44747;45287;45748.765222260314;46189.07621847611;35343;36505.08737281589;36763.26473470462;37788;37809;33736.66263337433;33965.32069358649;36554.451683224244;37234;37639;36582.63417365792;36818;37001.814990924875;37392.439113413864;37456.438153427174;27323.59014614822;32553.837230814643;32725.50911736278;32804.34391312208;32959.67040329566;24268.271951841474;24543.877280613484;24580.335731415154;24682.753172468765;24685.5925199394 10:19:07 INFO - PROCESS | 1653 | |2;jquery.html;350.5600471408382;371.4428357463804;374.26830546282;378.7878787878788;403.07494300580163;14692.632684182887;14809.925950370247;15399.525415261633;20434.386968390972;20494.795052049474;18783.436496905113;19041.809581904177;19530.121144548495;19681.53980752406;19946.70079948802;5665.575081868866;5972.522198224132;5978.730957106941;5979.820605381824;5996.610220335686;4154.293770059082;4384.21084204843;4437.733735975836;5892.9705351473185;5959.642421454727;4384.101259241847;4392.846250381237;5437.728113594324;6554;6576.342365763433;5030.220315851049;5682.51698605619;6031.8793624127275;6623.304553021935;6636.435902948231;5849.122631605251;5853.970730146322;5855.970720146372;5856.267966504187;5858.443447872445;12405.193662411913;12596.748065038739;12724.554640587536;12829.486820527261;12839;1925.258775371492;2208.2823082498253;2214.9889250553806;2232.118313266251;2400.50789588134;9199.494027828467;9611.423314601147;10097.040781125856;10210.795784084277;10248.897511024943;1567.4435575370808;1736.4877361178483;1817.173186200289;1877.9248830046918;1885.4343696890878;112062;120685;121276.78723212743;121469;122382.38808806078;11070.39112848801;11117.332960022424;11178.720531986766;11252.099832013419;11367.715807104889;14201;14240.145591264558;14246.572602821932;14273.500427484989;14344.211068391338;7891.28978391936;8181.263686268146;8185.836283274421;8262.380321475914;8309.335253179732;8009.719659811995;8023.799405014921;8059.032916049994;8122.593870306461;8235.258826705625;4333.566643335641;4351.9564804352185;4361.454818147731;4365.214261432909;4443.822247110079;1703.7870266216723;1811.2302271534545;1870.429518996719;1883.52143567299;1886.4434991677488;742.9257074292527;755.2787088330631;757.9886301705479;817.6198067898456;875.9737207883774;18454.538636534195;19161.616767664567;19352.032398380026;19978.80127192373;20034.499137521387;857.9227869491775;886.3883920095113;903.7921278105941;908.2098574240453;911.3438324406417;10065.547050382751;10414.947925260325;10447.582096716198;10621.575136994434;10641.733956651145;523868;526941.365293171;531627;545522.2723886435;546934;110799.44600276947;126969;127613.72386276019;129510;132080.3395983014;909.6452383570413;964.8745663063756;987.7283746969497;988.5650313861878;992.5731935267904;17490.03804790749;18358.724619130455;18464.26142954267;18473.815261847747;18504;35751.64248357483;51862.481375185766;55849.88300233892;56074.1588876159;56290;79478;80051.3989720214;80933.26768030928;83149;83227.5838620803;5971.402859713994;6788.355106264897;7243.311885370881;7330.120385553554;7349.265073492822;8994.280457563511;12410.904401547286;12618.621441356774;12906.483740650268;13121.671958201121;10629.362238265729;10680.626178084041;11261.549538018387;11330.03694685928;11488.712782180512;10683.94658026705;10746.623868164577;11139.33164010162;11291.606943781027;11326.37704926237;11020.944895275472;11250.774984500427;11274.661760147208;11620.186586938833;11643.184977051525;6294.4964402846745;6940.305969403019;7297.781066568012;7499.700011999677;7600.239976002355;9220.308476864127;9425.811483770149;11206.495707693337;11272.60545880923;11317.377544235145 10:19:07 INFO - PROCESS | 1653 | |3;mootools.html;1217.4338932396433;1287.3627554360594;1471.2790732541052;1614.628635413854;1636.8526832585064;7818.648160832762;8186.877196842052;8259.876101858463;8260.793480162998;8262.669493220272;7284.672189751461;7480.513766605167;7496.92503074969;7876.330511906494;8054.355651547877;2040.030985281994;2087.5198704298023;2136.7222261106035;2275.681404603357;2324.953770803137;2277.7266727992665;2327.767223277667;2328.15022516781;2329.1032952313312;2332.7317358503733;2022.817946384825;2098.842586805988;2268.466910276092;2294.8623082615013;2298.712660917385;2184.8361372897016;2248.37045627223;2254.9436264093365;2260.570491606598;2260.977390226093;2228.2423975848287;2256.650219216008;2259.7062381890414;2262.592733308004;2263.603869322862;8078.1921807819335;8143.144969778147;8150.184981501861;8169.591520424015;8187.263146316801;4862.051899879525;5114;5116.283720279164;5134.563562097226;5135.8202462914;3332.3668502984356;3409.7783644063056;3483.28592638511;3495.720342372604;3513.0163554204864;1042.775803202315;1043.6190790361538;1066.9093127084207;1070.9678709638724;1079.4656644960717;10435.217358698052;10518.211134164892;10550.366977981423;10557;10575.471226438647;4224.556421575752;4253.532111467736;4367.192069467159;4417.712848664826;4427.490838553543;8494.193051660082;8519.616617252115;8524.31805455562;8528.40301178924;8536.70121545743;5072.873178170502;5075.5178258065425;5084.313617661643;5090.821821236239;5093.719845408538;4538.591526762607;4655.767211639404;4680.251159814414;4771.23660214364;4780.545848144421;3576.803275819855;3613.5483064616924;3625.4380571011534;3672.559292884871;3687.5943646199435;992.4789485520015;1138.5161306444893;1139.0375133012592;1147.17976646698;1148.7415331550335;774.8605251054864;797.2266901105918;830.0454477351094;886.2998231397124;913.4975763330142;5435.076037073707;5474.644148130359;5554.6944918029085;5642.605017648807;5660;852.4970267542055;900.9819803603891;903.3450748207629;903.5391950105494;904.5703290936884;3642.6903713184147;3684.8341824617955;3722.4230244312175;3823.3691440912494;3864.1885204107452;8661.13388661129;9771.609135634637;9887.209023278121;9887.901120988841;9889.604415823287;9827.55775990068;9844.046785964181;9851.802963940681;9872.308938374388;9885.604575817031;5797.420257974169;7537.849243015109;7725.575093369918;7751.224877512203;7762.961185194038;5562.276904002454;5716.657000579979;5739.196512488172;5820.447057529528;5846.064629659234;8995.775105622412;9051.049639787727;9113.088691130833;9151.313651476034;9207.17135457812;9086.909130908607;9106.863397048917;9324.860127097963;9363.250939924927;9498.525073746147;6851.931480685129;7074;7088.149422069178;7099.006139140628;7107.360337569644;7543.660535275816;7573.166951635426;7594.164641889498;7659.770206893802;7689.846203076019;6960.686769095504;7015.824604384931;7045.682944267418;7065.752698655728;7109.431245500244;6682.76610318656;6787.253402125861;6818.556793808387;6835.965820171066;6885.793426197222;6455.483561315177;6483.578567393104;6489.1888513935755;6532.346765323429;6548.672566371567;4329.870103896888;4609.617114865594;4721.22099853534;4740.4785473597185;4844.563989240985;4403.713758605681;4742.407199100113;4763.1426343258545;4804.303376010389;4896.36347274852 10:19:07 INFO - PROCESS | 1653 | |4;prototype.html;284.3786326875778;296.3022082994548;301.9018818883862;304.98170109793415;313.0233670946647;4308.526062133167;4836.226203807391;4862.0032893256885;4868;4904.180096444541;4102.958970410295;4869.514797986612;4869.805207791684;5026.29631851541;5043.899122017567;3695.5380577427823;3707.462417949396;3746.8197517781878;3920.941505709511;3930.390789427629;3363.798172109669;3477.2871561329866;3873.205992771489;3933.449317095609;3935.940960885589;3354.3962086824363;3518.0852978225716;3614.7469677122613;3764.964634725445;3865.439511270864;3278.96721032789;3329.1535736944807;3564.9643503564894;3638.381475149231;3873.8063096845044;2712.362594790223;3353.899383018513;3360.663933606644;3375.1899544109483;3381.087106481261;4414.161309351245;4420.541221396931;4902.632302577321;4938.802447902115;4949.455559888409;4145.8334373953985;4326.524082350938;4352.455943007124;4386.473623165209;4390.758508282043;4923.818283611908;5294.523492885659;5301.72758537952;5310.114694481087;5323.653962492425;3113.79760315581;3135.623725152996;3634.890953271406;3652.9634703652887;3671.94492082619;4629.7916593753025;4691.202495575761;5063.620228482879;5448.536874365724;5576.191452239403;3461.8615255389504;3663.8351274192723;3688.2992231475932;3696.353138200804;3705.8511861323077;3735.813209339522;3740.8877733668032;3746.1383881706815;3757.200885340384;3785.3943369060817;3524.577050753926;4046.575109613448;4330.588594083557;4332.956670433318;4386.627136693353;4207;5086.77109530072;5318.016167009116;5390.757415916293;5412.621116521885;1186.851643544557;1211.733418647896;1220.20686553739;1223.6451429085644;1230.249547775874;790.316376334478;795.8249185179251;808.4058217210346;828.8715249136394;841.4446465332851;4463.687541872037;4695.201815691341;4729.361536192639;4731.309578528753;4800.591949684246;4536.319552067216;4903.53416425439;5108.719020453911;5136.691798492027;5141.55776006394;4025.6578190854107;4403.097365040159;4551;4714.528547145258;4730.834420795256;2491.7383674714256;2599.246218596586;2737.8767955442054;2774.805763596529;2777.8194417362806;4416.425864637641;5411.9729401353525;5437.483439073281;5438.021156191923;5480.98601758668;4601.838935637236;4805.6155507559315;5247.431746412476;5312.946870531246;5353.625246232727;5187.922181167285;5817.185594016841;5833.504152147115;5862.648241105548;5873.265841769693;4758.809647614056;4896.387951506062;5093.516115968977;5601.179616624695;5727.6540013096055;4827.613790896649;5444.265024221838;5529.944700552943;5547.7780888764;5574.888502229852;5440.6735595864375;5752.453516915886;5776.913346299725;5812.447817457335;5831.7375718093635;3101.3022070034062;3292.3579901918897;3516.5955915070094;3715.7956312403076;3729.272791805572;5473;5484.725763711719;5502.284702988746;5502.752376143003;5510.283663123768;5147.536721695065;5147.9227811582105;5305.389880163676;5334.653247538898;5399.244105825266;4686.484486706528;5039;5406.94507603203;5418.431064738304;5440.945590544202;4926.655134140719;5304.787808487772;5310.707911064928;5337.998250656004;5366.436524164907;4061.436347006365;4691.413573303337;4873.928580353265;5108.56577190943;5460.6996615186545;4974.502549745142;5078.263651770399;5095.261187127771;5314.24629872149;5317.707526086102 10:19:07 INFO - PROCESS | 1653 | |5;yui.html;678.2098854834121;679.6431873266534;699.2867275379114;738.5716284554959;773.6595897804965;13874.861251387483;14666.779998300033;14706.55880323592;14740.6314842129;14757.335919883617;11912.344821034862;13274.535391261308;13474.124181928168;13499.865001349983;14741.262936853169;798.2695833312526;818.3453237410077;819.7909533069089;819.8237378963522;820.216693058131;816.1348970091722;820.2986446588171;823.798169448486;825.3149885594942;828.9088200297963;847.2798121596625;849.817289282804;862.0560486267527;863.201538576817;864.0711235421916;856.6701819799359;857.5712143928037;857.9785505362354;858.5363903492138;858.8539948208758;635.659921941759;636.5289685632645;636.6307541625846;636.656205648949;638.7828138432955;13999.580012599637;14004.71990560183;14007.64980875476;14021.579352619437;14036;13349.399277032557;13769.31153442324;13866.376013079334;13898.51355202563;13983.23092229927;10158.492075396201;11248.54909657905;11417.657470275823;11475.827862582068;11488;3664.780113193217;3678.576963649161;3686.189038411545;3701.222743223926;3839.884803455901;60010;60936.69531652313;72627;80589.38821223543;89417.31748047569;10739.463026848782;10843.409316154608;10973.50619222137;11034.17243706709;11345.03567196781;21128.260510882046;21136;21153.471163221042;21163.259285925225;21209.257675981575;7696.692132314756;7741.767746967487;7816.179301173409;7820.452568320276;8028.397870159762;4224.491316985938;4257.446531950826;4315.136972605492;4409.140217657526;4478.731276123443;3225.1614580209316;3336.399448099317;3342.5487559179687;3348.28011977426;3349.69852713257;576;596.5317225977586;598.9670568118795;615.8768246350747;617.6849806598667;522.8980348831941;566.8072855229159;670.3832474123818;672.7107343842194;675.645286224736;7523.510971786816;8124.878126828103;8321.417500774887;8834.514101724339;8927.10728927115;637.3053371824733;648.1573953859963;655.1090516897016;667.3526679121245;669.6250099944046;3955.545112312121;4345.152695224464;4348.499922508889;4386.583274588909;4411.823129792237;74862.62568687122;75220;92880.53559732158;106844;115852;83182;83668.58165709133;84027;87446;101358.98641013644;77523;78470;78641;78865;79341.60329198433;9027.199313657706;9373.765655858659;9374.437533747998;9380.81238375215;9510.572024259063;49729.50270497249;51851.2222316658;53191.46808531865;53237.4676253248;54544.45455545552;68276.6586167066;74443;75065.62467187628;76046.61976690302;77347.83978240444;11484.484873874397;11578.536858525564;11732.538901024047;11759.882401175879;12165.452554634885;10904.291221070605;13175.934120329337;13346.799798002843;13572.93213533926;13876.653083672989;10693;12152;12557.811632825698;12593.244405335709;13006.089573729749;11934.52261909514;12195.329256890956;12343.382830858242;12845.229286242855;13018.934905325414;12065.879341206475;12310.384480775747;12484.188527745668;12593.055520836157;12680.492780288685;9584.329096963145;9638.807223855343;10106.292559521056;10265.384076955406;10434.791304174027;10078.79842403133;10669.199810014125;10711.303765255234;10723.517441714985;10737.838932415863 10:19:07 INFO - PROCESS | 1653 | __end_tp_report 10:19:07 INFO - PROCESS | 1653 | __start_cc_report 10:19:07 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,2835 10:19:07 INFO - PROCESS | 1653 | __end_cc_report 10:19:07 INFO - PROCESS | 1653 | __startTimestamp1479493147804__endTimestamp 10:19:07 INFO - PROCESS | 1653 | 10:19:07 INFO - PROCESS | 1653 | ------- Summary: start ------- 10:19:07 INFO - PROCESS | 1653 | Number of tests: 6 10:19:07 INFO - PROCESS | 1653 | 10:19:07 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5669.25 Median:5816.56 stddev:645.04 (11.1%) stddev-sans-first:610.81 10:19:07 INFO - PROCESS | 1653 | Values: 2952.9 3267.0 3307.2 3338.5 3380.8 5202.6 5489.2 5578.9 5587.6 5594.4 5604.3 5631.4 5701.3 5707.4 5755.8 5143.6 5210.8 5228.4 5229.8 5253.8 5113.1 5202.5 5254.1 5267.7 5282.3 5278.8 5288.8 5290.6 5308.9 5347.9 4488.3 5106.7 5126.9 5274.6 5296.3 5100.5 5176.6 5182.3 5184.0 5190.0 5643.2 5645.4 5665.5 5668.6 5676.6 6094.1 6095.2 6096.7 6108.1 6134.6 6143.3 6150.0 6152.6 6162.9 6168.0 5667.1 5703.5 5721.1 5732.5 5745.5 6284.3 6317.1 6322.5 6328.7 6331.4 5978.5 6073.5 6075.0 6084.1 6131.0 6177.0 6206.8 6216.2 6216.8 6222.5 5921.3 5957.5 5965.8 6001.5 6035.3 6085.9 6105.8 6112.7 6113.9 6121.8 4843.5 4909.4 4919.5 4924.4 4954.0 4318.5 4351.4 4352.1 4352.9 4372.6 5682.3 5695.8 5711.4 5765.8 5769.3 6226.0 6226.4 6239.6 6251.0 6259.7 5554.4 5628.4 5689.8 5705.2 5714.1 4642.7 5297.7 5314.9 5333.7 5408.3 6255.1 6349.9 6355.4 6365.7 6390.9 6091.4 6133.8 6164.4 6167.9 6190.7 6244.8 6290.1 6312.5 6327.0 6333.2 6040.2 6087.5 6101.4 6123.5 6143.3 6176.9 6217.7 6221.3 6243.2 6251.7 5704.8 5814.0 5859.2 6004.9 6052.1 5899.1 5910.1 5916.3 5922.6 5935.2 4981.3 5777.3 5804.9 5817.1 5835.7 5893.3 5928.5 5938.5 5944.2 5948.6 5784.5 5810.4 5816.6 5817.3 5827.6 10:19:07 INFO - PROCESS | 1653 | 10:19:07 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:63286.01 Median:38741.11 stddev:135938.44 (350.9%) stddev-sans-first:136237.96 10:19:07 INFO - PROCESS | 1653 | Values: 466.9 505.6 517.7 525.4 552.8 38521.4 39607.4 39660.6 41811.0 41900.0 41374.0 41662.8 41751.4 41764.8 41846.4 9223.0 9382.8 9396.8 9397.8 9398.9 9271.7 9366.9 9374.7 9395.1 9397.8 9395.5 9411.2 9423.6 9433.2 9438.9 9347.6 9409.7 9415.9 9416.9 9419.0 9370.9 9437.9 9447.9 9454.3 9466.2 38611.6 38726.6 38755.6 38862.6 39019.8 3171.3 3253.7 3346.5 3629.9 3633.7 29130.6 29260.4 30009.7 30350.8 31647.8 3150.5 3153.0 3164.8 3206.7 3251.6 430245.0 454089.7 456329.0 464406.0 468973.0 58711.4 59150.7 59291.7 59442.0 59606.0 28108.4 61784.7 61908.7 61942.4 61999.7 14873.6 15603.5 15624.2 15635.3 15677.8 11893.8 12005.6 12007.2 12013.3 12026.0 18139.5 18259.3 18290.8 18294.6 18302.3 7403.4 7679.1 7758.0 7811.6 7813.5 801.0 840.8 981.9 1013.1 1053.2 24634.4 27877.7 29380.0 29384.6 29758.1 1038.5 1052.2 1077.7 1112.6 1116.0 14927.0 14942.7 14989.8 15022.0 15280.0 637071.0 645852.0 646659.0 647147.0 649047.0 56211.0 56652.4 56745.1 56937.4 57194.7 1218.3 1261.0 1327.3 1355.2 1381.5 23950.8 28494.4 28652.4 29853.4 30498.2 47000.5 47656.5 47698.0 47704.0 47720.0 389746.0 391290.0 391412.0 391643.0 392702.0 22612.8 23013.5 23277.3 25089.5 26018.5 43616.0 44747.0 45287.0 45748.8 46189.1 35343.0 36505.1 36763.3 37788.0 37809.0 33736.7 33965.3 36554.5 37234.0 37639.0 36582.6 36818.0 37001.8 37392.4 37456.4 27323.6 32553.8 32725.5 32804.3 32959.7 24268.3 24543.9 24580.3 24682.8 24685.6 10:19:07 INFO - PROCESS | 1653 | 10:19:07 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:32579.33 Median:18051.10 stddev:90099.30 (499.1%) stddev-sans-first:90319.56 10:19:07 INFO - PROCESS | 1653 | Values: 350.6 371.4 374.3 378.8 403.1 14692.6 14809.9 15399.5 20434.4 20494.8 18783.4 19041.8 19530.1 19681.5 19946.7 5665.6 5972.5 5978.7 5979.8 5996.6 4154.3 4384.2 4437.7 5893.0 5959.6 4384.1 4392.8 5437.7 6554.0 6576.3 5030.2 5682.5 6031.9 6623.3 6636.4 5849.1 5854.0 5856.0 5856.3 5858.4 12405.2 12596.7 12724.6 12829.5 12839.0 1925.3 2208.3 2215.0 2232.1 2400.5 9199.5 9611.4 10097.0 10210.8 10248.9 1567.4 1736.5 1817.2 1877.9 1885.4 112062.0 120685.0 121276.8 121469.0 122382.4 11070.4 11117.3 11178.7 11252.1 11367.7 14201.0 14240.1 14246.6 14273.5 14344.2 7891.3 8181.3 8185.8 8262.4 8309.3 8009.7 8023.8 8059.0 8122.6 8235.3 4333.6 4352.0 4361.5 4365.2 4443.8 1703.8 1811.2 1870.4 1883.5 1886.4 742.9 755.3 758.0 817.6 876.0 18454.5 19161.6 19352.0 19978.8 20034.5 857.9 886.4 903.8 908.2 911.3 10065.5 10414.9 10447.6 10621.6 10641.7 523868.0 526941.4 531627.0 545522.3 546934.0 110799.4 126969.0 127613.7 129510.0 132080.3 909.6 964.9 987.7 988.6 992.6 17490.0 18358.7 18464.3 18473.8 18504.0 35751.6 51862.5 55849.9 56074.2 56290.0 79478.0 80051.4 80933.3 83149.0 83227.6 5971.4 6788.4 7243.3 7330.1 7349.3 8994.3 12410.9 12618.6 12906.5 13121.7 10629.4 10680.6 11261.5 11330.0 11488.7 10683.9 10746.6 11139.3 11291.6 11326.4 11020.9 11250.8 11274.7 11620.2 11643.2 6294.5 6940.3 7297.8 7499.7 7600.2 9220.3 9425.8 11206.5 11272.6 11317.4 10:19:07 INFO - PROCESS | 1653 | 10:19:07 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5288.00 Median:5514.67 stddev:2880.65 (52.2%) stddev-sans-first:2872.48 10:19:07 INFO - PROCESS | 1653 | Values: 1217.4 1287.4 1471.3 1614.6 1636.9 7818.6 8186.9 8259.9 8260.8 8262.7 7284.7 7480.5 7496.9 7876.3 8054.4 2040.0 2087.5 2136.7 2275.7 2325.0 2277.7 2327.8 2328.2 2329.1 2332.7 2022.8 2098.8 2268.5 2294.9 2298.7 2184.8 2248.4 2254.9 2260.6 2261.0 2228.2 2256.7 2259.7 2262.6 2263.6 8078.2 8143.1 8150.2 8169.6 8187.3 4862.1 5114.0 5116.3 5134.6 5135.8 3332.4 3409.8 3483.3 3495.7 3513.0 1042.8 1043.6 1066.9 1071.0 1079.5 10435.2 10518.2 10550.4 10557.0 10575.5 4224.6 4253.5 4367.2 4417.7 4427.5 8494.2 8519.6 8524.3 8528.4 8536.7 5072.9 5075.5 5084.3 5090.8 5093.7 4538.6 4655.8 4680.3 4771.2 4780.5 3576.8 3613.5 3625.4 3672.6 3687.6 992.5 1138.5 1139.0 1147.2 1148.7 774.9 797.2 830.0 886.3 913.5 5435.1 5474.6 5554.7 5642.6 5660.0 852.5 901.0 903.3 903.5 904.6 3642.7 3684.8 3722.4 3823.4 3864.2 8661.1 9771.6 9887.2 9887.9 9889.6 9827.6 9844.0 9851.8 9872.3 9885.6 5797.4 7537.8 7725.6 7751.2 7763.0 5562.3 5716.7 5739.2 5820.4 5846.1 8995.8 9051.0 9113.1 9151.3 9207.2 9086.9 9106.9 9324.9 9363.3 9498.5 6851.9 7074.0 7088.1 7099.0 7107.4 7543.7 7573.2 7594.2 7659.8 7689.8 6960.7 7015.8 7045.7 7065.8 7109.4 6682.8 6787.3 6818.6 6836.0 6885.8 6455.5 6483.6 6489.2 6532.3 6548.7 4329.9 4609.6 4721.2 4740.5 4844.6 4403.7 4742.4 4763.1 4804.3 4896.4 10:19:07 INFO - PROCESS | 1653 | 10:19:07 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4250.26 Median:4731.07 stddev:1329.40 (28.1%) stddev-sans-first:1299.38 10:19:07 INFO - PROCESS | 1653 | Values: 284.4 296.3 301.9 305.0 313.0 4308.5 4836.2 4862.0 4868.0 4904.2 4103.0 4869.5 4869.8 5026.3 5043.9 3695.5 3707.5 3746.8 3920.9 3930.4 3363.8 3477.3 3873.2 3933.4 3935.9 3354.4 3518.1 3614.7 3765.0 3865.4 3279.0 3329.2 3565.0 3638.4 3873.8 2712.4 3353.9 3360.7 3375.2 3381.1 4414.2 4420.5 4902.6 4938.8 4949.5 4145.8 4326.5 4352.5 4386.5 4390.8 4923.8 5294.5 5301.7 5310.1 5323.7 3113.8 3135.6 3634.9 3653.0 3671.9 4629.8 4691.2 5063.6 5448.5 5576.2 3461.9 3663.8 3688.3 3696.4 3705.9 3735.8 3740.9 3746.1 3757.2 3785.4 3524.6 4046.6 4330.6 4333.0 4386.6 4207.0 5086.8 5318.0 5390.8 5412.6 1186.9 1211.7 1220.2 1223.6 1230.2 790.3 795.8 808.4 828.9 841.4 4463.7 4695.2 4729.4 4731.3 4800.6 4536.3 4903.5 5108.7 5136.7 5141.6 4025.7 4403.1 4551.0 4714.5 4730.8 2491.7 2599.2 2737.9 2774.8 2777.8 4416.4 5412.0 5437.5 5438.0 5481.0 4601.8 4805.6 5247.4 5312.9 5353.6 5187.9 5817.2 5833.5 5862.6 5873.3 4758.8 4896.4 5093.5 5601.2 5727.7 4827.6 5444.3 5529.9 5547.8 5574.9 5440.7 5752.5 5776.9 5812.4 5831.7 3101.3 3292.4 3516.6 3715.8 3729.3 5473.0 5484.7 5502.3 5502.8 5510.3 5147.5 5147.9 5305.4 5334.7 5399.2 4686.5 5039.0 5406.9 5418.4 5440.9 4926.7 5304.8 5310.7 5338.0 5366.4 4061.4 4691.4 4873.9 5108.6 5460.7 4974.5 5078.3 5095.3 5314.2 5317.7 10:19:07 INFO - PROCESS | 1653 | 10:19:07 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:19118.53 Median:27104.12 stddev:27038.33 (99.8%) stddev-sans-first:27078.73 10:19:07 INFO - PROCESS | 1653 | Values: 678.2 679.6 699.3 738.6 773.7 13874.9 14666.8 14706.6 14740.6 14757.3 11912.3 13274.5 13474.1 13499.9 14741.3 798.3 818.3 819.8 819.8 820.2 816.1 820.3 823.8 825.3 828.9 847.3 849.8 862.1 863.2 864.1 856.7 857.6 858.0 858.5 858.9 635.7 636.5 636.6 636.7 638.8 13999.6 14004.7 14007.6 14021.6 14036.0 13349.4 13769.3 13866.4 13898.5 13983.2 10158.5 11248.5 11417.7 11475.8 11488.0 3664.8 3678.6 3686.2 3701.2 3839.9 60010.0 60936.7 72627.0 80589.4 89417.3 10739.5 10843.4 10973.5 11034.2 11345.0 21128.3 21136.0 21153.5 21163.3 21209.3 7696.7 7741.8 7816.2 7820.5 8028.4 4224.5 4257.4 4315.1 4409.1 4478.7 3225.2 3336.4 3342.5 3348.3 3349.7 576.0 596.5 599.0 615.9 617.7 522.9 566.8 670.4 672.7 675.6 7523.5 8124.9 8321.4 8834.5 8927.1 637.3 648.2 655.1 667.4 669.6 3955.5 4345.2 4348.5 4386.6 4411.8 74862.6 75220.0 92880.5 106844.0 115852.0 83182.0 83668.6 84027.0 87446.0 101359.0 77523.0 78470.0 78641.0 78865.0 79341.6 9027.2 9373.8 9374.4 9380.8 9510.6 49729.5 51851.2 53191.5 53237.5 54544.5 68276.7 74443.0 75065.6 76046.6 77347.8 11484.5 11578.5 11732.5 11759.9 12165.5 10904.3 13175.9 13346.8 13572.9 13876.7 10693.0 12152.0 12557.8 12593.2 13006.1 11934.5 12195.3 12343.4 12845.2 13018.9 12065.9 12310.4 12484.2 12593.1 12680.5 9584.3 9638.8 10106.3 10265.4 10434.8 10078.8 10669.2 10711.3 10723.5 10737.8 10:19:07 INFO - PROCESS | 1653 | -------- Summary: end -------- 10:19:07 INFO - PROCESS | 1653 | 10:19:08 INFO - TEST-INFO | 1653: exit 0 10:19:08 INFO - TEST-OK | dromaeo_css | took 1121398ms 10:19:08 INFO - TEST-START | kraken 10:19:08 INFO - operating with platform_type : mac_ 10:19:08 INFO - Initialising browser for kraken test... 10:19:08 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmpljMduA/profile http://localhost:49243/getInfo.html) 10:19:11 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 10:19:11 INFO - PROCESS | 1662 | colorDepth:24 10:19:11 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 10:19:11 INFO - PROCESS | 1662 | __metrics 10:19:11 INFO - PROCESS | 1662 | 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" 10:19:11 INFO - PROCESS | 1662 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:19:12 INFO - TEST-INFO | 1662: exit 0 10:19:12 INFO - Browser initialized. 10:19:12 INFO - Running cycle 1/1 for kraken test... 10:19:12 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmpljMduA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:19:24 INFO - PROCESS | 1663 | RSS: Main: 243232768 10:19:24 INFO - PROCESS | 1663 | 10:19:27 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 10:19:28 INFO - PROCESS | 1663 | RSS: Main: 294965248 10:19:28 INFO - PROCESS | 1663 | 10:19:30 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 10:19:31 INFO - PROCESS | 1663 | RSS: Main: 297197568 10:19:31 INFO - PROCESS | 1663 | 10:19:35 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 10:19:35 INFO - PROCESS | 1663 | RSS: Main: 385597440 10:19:35 INFO - PROCESS | 1663 | 10:19:37 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 10:19:38 INFO - PROCESS | 1663 | RSS: Main: 288190464 10:19:38 INFO - PROCESS | 1663 | 10:19:40 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:19:41 INFO - PROCESS | 1663 | RSS: Main: 291741696 10:19:41 INFO - PROCESS | 1663 | 10:19:43 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 10:19:44 INFO - PROCESS | 1663 | RSS: Main: 333897728 10:19:44 INFO - PROCESS | 1663 | 10:19:47 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 10:19:48 INFO - PROCESS | 1663 | RSS: Main: 336195584 10:19:48 INFO - PROCESS | 1663 | 10:19:51 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 10:19:51 INFO - PROCESS | 1663 | RSS: Main: 332525568 10:19:51 INFO - PROCESS | 1663 | 10:19:53 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:19:54 INFO - PROCESS | 1663 | RSS: Main: 309837824 10:19:54 INFO - PROCESS | 1663 | 10:19:55 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:19:56 INFO - PROCESS | 1663 | RSS: Main: 314306560 10:19:56 INFO - PROCESS | 1663 | 10:19:58 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:19:59 INFO - PROCESS | 1663 | RSS: Main: 316239872 10:19:59 INFO - PROCESS | 1663 | 10:20:02 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:20:03 INFO - PROCESS | 1663 | RSS: Main: 329220096 10:20:03 INFO - PROCESS | 1663 | 10:20:06 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:20:06 INFO - PROCESS | 1663 | RSS: Main: 327135232 10:20:06 INFO - PROCESS | 1663 | 10:20:08 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 10:20:08 INFO - PROCESS | 1663 | RSS: Main: 370847744 10:20:08 INFO - PROCESS | 1663 | 10:20:08 INFO - PROCESS | 1663 | __start_tp_report 10:20:08 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 10:20:08 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 10:20:08 INFO - PROCESS | 1663 | |i|pagename|runs| 10:20:08 INFO - PROCESS | 1663 | |0;ai-astar;114;113;113;114;113;113;113;113;113;113 10:20:08 INFO - PROCESS | 1663 | |1;audio-beat-detection;150;113;118;150;114;126;123;113;143;111 10:20:08 INFO - PROCESS | 1663 | |2;audio-dft;182;180;184;187;185;182;220;182;179;181 10:20:08 INFO - PROCESS | 1663 | |3;audio-fft;78;74;76;107;80;68;59;59;83;58 10:20:08 INFO - PROCESS | 1663 | |4;audio-oscillator;94;70;92;71;69;70;90;67;70;92 10:20:08 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;87;83;86;84;86;83;87;86;124;115 10:20:08 INFO - PROCESS | 1663 | |6;imaging-darkroom;95;100;100;96;104;138;148;154;95;95 10:20:08 INFO - PROCESS | 1663 | |7;imaging-desaturate;85;83;88;87;87;101;129;129;87;85 10:20:08 INFO - PROCESS | 1663 | |8;json-parse-financial;57;55;53;55;55;54;56;55;54;54 10:20:08 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;66;70;81;76;72;69;69;70;70;72 10:20:08 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;89;88;89;88;87;88;87;88;88;89 10:20:08 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;154;150;148;151;146;150;152;148;245;160 10:20:08 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;180;174;175;180;170;173;172;172;174;172 10:20:08 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;68;68;68;69;68;68;68;67;67;68 10:20:08 INFO - PROCESS | 1663 | __end_tp_report 10:20:08 INFO - PROCESS | 1663 | __start_cc_report 10:20:08 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1968 10:20:08 INFO - PROCESS | 1663 | __end_cc_report 10:20:08 INFO - PROCESS | 1663 | __startTimestamp1479493208826__endTimestamp 10:20:08 INFO - PROCESS | 1663 | 10:20:08 INFO - PROCESS | 1663 | ------- Summary: start ------- 10:20:08 INFO - PROCESS | 1663 | Number of tests: 14 10:20:08 INFO - PROCESS | 1663 | 10:20:08 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:113.20 Median:113.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 10:20:08 INFO - PROCESS | 1663 | Values: 114.0 113.0 113.0 114.0 113.0 113.0 113.0 113.0 113.0 113.0 10:20:08 INFO - PROCESS | 1663 | 10:20:08 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:126.10 Median:124.50 stddev:15.71 (12.6%) stddev-sans-first:14.08 10:20:08 INFO - PROCESS | 1663 | Values: 150.0 113.0 118.0 150.0 114.0 126.0 123.0 113.0 143.0 111.0 10:20:08 INFO - PROCESS | 1663 | 10:20:08 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:186.20 Median:183.00 stddev:12.11 (6.6%) stddev-sans-first:12.75 10:20:08 INFO - PROCESS | 1663 | Values: 182.0 180.0 184.0 187.0 185.0 182.0 220.0 182.0 179.0 181.0 10:20:08 INFO - PROCESS | 1663 | 10:20:08 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:74.20 Median:75.00 stddev:14.79 (19.7%) stddev-sans-first:15.62 10:20:08 INFO - PROCESS | 1663 | Values: 78.0 74.0 76.0 107.0 80.0 68.0 59.0 59.0 83.0 58.0 10:20:08 INFO - PROCESS | 1663 | 10:20:08 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:78.50 Median:80.50 stddev:11.70 (14.5%) stddev-sans-first:10.99 10:20:08 INFO - PROCESS | 1663 | Values: 94.0 70.0 92.0 71.0 69.0 70.0 90.0 67.0 70.0 92.0 10:20:08 INFO - PROCESS | 1663 | 10:20:08 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:92.10 Median:86.00 stddev:14.67 (17.1%) stddev-sans-first:15.44 10:20:08 INFO - PROCESS | 1663 | Values: 87.0 83.0 86.0 84.0 86.0 83.0 87.0 86.0 124.0 115.0 10:20:08 INFO - PROCESS | 1663 | 10:20:08 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:112.50 Median:124.50 stddev:24.06 (19.3%) stddev-sans-first:24.67 10:20:08 INFO - PROCESS | 1663 | Values: 95.0 100.0 100.0 96.0 104.0 138.0 148.0 154.0 95.0 95.0 10:20:08 INFO - PROCESS | 1663 | 10:20:08 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:86.00 stddev:18.02 (20.9%) stddev-sans-first:18.65 10:20:08 INFO - PROCESS | 1663 | Values: 85.0 83.0 88.0 87.0 87.0 101.0 129.0 129.0 87.0 85.0 10:20:08 INFO - PROCESS | 1663 | 10:20:08 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:1.14 (2.1%) stddev-sans-first:0.88 10:20:08 INFO - PROCESS | 1663 | Values: 57.0 55.0 53.0 55.0 55.0 54.0 56.0 55.0 54.0 54.0 10:20:08 INFO - PROCESS | 1663 | 10:20:08 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:71.50 Median:71.00 stddev:4.22 (5.9%) stddev-sans-first:3.98 10:20:08 INFO - PROCESS | 1663 | Values: 66.0 70.0 81.0 76.0 72.0 69.0 69.0 70.0 70.0 72.0 10:20:08 INFO - PROCESS | 1663 | 10:20:08 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:88.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 10:20:08 INFO - PROCESS | 1663 | Values: 89.0 88.0 89.0 88.0 87.0 88.0 87.0 88.0 88.0 89.0 10:20:08 INFO - PROCESS | 1663 | 10:20:08 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:160.40 Median:151.50 stddev:29.98 (19.8%) stddev-sans-first:31.71 10:20:08 INFO - PROCESS | 1663 | Values: 154.0 150.0 148.0 151.0 146.0 150.0 152.0 148.0 245.0 160.0 10:20:08 INFO - PROCESS | 1663 | 10:20:08 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.20 Median:174.00 stddev:3.36 (1.9%) stddev-sans-first:2.83 10:20:08 INFO - PROCESS | 1663 | Values: 180.0 174.0 175.0 180.0 170.0 173.0 172.0 172.0 174.0 172.0 10:20:08 INFO - PROCESS | 1663 | 10:20:08 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 10:20:08 INFO - PROCESS | 1663 | Values: 68.0 68.0 68.0 69.0 68.0 68.0 68.0 67.0 67.0 68.0 10:20:08 INFO - PROCESS | 1663 | -------- Summary: end -------- 10:20:08 INFO - PROCESS | 1663 | 10:20:09 INFO - TEST-INFO | 1663: exit 0 10:20:09 INFO - TEST-OK | kraken | took 61434ms 10:20:09 INFO - SUITE-END | took 1182s 10:20:09 INFO - Completed test suite (00:19:42) 10:20:09 INFO - javascript benchmark 10:20:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2952.92617684558, 3266.9999999999995, 3307.2228026413804, 3338.515915192297, 3380.814055226963, 5202.583793296537, 5489.231507588941, 5578.86052848679, 5587.580931430139, 5594.412586678396, 5604.327480702311, 5631.352394474637, 5701.315842098954, 5707.429257074291, 5755.827325180241, 5143.639945203838, 5210.817621383252, 5228.424873263938, 5229.8169564065265, 5253.763580638862, 5113.105206588851, 5202.479752024805, 5254.106801843695, 5267.736613169345, 5282.31329927109, 5278.762455689503, 5288.8413347599635, 5290.576753859682, 5308.893822123555, 5347.946520534783, 4488.304312831484, 5106.66806657566, 5126.871828204287, 5274.6307758457115, 5296.25852380667, 5100.489951004907, 5176.6117541184185, 5182.274481572583, 5183.989122121188, 5190.039842629126, 5643.209950606918, 5645.350784659776, 5665.518430933375, 5668.57485688575, 5676.631018983753, 6094.085887116968, 6095.207623009025, 6096.69516524172, 6108.144859719643, 6134.631922084689, 6143.310589587854, 6149.954507733696, 6152.6308421494405, 6162.907556386658, 6167.969160154215, 5667.086045621127, 5703.486686198262, 5721.141828725683, 5732.484076433141, 5745.454181852676, 6284.277308109535, 6317.084022816758, 6322.4942004639515, 6328.71520781566, 6331.366863313724, 5978.469149566272, 6073.4837538808815, 6074.969625151934, 6084.117802918552, 6131.049687298476, 6177.038695870212, 6206.751729930843, 6216.191895053614, 6216.844578885564, 6222.533310001768, 5921.289445266596, 5957.523398128226, 5965.79119730816, 6001.459868611846, 6035.275766907911, 6085.939140608626, 6105.8168254952425, 6112.663803490762, 6113.908291375633, 6121.755129794758, 4843.539863712942, 4909.410870695539, 4919.4834542373255, 4924.4090709115135, 4953.984433191187, 4318.5033721121845, 4351.369051487517, 4352.064306174125, 4352.869413917588, 4372.562743725602, 5682.261306030272, 5695.829125126253, 5711.371749107595, 5765.798197063166, 5769.278840144982, 6226.034964580497, 6226.40849119333, 6239.563230573907, 6250.968745156336, 6259.749610015549, 5554.361248456398, 5628.352739435018, 5689.7724091036725, 5705.1727499512335, 5714.085746280575, 4642.744649044335, 5297.708626025606, 5314.946850531445, 5333.653312534673, 5408.323959505062, 6255.124282600348, 6349.920513512714, 6355.364463553793, 6365.7135428904885, 6390.9041364378645, 6091.360407157184, 6133.8466538335115, 6164.352742961924, 6167.876642467036, 6190.659513726789, 6244.750209991549, 6290.119383286435, 6312.4634406074165, 6327.0, 6333.240011198685, 6040.244969378828, 6087.482563981934, 6101.359357267601, 6123.510119190543, 6143.324234334309, 6176.857281402955, 6217.658028808459, 6221.253449585897, 6243.219597550306, 6251.749930002931, 5704.771809127588, 5814.04068328721, 5859.174062217469, 6004.87990240184, 6052.122442245938, 5899.056151015817, 5910.083936989773, 5916.319623243382, 5922.585419020627, 5935.228420305332, 4981.327520784793, 5777.306723193244, 5804.94195058044, 5817.069268916953, 5835.708214589169, 5893.322267939242, 5928.525717942641, 5938.465538101592, 5944.1975333331175, 5948.553858460719, 5784.479396854304, 5810.389909059657, 5816.563757718103, 5817.301923769006, 5827.59206855516], "value": 5626.592359828241, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [466.86227562868953, 505.60310156527134, 517.6505858545482, 525.4115390762347, 552.7954656776993, 38521.42217866731, 39607.40588891166, 39660.603393966085, 41811.0, 41900.0, 41374.0, 41662.7916860416, 41751.37372939401, 41764.79117604408, 41846.37230441546, 9222.953885230581, 9382.812343753121, 9396.81206375872, 9397.81204375912, 9398.906010939905, 9271.675491357804, 9366.906330936705, 9374.67188648394, 9395.107464790834, 9397.81204375912, 9395.530223488799, 9411.200047995928, 9423.62305507779, 9433.151016408521, 9438.905610943906, 9347.579358928831, 9409.717708468757, 9415.858762118574, 9416.858747118798, 9418.952905235465, 9370.85943710845, 9437.858432123523, 9447.90552094477, 9454.290928180346, 9466.242700583936, 38611.61388386136, 38726.612733872586, 38755.612443875485, 38862.61137388618, 39019.8049009756, 3171.349873275973, 3253.7071663550396, 3346.5147553604593, 3629.909252268688, 3633.654802793757, 29130.563041554393, 29260.41479170426, 30009.69990300113, 30350.84824575885, 31647.841760791278, 3150.5116706910467, 3152.952705709416, 3164.7784655074156, 3206.679332066798, 3251.64231934487, 430245.0, 454089.72955135343, 456329.0, 464406.0, 468973.0, 58711.41288587145, 59150.70424647849, 59291.70354148201, 59442.0, 59606.0, 28108.43783124326, 61784.69107654523, 61908.69045654743, 61942.38057619456, 61999.6900015497, 14873.553793386216, 15603.453879114177, 15624.218789060502, 15635.296411661502, 15677.764833527506, 11893.76212475763, 12005.63983080509, 12007.159498835172, 12013.339266340436, 12025.977791887788, 18139.54651133706, 18259.269629214683, 18290.81709182891, 18294.63410731778, 18302.26790928348, 7403.370713489414, 7679.116901556393, 7758.0, 7811.648475818602, 7813.492123011986, 800.9839803203903, 840.7603832907593, 981.9263555233387, 1013.0730381700808, 1053.199568328076, 24634.384140396276, 27877.721222787917, 29379.98405103677, 29384.559231611544, 29758.107256782332, 1038.4963292802984, 1052.1530168214508, 1077.6713102503654, 1112.57165991094, 1115.9776804463866, 14927.0, 14942.729867961127, 14989.775153372708, 15022.0, 15280.006799557994, 637071.0, 645852.0, 646659.0, 647147.0, 649047.0, 56211.0, 56652.433475664715, 56745.14882276769, 56937.43062569404, 57194.71402643043, 1218.2507757728933, 1261.0353079893705, 1327.3097989045834, 1355.1936597724339, 1381.530279704905, 23950.760492394853, 28494.43011139724, 28652.42695146044, 29853.402931941673, 30498.237544061576, 47000.529994700984, 47656.52343476521, 47698.0, 47704.0, 47720.0, 389746.0, 391290.0, 391412.0, 391643.0, 392702.0, 22612.773872261725, 23013.53972920566, 23277.3016809496, 25089.49821003606, 26018.528239817188, 43616.0, 44747.0, 45287.0, 45748.765222260314, 46189.07621847611, 35343.0, 36505.08737281589, 36763.26473470462, 37788.0, 37809.0, 33736.66263337433, 33965.32069358649, 36554.451683224244, 37234.0, 37639.0, 36582.63417365792, 36818.0, 37001.814990924875, 37392.439113413864, 37456.438153427174, 27323.59014614822, 32553.837230814643, 32725.50911736278, 32804.34391312208, 32959.67040329566, 24268.271951841474, 24543.877280613484, 24580.335731415154, 24682.753172468765, 24685.5925199394], "value": 19131.19954091934, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.5600471408382, 371.4428357463804, 374.26830546282, 378.7878787878788, 403.07494300580163, 14692.632684182887, 14809.925950370247, 15399.525415261633, 20434.386968390972, 20494.795052049474, 18783.436496905113, 19041.809581904177, 19530.121144548495, 19681.53980752406, 19946.70079948802, 5665.575081868866, 5972.522198224132, 5978.730957106941, 5979.820605381824, 5996.610220335686, 4154.293770059082, 4384.21084204843, 4437.733735975836, 5892.9705351473185, 5959.642421454727, 4384.101259241847, 4392.846250381237, 5437.728113594324, 6554.0, 6576.342365763433, 5030.220315851049, 5682.51698605619, 6031.8793624127275, 6623.304553021935, 6636.435902948231, 5849.122631605251, 5853.970730146322, 5855.970720146372, 5856.267966504187, 5858.443447872445, 12405.193662411913, 12596.748065038739, 12724.554640587536, 12829.486820527261, 12839.0, 1925.258775371492, 2208.2823082498253, 2214.9889250553806, 2232.118313266251, 2400.50789588134, 9199.494027828467, 9611.423314601147, 10097.040781125856, 10210.795784084277, 10248.897511024943, 1567.4435575370808, 1736.4877361178483, 1817.173186200289, 1877.9248830046918, 1885.4343696890878, 112062.0, 120685.0, 121276.78723212743, 121469.0, 122382.38808806078, 11070.39112848801, 11117.332960022424, 11178.720531986766, 11252.099832013419, 11367.715807104889, 14201.0, 14240.145591264558, 14246.572602821932, 14273.500427484989, 14344.211068391338, 7891.28978391936, 8181.263686268146, 8185.836283274421, 8262.380321475914, 8309.335253179732, 8009.719659811995, 8023.799405014921, 8059.032916049994, 8122.593870306461, 8235.258826705625, 4333.566643335641, 4351.9564804352185, 4361.454818147731, 4365.214261432909, 4443.822247110079, 1703.7870266216723, 1811.2302271534545, 1870.429518996719, 1883.52143567299, 1886.4434991677488, 742.9257074292527, 755.2787088330631, 757.9886301705479, 817.6198067898456, 875.9737207883774, 18454.538636534195, 19161.616767664567, 19352.032398380026, 19978.80127192373, 20034.499137521387, 857.9227869491775, 886.3883920095113, 903.7921278105941, 908.2098574240453, 911.3438324406417, 10065.547050382751, 10414.947925260325, 10447.582096716198, 10621.575136994434, 10641.733956651145, 523868.0, 526941.365293171, 531627.0, 545522.2723886435, 546934.0, 110799.44600276947, 126969.0, 127613.72386276019, 129510.0, 132080.3395983014, 909.6452383570413, 964.8745663063756, 987.7283746969497, 988.5650313861878, 992.5731935267904, 17490.03804790749, 18358.724619130455, 18464.26142954267, 18473.815261847747, 18504.0, 35751.64248357483, 51862.481375185766, 55849.88300233892, 56074.1588876159, 56290.0, 79478.0, 80051.3989720214, 80933.26768030928, 83149.0, 83227.5838620803, 5971.402859713994, 6788.355106264897, 7243.311885370881, 7330.120385553554, 7349.265073492822, 8994.280457563511, 12410.904401547286, 12618.621441356774, 12906.483740650268, 13121.671958201121, 10629.362238265729, 10680.626178084041, 11261.549538018387, 11330.03694685928, 11488.712782180512, 10683.94658026705, 10746.623868164577, 11139.33164010162, 11291.606943781027, 11326.37704926237, 11020.944895275472, 11250.774984500427, 11274.661760147208, 11620.186586938833, 11643.184977051525, 6294.4964402846745, 6940.305969403019, 7297.781066568012, 7499.700011999677, 7600.239976002355, 9220.308476864127, 9425.811483770149, 11206.495707693337, 11272.60545880923, 11317.377544235145], "value": 8987.320988407651, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1217.4338932396433, 1287.3627554360594, 1471.2790732541052, 1614.628635413854, 1636.8526832585064, 7818.648160832762, 8186.877196842052, 8259.876101858463, 8260.793480162998, 8262.669493220272, 7284.672189751461, 7480.513766605167, 7496.92503074969, 7876.330511906494, 8054.355651547877, 2040.030985281994, 2087.5198704298023, 2136.7222261106035, 2275.681404603357, 2324.953770803137, 2277.7266727992665, 2327.767223277667, 2328.15022516781, 2329.1032952313312, 2332.7317358503733, 2022.817946384825, 2098.842586805988, 2268.466910276092, 2294.8623082615013, 2298.712660917385, 2184.8361372897016, 2248.37045627223, 2254.9436264093365, 2260.570491606598, 2260.977390226093, 2228.2423975848287, 2256.650219216008, 2259.7062381890414, 2262.592733308004, 2263.603869322862, 8078.1921807819335, 8143.144969778147, 8150.184981501861, 8169.591520424015, 8187.263146316801, 4862.051899879525, 5114.0, 5116.283720279164, 5134.563562097226, 5135.8202462914, 3332.3668502984356, 3409.7783644063056, 3483.28592638511, 3495.720342372604, 3513.0163554204864, 1042.775803202315, 1043.6190790361538, 1066.9093127084207, 1070.9678709638724, 1079.4656644960717, 10435.217358698052, 10518.211134164892, 10550.366977981423, 10557.0, 10575.471226438647, 4224.556421575752, 4253.532111467736, 4367.192069467159, 4417.712848664826, 4427.490838553543, 8494.193051660082, 8519.616617252115, 8524.31805455562, 8528.40301178924, 8536.70121545743, 5072.873178170502, 5075.5178258065425, 5084.313617661643, 5090.821821236239, 5093.719845408538, 4538.591526762607, 4655.767211639404, 4680.251159814414, 4771.23660214364, 4780.545848144421, 3576.803275819855, 3613.5483064616924, 3625.4380571011534, 3672.559292884871, 3687.5943646199435, 992.4789485520015, 1138.5161306444893, 1139.0375133012592, 1147.17976646698, 1148.7415331550335, 774.8605251054864, 797.2266901105918, 830.0454477351094, 886.2998231397124, 913.4975763330142, 5435.076037073707, 5474.644148130359, 5554.6944918029085, 5642.605017648807, 5660.0, 852.4970267542055, 900.9819803603891, 903.3450748207629, 903.5391950105494, 904.5703290936884, 3642.6903713184147, 3684.8341824617955, 3722.4230244312175, 3823.3691440912494, 3864.1885204107452, 8661.13388661129, 9771.609135634637, 9887.209023278121, 9887.901120988841, 9889.604415823287, 9827.55775990068, 9844.046785964181, 9851.802963940681, 9872.308938374388, 9885.604575817031, 5797.420257974169, 7537.849243015109, 7725.575093369918, 7751.224877512203, 7762.961185194038, 5562.276904002454, 5716.657000579979, 5739.196512488172, 5820.447057529528, 5846.064629659234, 8995.775105622412, 9051.049639787727, 9113.088691130833, 9151.313651476034, 9207.17135457812, 9086.909130908607, 9106.863397048917, 9324.860127097963, 9363.250939924927, 9498.525073746147, 6851.931480685129, 7074.0, 7088.149422069178, 7099.006139140628, 7107.360337569644, 7543.660535275816, 7573.166951635426, 7594.164641889498, 7659.770206893802, 7689.846203076019, 6960.686769095504, 7015.824604384931, 7045.682944267418, 7065.752698655728, 7109.431245500244, 6682.76610318656, 6787.253402125861, 6818.556793808387, 6835.965820171066, 6885.793426197222, 6455.483561315177, 6483.578567393104, 6489.1888513935755, 6532.346765323429, 6548.672566371567, 4329.870103896888, 4609.617114865594, 4721.22099853534, 4740.4785473597185, 4844.563989240985, 4403.713758605681, 4742.407199100113, 4763.1426343258545, 4804.303376010389, 4896.36347274852], "value": 4282.454197708368, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.3786326875778, 296.3022082994548, 301.9018818883862, 304.98170109793415, 313.0233670946647, 4308.526062133167, 4836.226203807391, 4862.0032893256885, 4868.0, 4904.180096444541, 4102.958970410295, 4869.514797986612, 4869.805207791684, 5026.29631851541, 5043.899122017567, 3695.5380577427823, 3707.462417949396, 3746.8197517781878, 3920.941505709511, 3930.390789427629, 3363.798172109669, 3477.2871561329866, 3873.205992771489, 3933.449317095609, 3935.940960885589, 3354.3962086824363, 3518.0852978225716, 3614.7469677122613, 3764.964634725445, 3865.439511270864, 3278.96721032789, 3329.1535736944807, 3564.9643503564894, 3638.381475149231, 3873.8063096845044, 2712.362594790223, 3353.899383018513, 3360.663933606644, 3375.1899544109483, 3381.087106481261, 4414.161309351245, 4420.541221396931, 4902.632302577321, 4938.802447902115, 4949.455559888409, 4145.8334373953985, 4326.524082350938, 4352.455943007124, 4386.473623165209, 4390.758508282043, 4923.818283611908, 5294.523492885659, 5301.72758537952, 5310.114694481087, 5323.653962492425, 3113.79760315581, 3135.623725152996, 3634.890953271406, 3652.9634703652887, 3671.94492082619, 4629.7916593753025, 4691.202495575761, 5063.620228482879, 5448.536874365724, 5576.191452239403, 3461.8615255389504, 3663.8351274192723, 3688.2992231475932, 3696.353138200804, 3705.8511861323077, 3735.813209339522, 3740.8877733668032, 3746.1383881706815, 3757.200885340384, 3785.3943369060817, 3524.577050753926, 4046.575109613448, 4330.588594083557, 4332.956670433318, 4386.627136693353, 4207.0, 5086.77109530072, 5318.016167009116, 5390.757415916293, 5412.621116521885, 1186.851643544557, 1211.733418647896, 1220.20686553739, 1223.6451429085644, 1230.249547775874, 790.316376334478, 795.8249185179251, 808.4058217210346, 828.8715249136394, 841.4446465332851, 4463.687541872037, 4695.201815691341, 4729.361536192639, 4731.309578528753, 4800.591949684246, 4536.319552067216, 4903.53416425439, 5108.719020453911, 5136.691798492027, 5141.55776006394, 4025.6578190854107, 4403.097365040159, 4551.0, 4714.528547145258, 4730.834420795256, 2491.7383674714256, 2599.246218596586, 2737.8767955442054, 2774.805763596529, 2777.8194417362806, 4416.425864637641, 5411.9729401353525, 5437.483439073281, 5438.021156191923, 5480.98601758668, 4601.838935637236, 4805.6155507559315, 5247.431746412476, 5312.946870531246, 5353.625246232727, 5187.922181167285, 5817.185594016841, 5833.504152147115, 5862.648241105548, 5873.265841769693, 4758.809647614056, 4896.387951506062, 5093.516115968977, 5601.179616624695, 5727.6540013096055, 4827.613790896649, 5444.265024221838, 5529.944700552943, 5547.7780888764, 5574.888502229852, 5440.6735595864375, 5752.453516915886, 5776.913346299725, 5812.447817457335, 5831.7375718093635, 3101.3022070034062, 3292.3579901918897, 3516.5955915070094, 3715.7956312403076, 3729.272791805572, 5473.0, 5484.725763711719, 5502.284702988746, 5502.752376143003, 5510.283663123768, 5147.536721695065, 5147.9227811582105, 5305.389880163676, 5334.653247538898, 5399.244105825266, 4686.484486706528, 5039.0, 5406.94507603203, 5418.431064738304, 5440.945590544202, 4926.655134140719, 5304.787808487772, 5310.707911064928, 5337.998250656004, 5366.436524164907, 4061.436347006365, 4691.413573303337, 4873.928580353265, 5108.56577190943, 5460.6996615186545, 4974.502549745142, 5078.263651770399, 5095.261187127771, 5314.24629872149, 5317.707526086102], "value": 3829.776830831129, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [678.2098854834121, 679.6431873266534, 699.2867275379114, 738.5716284554959, 773.6595897804965, 13874.861251387483, 14666.779998300033, 14706.55880323592, 14740.6314842129, 14757.335919883617, 11912.344821034862, 13274.535391261308, 13474.124181928168, 13499.865001349983, 14741.262936853169, 798.2695833312526, 818.3453237410077, 819.7909533069089, 819.8237378963522, 820.216693058131, 816.1348970091722, 820.2986446588171, 823.798169448486, 825.3149885594942, 828.9088200297963, 847.2798121596625, 849.817289282804, 862.0560486267527, 863.201538576817, 864.0711235421916, 856.6701819799359, 857.5712143928037, 857.9785505362354, 858.5363903492138, 858.8539948208758, 635.659921941759, 636.5289685632645, 636.6307541625846, 636.656205648949, 638.7828138432955, 13999.580012599637, 14004.71990560183, 14007.64980875476, 14021.579352619437, 14036.0, 13349.399277032557, 13769.31153442324, 13866.376013079334, 13898.51355202563, 13983.23092229927, 10158.492075396201, 11248.54909657905, 11417.657470275823, 11475.827862582068, 11488.0, 3664.780113193217, 3678.576963649161, 3686.189038411545, 3701.222743223926, 3839.884803455901, 60010.0, 60936.69531652313, 72627.0, 80589.38821223543, 89417.31748047569, 10739.463026848782, 10843.409316154608, 10973.50619222137, 11034.17243706709, 11345.03567196781, 21128.260510882046, 21136.0, 21153.471163221042, 21163.259285925225, 21209.257675981575, 7696.692132314756, 7741.767746967487, 7816.179301173409, 7820.452568320276, 8028.397870159762, 4224.491316985938, 4257.446531950826, 4315.136972605492, 4409.140217657526, 4478.731276123443, 3225.1614580209316, 3336.399448099317, 3342.5487559179687, 3348.28011977426, 3349.69852713257, 576.0, 596.5317225977586, 598.9670568118795, 615.8768246350747, 617.6849806598667, 522.8980348831941, 566.8072855229159, 670.3832474123818, 672.7107343842194, 675.645286224736, 7523.510971786816, 8124.878126828103, 8321.417500774887, 8834.514101724339, 8927.10728927115, 637.3053371824733, 648.1573953859963, 655.1090516897016, 667.3526679121245, 669.6250099944046, 3955.545112312121, 4345.152695224464, 4348.499922508889, 4386.583274588909, 4411.823129792237, 74862.62568687122, 75220.0, 92880.53559732158, 106844.0, 115852.0, 83182.0, 83668.58165709133, 84027.0, 87446.0, 101358.98641013644, 77523.0, 78470.0, 78641.0, 78865.0, 79341.60329198433, 9027.199313657706, 9373.765655858659, 9374.437533747998, 9380.81238375215, 9510.572024259063, 49729.50270497249, 51851.2222316658, 53191.46808531865, 53237.4676253248, 54544.45455545552, 68276.6586167066, 74443.0, 75065.62467187628, 76046.61976690302, 77347.83978240444, 11484.484873874397, 11578.536858525564, 11732.538901024047, 11759.882401175879, 12165.452554634885, 10904.291221070605, 13175.934120329337, 13346.799798002843, 13572.93213533926, 13876.653083672989, 10693.0, 12152.0, 12557.811632825698, 12593.244405335709, 13006.089573729749, 11934.52261909514, 12195.329256890956, 12343.382830858242, 12845.229286242855, 13018.934905325414, 12065.879341206475, 12310.384480775747, 12484.188527745668, 12593.055520836157, 12680.492780288685, 9584.329096963145, 9638.807223855343, 10106.292559521056, 10265.384076955406, 10434.791304174027, 10078.79842403133, 10669.199810014125, 10711.303765255234, 10723.517441714985, 10737.838932415863], "value": 7090.299361671214, "unit": "score"}], "name": "dromaeo_css", "value": 6948.104099996586, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 113.0, 118.0, 150.0, 114.0, 126.0, 123.0, 113.0, 143.0, 111.0], "value": 126.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 180.0, 184.0, 187.0, 185.0, 182.0, 220.0, 182.0, 179.0, 181.0], "value": 186.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 76.0, 107.0, 80.0, 68.0, 59.0, 59.0, 83.0, 58.0], "value": 74.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 70.0, 92.0, 71.0, 69.0, 70.0, 90.0, 67.0, 70.0, 92.0], "value": 78.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 86.0, 84.0, 86.0, 83.0, 87.0, 86.0, 124.0, 115.0], "value": 92.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 100.0, 100.0, 96.0, 104.0, 138.0, 148.0, 154.0, 95.0, 95.0], "value": 112.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 88.0, 87.0, 87.0, 101.0, 129.0, 129.0, 87.0, 85.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 53.0, 55.0, 55.0, 54.0, 56.0, 55.0, 54.0, 54.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 70.0, 81.0, 76.0, 72.0, 69.0, 69.0, 70.0, 70.0, 72.0], "value": 71.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 89.0, 88.0, 87.0, 88.0, 87.0, 88.0, 88.0, 89.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 150.0, 148.0, 151.0, 146.0, 150.0, 152.0, 148.0, 245.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 174.0, 175.0, 180.0, 170.0, 173.0, 172.0, 172.0, 174.0, 172.0], "value": 174.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0, 67.0, 67.0, 68.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1495.8000000000002, "alertThreshold": 2.0}]} 10:20:10 INFO - Return code: 0 10:20:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:20:10 INFO - # TBPL SUCCESS # 10:20:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:20:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:20:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:20:10 INFO - 2016-11-18 10:20:10.144 screenresolution[1667:9780] starting screenresolution argv=screenresolution get 10:20:10 INFO - 2016-11-18 10:20:10.147 screenresolution[1667:9780] Display 0: 1600x1200x32@60 10:20:10 INFO - 2016-11-18 10:20:10.153 screenresolution[1668:9783] starting screenresolution argv=screenresolution list 10:20:10 INFO - Available Modes on Display 0 10:20:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:20:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:20:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:20:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:20:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:20:10 INFO - Intel Iris: 10:20:10 INFO - Chipset Model: Intel Iris 10:20:10 INFO - Type: GPU 10:20:10 INFO - Bus: Built-In 10:20:10 INFO - VRAM (Dynamic, Max): 1536 MB 10:20:10 INFO - Vendor: Intel (0x8086) 10:20:10 INFO - Device ID: 0x0a2e 10:20:10 INFO - Revision ID: 0x0009 10:20:10 INFO - Displays: 10:20:10 INFO - Display: 10:20:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:20:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:20:10 INFO - Display Serial Number: 1600x1200 60 10:20:10 INFO - Main Display: Yes 10:20:10 INFO - Mirror: Off 10:20:10 INFO - Online: Yes 10:20:10 INFO - Rotation: Supported 10:20:10 INFO - Return code: 0 10:20:10 INFO - Running post-action listener: _resource_record_post_action 10:20:10 INFO - [mozharness: 2016-11-18 18:20:10.409985Z] Finished run-tests step (success) 10:20:10 INFO - Running post-run listener: _resource_record_post_run 10:20:10 INFO - Total resource usage - Wall time: 1216s; CPU: 54.0%; Read bytes: 37401600; Write bytes: 693756416; Read time: 236; Write time: 1950 10:20:10 INFO - TinderboxPrint: CPU usage
54.0% 10:20:10 INFO - TinderboxPrint: I/O read bytes / time
37,401,600 / 236 10:20:10 INFO - TinderboxPrint: I/O write bytes / time
693,756,416 / 1,950 10:20:10 INFO - TinderboxPrint: CPU idle
2,239.7 (46.0%) 10:20:10 INFO - TinderboxPrint: CPU system
976.1 (20.1%) 10:20:10 INFO - TinderboxPrint: CPU user
1,650.0 (33.9%) 10:20:10 INFO - TinderboxPrint: Swap in / out
420,331,520 / 0 10:20:10 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 367026688; Write bytes: 366573056; Read time: 27542; Write time: 756 10:20:10 INFO - run-tests - Wall time: 1184s; CPU: 54.0%; Read bytes: 36447232; Write bytes: 306426880; Read time: 224; Write time: 1138 10:20:10 INFO - Running post-run listener: _upload_blobber_files 10:20:10 INFO - Blob upload gear active. 10:20:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:20:10 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:20:10 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:20:10 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:20:11 INFO - (blobuploader) - INFO - Open directory for files ... 10:20:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:20:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:20:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:20:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:20:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:20:12 INFO - (blobuploader) - INFO - Done attempting. 10:20:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:20:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:20:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:20:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:20:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:20:13 INFO - (blobuploader) - INFO - Done attempting. 10:20:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:20:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:20:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:20:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:20:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:20:15 INFO - (blobuploader) - INFO - Done attempting. 10:20:15 INFO - (blobuploader) - INFO - Iteration through files over. 10:20:15 INFO - Return code: 0 10:20:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:20:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:20:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d436ce2de4f15d08a0f4e48779cd2e2a7c72878a968817a1c905231eaff5a4fb791644bbce849d60e4a3f721a223af1f36d6f91bddef165517ca07e4e25736ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e14c4bd7696cc636ba4d80d33b0c5502f05b7dde67f484e80f1cfe46c217147a0e437e9832fee452745161f48ae2edd6c8a372602df30cf750e82cfadc83bd47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e3af8ae98a8e191d977d70410b16c6790f5416c90da950c3fa693e2b8886a94d37591821b733bcee032460badefd5aa25f4e4f8c25c461173d34d5923fd09aa"} 10:20:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:20:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:20:15 INFO - Contents: 10:20:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d436ce2de4f15d08a0f4e48779cd2e2a7c72878a968817a1c905231eaff5a4fb791644bbce849d60e4a3f721a223af1f36d6f91bddef165517ca07e4e25736ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e14c4bd7696cc636ba4d80d33b0c5502f05b7dde67f484e80f1cfe46c217147a0e437e9832fee452745161f48ae2edd6c8a372602df30cf750e82cfadc83bd47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e3af8ae98a8e191d977d70410b16c6790f5416c90da950c3fa693e2b8886a94d37591821b733bcee032460badefd5aa25f4e4f8c25c461173d34d5923fd09aa"} 10:20:15 INFO - Running post-run listener: copy_logs_to_upload_dir 10:20:15 INFO - Copying logs to upload dir... 10:20:15 INFO - mkdir: /builds/slave/test/build/upload/logs 10:20:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.057312 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-11-18 10:20:15.705282) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 10:20:15.709638) ========= 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.RVs8bfd85M/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.txDobCJWS6/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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/Firefox/sha512/d436ce2de4f15d08a0f4e48779cd2e2a7c72878a968817a1c905231eaff5a4fb791644bbce849d60e4a3f721a223af1f36d6f91bddef165517ca07e4e25736ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e14c4bd7696cc636ba4d80d33b0c5502f05b7dde67f484e80f1cfe46c217147a0e437e9832fee452745161f48ae2edd6c8a372602df30cf750e82cfadc83bd47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e3af8ae98a8e191d977d70410b16c6790f5416c90da950c3fa693e2b8886a94d37591821b733bcee032460badefd5aa25f4e4f8c25c461173d34d5923fd09aa"} build_url:https://queue.taskcluster.net/v1/task/a1SPFV2yQfqn2-GgHpb2rA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010872 build_url: 'https://queue.taskcluster.net/v1/task/a1SPFV2yQfqn2-GgHpb2rA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d436ce2de4f15d08a0f4e48779cd2e2a7c72878a968817a1c905231eaff5a4fb791644bbce849d60e4a3f721a223af1f36d6f91bddef165517ca07e4e25736ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e14c4bd7696cc636ba4d80d33b0c5502f05b7dde67f484e80f1cfe46c217147a0e437e9832fee452745161f48ae2edd6c8a372602df30cf750e82cfadc83bd47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e3af8ae98a8e191d977d70410b16c6790f5416c90da950c3fa693e2b8886a94d37591821b733bcee032460badefd5aa25f4e4f8c25c461173d34d5923fd09aa"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 10:20:15.747396) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 10:20:15.747960) ========= 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.RVs8bfd85M/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.txDobCJWS6/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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.004985 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 10:20:15.797917) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 10:20:15.798346) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 10:20:15.798803) ========= ========= Total master_lag: 0.42 =========