builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0010 starttime: 1475818035.48 results: success (0) buildid: 20161006202401 builduid: ee2a3d12a1b746e0b7d546968ad16c8a revision: 0e67f06bcfcc83f4317a968914232bb6c82965ac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 22:27:15.476669) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 22:27:15.477185) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 22:27:15.477546) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 22:27:15.503271) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 22:27:15.503761) ========= 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.tvzFx0ZVL3/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.XYd09ed117/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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-10-06 22:27:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 168M=0s 2016-10-06 22:27:15 (168 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132264 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 22:27:15.753951) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 22:27:15.754447) ========= 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.tvzFx0ZVL3/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.XYd09ed117/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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.030279 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 22:27:15.806549) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 22:27:15.806965) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0e67f06bcfcc83f4317a968914232bb6c82965ac --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 0e67f06bcfcc83f4317a968914232bb6c82965ac --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tvzFx0ZVL3/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.XYd09ed117/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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-10-06 22:27:15,882 truncating revision to first 12 chars 2016-10-06 22:27:15,882 Setting DEBUG logging. 2016-10-06 22:27:15,882 attempt 1/10 2016-10-06 22:27:15,882 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0e67f06bcfcc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 22:27:16,939 unpacking tar archive at: fx-team-0e67f06bcfcc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.327089 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 22:27:17.155968) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 22:27:17.156356) ========= script_repo_revision: 0e67f06bcfcc83f4317a968914232bb6c82965ac ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 22:27:17.156812) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 22:27:17.157117) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 22:27:17.175319) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-06 22:27:17.175822) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tvzFx0ZVL3/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.XYd09ed117/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 22:27:17 INFO - MultiFileLogger online at 20161006 22:27:17 in /builds/slave/test 22:27:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 22:27:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:27:17 INFO - {'append_to_log': False, 22:27:17 INFO - 'base_work_dir': '/builds/slave/test', 22:27:17 INFO - 'blob_upload_branch': 'Fx-Team', 22:27:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:27:17 INFO - 'branch': 'Fx-Team', 22:27:17 INFO - 'buildbot_json_path': 'buildprops.json', 22:27:17 INFO - 'config_files': ('talos/mac_config.py',), 22:27:17 INFO - 'default_actions': ('clobber', 22:27:17 INFO - 'read-buildbot-config', 22:27:17 INFO - 'download-and-extract', 22:27:17 INFO - 'populate-webroot', 22:27:17 INFO - 'create-virtualenv', 22:27:17 INFO - 'install', 22:27:17 INFO - 'run-tests'), 22:27:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:27:17 INFO - 'download_minidump_stackwalk': True, 22:27:17 INFO - 'download_symbols': 'ondemand', 22:27:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:27:17 INFO - 'tooltool.py': '/tools/tooltool.py', 22:27:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:27:17 INFO - '/tools/misc-python/virtualenv.py')}, 22:27:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:27:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:27:17 INFO - 'installer_path': 'installer.exe', 22:27:17 INFO - 'log_level': 'info', 22:27:17 INFO - 'log_name': 'talos', 22:27:17 INFO - 'log_to_console': True, 22:27:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:27:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:27:17 INFO - 'opt_config_files': (), 22:27:17 INFO - 'pip_index': False, 22:27:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:27:17 INFO - 'cmd': ('bash', 22:27:17 INFO - '-c', 22:27:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:27:17 INFO - 'enabled': True, 22:27:17 INFO - 'halt_on_failure': False, 22:27:17 INFO - 'name': 'check_screen_resolution'},), 22:27:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:27:17 INFO - 'cmd': ('bash', 22:27:17 INFO - '-c', 22:27:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:27:17 INFO - 'enabled': True, 22:27:17 INFO - 'halt_on_failure': False, 22:27:17 INFO - 'name': 'check_screen_resolution'},), 22:27:17 INFO - 'run_cmd_checks_enabled': True, 22:27:17 INFO - 'sps_profile': False, 22:27:17 INFO - 'sps_profile_interval': 0, 22:27:17 INFO - 'suite': 'dromaeojs', 22:27:17 INFO - 'system_bits': '32', 22:27:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:27:17 INFO - 'title': 't-yosemite-r7-0010', 22:27:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:27:17 INFO - 'use_talos_json': True, 22:27:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:27:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:27:17 INFO - 'work_dir': 'build'} 22:27:17 INFO - [mozharness: 2016-10-07 05:27:17.392330Z] Running clobber step. 22:27:17 INFO - Running pre-action listener: _resource_record_pre_action 22:27:17 INFO - Running main action method: clobber 22:27:17 INFO - rmtree: /builds/slave/test/build 22:27:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:27:19 INFO - Running post-action listener: _resource_record_post_action 22:27:19 INFO - [mozharness: 2016-10-07 05:27:19.736827Z] Finished clobber step (success) 22:27:19 INFO - [mozharness: 2016-10-07 05:27:19.736950Z] Running read-buildbot-config step. 22:27:19 INFO - Running pre-action listener: _resource_record_pre_action 22:27:19 INFO - Running main action method: read_buildbot_config 22:27:19 INFO - Using buildbot properties: 22:27:19 INFO - { 22:27:19 INFO - "project": "", 22:27:19 INFO - "product": "firefox", 22:27:19 INFO - "script_repo_revision": "production", 22:27:19 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 22:27:19 INFO - "repository": "", 22:27:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 22:27:19 INFO - "buildid": "20161006202401", 22:27:19 INFO - "pgo_build": "False", 22:27:19 INFO - "basedir": "/builds/slave/test", 22:27:19 INFO - "buildnumber": 858, 22:27:19 INFO - "slavename": "t-yosemite-r7-0010", 22:27:19 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 22:27:19 INFO - "platform": "yosemite_r7", 22:27:19 INFO - "scheduler": "tests-fx-team-macosx64-talos", 22:27:19 INFO - "branch": "fx-team", 22:27:19 INFO - "repo_path": "integration/fx-team", 22:27:19 INFO - "revision": "0e67f06bcfcc83f4317a968914232bb6c82965ac", 22:27:19 INFO - "stage_platform": "macosx64", 22:27:19 INFO - "builduid": "ee2a3d12a1b746e0b7d546968ad16c8a", 22:27:19 INFO - "slavebuilddir": "test" 22:27:19 INFO - } 22:27:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 22:27:19 INFO - Running post-action listener: _resource_record_post_action 22:27:19 INFO - [mozharness: 2016-10-07 05:27:19.740264Z] Finished read-buildbot-config step (success) 22:27:19 INFO - [mozharness: 2016-10-07 05:27:19.740396Z] Running download-and-extract step. 22:27:19 INFO - Running pre-action listener: _resource_record_pre_action 22:27:19 INFO - Running main action method: download_and_extract 22:27:19 INFO - mkdir: /builds/slave/test/build/tests 22:27:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:19 INFO - trying https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 22:27:19 INFO - Downloading https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 22:27:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 22:27:20 INFO - Downloaded 1199 bytes. 22:27:20 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 22:27:20 INFO - Using the following test package requirements: 22:27:20 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 22:27:20 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:27:20 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 22:27:20 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:27:20 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 22:27:20 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:27:20 INFO - u'jsshell-mac.zip'], 22:27:20 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:27:20 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 22:27:20 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 22:27:20 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:27:20 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 22:27:20 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:27:20 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 22:27:20 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:27:20 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 22:27:20 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:27:20 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 22:27:20 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 22:27:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 22:27:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 22:27:20 INFO - Fetch https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 22:27:21 INFO - Http code: 200 22:27:21 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 22:27:21 INFO - x-amz-cf-id: XmCPTlLLDL-XkarCM8t3iIVDtQlUOBpTO1uc6_OfxdFapIraTda-sA== 22:27:21 INFO - x-amz-version-id: h6ciNXuWd4FeHlhEGrS8vGKOAGrd9qde 22:27:21 INFO - Expected file size: 16482348 22:27:21 INFO - Obtained file size: 16482348 22:27:28 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 22:27:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 22:27:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 22:27:28 INFO - Fetch https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 22:27:28 INFO - Http code: 200 22:27:28 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 22:27:28 INFO - x-amz-cf-id: YIBIOVQute2fYbylviQ0P4K56dXycv0gMu7wi2dNS1zpVB0l1rVnow== 22:27:28 INFO - x-amz-version-id: h6ciNXuWd4FeHlhEGrS8vGKOAGrd9qde 22:27:29 INFO - Expected file size: 16482348 22:27:29 INFO - Obtained file size: 16482348 22:27:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 22:27:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 22:27:35 INFO - Fetch https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 22:27:36 INFO - Http code: 200 22:27:36 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 22:27:36 INFO - x-amz-cf-id: U5GUCkl-soKycpkHIaII2mTUfJ93EcSZ_RKQYaSwTp5mzbnpJn3THA== 22:27:36 INFO - x-amz-version-id: rylbzKG1NZO5NZK_cF.7qkrrSSXVGrgE 22:27:36 INFO - Expected file size: 14409006 22:27:36 INFO - Obtained file size: 14409006 22:27: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')]} 22:27:36 INFO - trying https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 22:27:36 INFO - Downloading https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 22:27:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 22:27:39 INFO - Downloaded 111722484 bytes. 22:27:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 22:27:39 INFO - mkdir: /builds/slave/test/properties 22:27:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:27:39 INFO - Writing to file /builds/slave/test/properties/build_url 22:27:39 INFO - Contents: 22:27:39 INFO - build_url:https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 22:27:40 INFO - Running post-action listener: _resource_record_post_action 22:27:40 INFO - Running post-action listener: set_extra_try_arguments 22:27:40 INFO - [mozharness: 2016-10-07 05:27:40.391386Z] Finished download-and-extract step (success) 22:27:40 INFO - [mozharness: 2016-10-07 05:27:40.391480Z] Running populate-webroot step. 22:27:40 INFO - Running pre-action listener: _resource_record_pre_action 22:27:40 INFO - Running main action method: populate_webroot 22:27:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:27:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:27:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:27:40 INFO - '--tppagecycles', 22:27:40 INFO - '7'], 22:27:40 INFO - 'tests': ['tsvgm']}}, 22:27:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:27:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:27:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:27:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:27:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:27:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:27:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:40 INFO - 'talos_options': ['--disable-e10s'], 22:27:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:27:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:27:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:40 INFO - 'talos_options': ['--disable-e10s'], 22:27:40 INFO - 'tests': ['damp', 'tps']}, 22:27:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:40 INFO - 'tests': ['damp', 'tps']}, 22:27:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:27:40 INFO - 'tests': ['dromaeo_dom']}, 22:27:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:27:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:27:40 INFO - 'tests': ['basic_compositor_video']}, 22:27:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:27:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:27:40 INFO - 'tests': ['a11yr', 22:27:40 INFO - 'ts_paint', 22:27:40 INFO - 'tpaint', 22:27:40 INFO - 'sessionrestore', 22:27:40 INFO - 'sessionrestore_no_auto_restore', 22:27:40 INFO - 'tabpaint']}, 22:27:40 INFO - 'other-e10s': {'tests': ['a11yr', 22:27:40 INFO - 'ts_paint', 22:27:40 INFO - 'tpaint', 22:27:40 INFO - 'sessionrestore', 22:27:40 INFO - 'sessionrestore_no_auto_restore', 22:27:40 INFO - 'tabpaint']}, 22:27:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:27:40 INFO - 'ts_paint', 22:27:40 INFO - 'tpaint', 22:27:40 INFO - 'sessionrestore', 22:27:40 INFO - 'sessionrestore_no_auto_restore', 22:27:40 INFO - 'tabpaint']}, 22:27:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:27:40 INFO - 'ts_paint', 22:27:40 INFO - 'tpaint', 22:27:40 INFO - 'sessionrestore', 22:27:40 INFO - 'sessionrestore_no_auto_restore', 22:27:40 INFO - 'tabpaint']}, 22:27:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:27:40 INFO - 'tests': ['a11yr', 22:27:40 INFO - 'ts_paint', 22:27:40 INFO - 'tpaint', 22:27:40 INFO - 'sessionrestore', 22:27:40 INFO - 'sessionrestore_no_auto_restore', 22:27:40 INFO - 'tabpaint']}, 22:27:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:27:40 INFO - 'tests': ['a11yr', 22:27:40 INFO - 'ts_paint', 22:27:40 INFO - 'tpaint', 22:27:40 INFO - 'sessionrestore', 22:27:40 INFO - 'sessionrestore_no_auto_restore', 22:27:40 INFO - 'tabpaint']}, 22:27:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:27:40 INFO - 'tests': ['tsvgx', 22:27:40 INFO - 'tsvgr_opacity', 22:27:40 INFO - 'tart', 22:27:40 INFO - 'tscrollx', 22:27:40 INFO - 'cart']}, 22:27:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:27:40 INFO - 'tsvgr_opacity', 22:27:40 INFO - 'tart', 22:27:40 INFO - 'tscrollx', 22:27:40 INFO - 'cart']}, 22:27:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:40 INFO - 'talos_options': ['--disable-e10s'], 22:27:40 INFO - 'tests': ['tp5o']}, 22:27:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:40 INFO - 'tests': ['tp5o']}, 22:27:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:40 INFO - 'talos_options': ['--disable-e10s', 22:27:40 INFO - '--xperf_path', 22:27:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:27:40 INFO - 'tests': ['tp5n']}, 22:27:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:40 INFO - 'talos_options': ['--xperf_path', 22:27:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:27:40 INFO - 'tests': ['tp5n']}}, 22:27:40 INFO - 'talos.zip': {'path': '', 22:27:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:27:40 INFO - Running post-action listener: _resource_record_post_action 22:27:40 INFO - [mozharness: 2016-10-07 05:27:40.410388Z] Finished populate-webroot step (success) 22:27:40 INFO - [mozharness: 2016-10-07 05:27:40.410516Z] Running create-virtualenv step. 22:27:40 INFO - Running pre-action listener: _resource_record_pre_action 22:27:40 INFO - Running main action method: create_virtualenv 22:27:40 INFO - Creating virtualenv /builds/slave/test/build/venv 22:27:40 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 22:27:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:27:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:27:40 INFO - Using real prefix '/tools/python27' 22:27:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:27:41 INFO - Installing distribute.............................................................................................................................................................................................done. 22:27:44 INFO - Installing pip.................done. 22:27:44 INFO - Return code: 0 22:27:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:27:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:27:44 INFO - Reading from file tmpfile_stdout 22:27:44 INFO - Output received: 22:27:44 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) 22:27:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:27:44 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')]} 22:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:44 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')]} 22:27:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:44 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 0x108dfc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d72570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8598da31a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c10d30>, '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 0x108a36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c08b20>, '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.tvzFx0ZVL3/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.XYd09ed117/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 22:27:44 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 22:27:44 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 22:27:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tvzFx0ZVL3/Render', 22:27:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:27:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:27:44 INFO - 'HOME': '/Users/cltbld', 22:27:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:27:44 INFO - 'LOGNAME': 'cltbld', 22:27:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:44 INFO - 'MOZ_NO_REMOTE': '1', 22:27:44 INFO - 'NO_EM_RESTART': '1', 22:27:44 INFO - 'PAGER': '/bin/cat', 22:27:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:27:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:44 INFO - 'PWD': '/builds/slave/test', 22:27:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:27:44 INFO - 'SHELL': '/bin/bash', 22:27:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XYd09ed117/Listeners', 22:27:44 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 22:27:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:27:44 INFO - 'USER': 'cltbld', 22:27:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:27:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:27:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:44 INFO - 'XPC_FLAGS': '0x0', 22:27:44 INFO - 'XPC_SERVICE_NAME': '0', 22:27:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:27:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:44 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 22:27:44 INFO - Cleaning up... 22:27:44 INFO - Return code: 0 22:27:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:27:44 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')]} 22:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:44 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')]} 22:27:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:44 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 0x108dfc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d72570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8598da31a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c10d30>, '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 0x108a36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c08b20>, '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.tvzFx0ZVL3/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.XYd09ed117/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 22:27:44 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 22:27:44 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 22:27:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tvzFx0ZVL3/Render', 22:27:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:27:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:27:44 INFO - 'HOME': '/Users/cltbld', 22:27:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:27:44 INFO - 'LOGNAME': 'cltbld', 22:27:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:44 INFO - 'MOZ_NO_REMOTE': '1', 22:27:44 INFO - 'NO_EM_RESTART': '1', 22:27:44 INFO - 'PAGER': '/bin/cat', 22:27:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:27:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:44 INFO - 'PWD': '/builds/slave/test', 22:27:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:27:44 INFO - 'SHELL': '/bin/bash', 22:27:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XYd09ed117/Listeners', 22:27:44 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 22:27:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:27:44 INFO - 'USER': 'cltbld', 22:27:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:27:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:27:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:44 INFO - 'XPC_FLAGS': '0x0', 22:27:44 INFO - 'XPC_SERVICE_NAME': '0', 22:27:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:27:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:44 INFO - Downloading/unpacking psutil>=3.1.1 22:27:44 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 22:27:44 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 22:27:44 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 22:27:44 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 22:27:44 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 22:27:44 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 22:27:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:27:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:27:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:27:48 INFO - Installing collected packages: psutil 22:27:48 INFO - Running setup.py install for psutil 22:27:48 INFO - building 'psutil._psutil_osx' extension 22:27:48 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 22:27:48 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 22:27:49 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 22:27:49 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 22:27:49 INFO - building 'psutil._psutil_posix' extension 22:27:49 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 22:27:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:27:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:27:49 INFO - ^ 22:27:49 INFO - 1 warning generated. 22:27:49 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 22:27:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:27:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:27:49 INFO - Successfully installed psutil 22:27:49 INFO - Cleaning up... 22:27:49 INFO - Return code: 0 22:27:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108dfc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d72570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8598da31a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c10d30>, '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 0x108a36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c08b20>, '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.tvzFx0ZVL3/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.XYd09ed117/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 22:27:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:27:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:27:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tvzFx0ZVL3/Render', 22:27:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:27:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:27:49 INFO - 'HOME': '/Users/cltbld', 22:27:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:27:49 INFO - 'LOGNAME': 'cltbld', 22:27:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:49 INFO - 'MOZ_NO_REMOTE': '1', 22:27:49 INFO - 'NO_EM_RESTART': '1', 22:27:49 INFO - 'PAGER': '/bin/cat', 22:27:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:27:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:49 INFO - 'PWD': '/builds/slave/test', 22:27:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:27:49 INFO - 'SHELL': '/bin/bash', 22:27:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XYd09ed117/Listeners', 22:27:49 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 22:27:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:27:49 INFO - 'USER': 'cltbld', 22:27:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:27:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:27:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:49 INFO - 'XPC_FLAGS': '0x0', 22:27:49 INFO - 'XPC_SERVICE_NAME': '0', 22:27:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:27:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:27:49 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 22:27:49 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 22:27:49 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 22:27:49 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 22:27:49 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 22:27:49 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 22:27:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:27:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:27:52 INFO - Installing collected packages: mozsystemmonitor 22:27:52 INFO - Running setup.py install for mozsystemmonitor 22:27:52 INFO - Successfully installed mozsystemmonitor 22:27:52 INFO - Cleaning up... 22:27:52 INFO - Return code: 0 22:27:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:27: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')]} 22:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27: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')]} 22:27:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:52 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 0x108dfc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d72570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8598da31a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c10d30>, '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 0x108a36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c08b20>, '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.tvzFx0ZVL3/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.XYd09ed117/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 22:27:52 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 22:27:52 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 22:27:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tvzFx0ZVL3/Render', 22:27:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:27:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:27:52 INFO - 'HOME': '/Users/cltbld', 22:27:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:27:52 INFO - 'LOGNAME': 'cltbld', 22:27:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:52 INFO - 'MOZ_NO_REMOTE': '1', 22:27:52 INFO - 'NO_EM_RESTART': '1', 22:27:52 INFO - 'PAGER': '/bin/cat', 22:27:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:27:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:52 INFO - 'PWD': '/builds/slave/test', 22:27:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:27:52 INFO - 'SHELL': '/bin/bash', 22:27:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XYd09ed117/Listeners', 22:27:52 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 22:27:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:27:52 INFO - 'USER': 'cltbld', 22:27:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:27:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:27:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:52 INFO - 'XPC_FLAGS': '0x0', 22:27:52 INFO - 'XPC_SERVICE_NAME': '0', 22:27:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:27:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:52 INFO - Downloading/unpacking jsonschema==2.5.1 22:27:52 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 22:27:52 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 22:27:52 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 22:27:52 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 22:27:52 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 22:27:52 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 22:27:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:27:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:27:55 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 22:27:55 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 22:27:55 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 22:27:55 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 22:27:55 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 22:27:55 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 22:27:55 INFO - Downloading functools32-3.2.3-2.tar.gz 22:27:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:27:55 INFO - warning: no files found matching '*.txt' 22:27:55 INFO - no previously-included directories found matching 'build' 22:27:55 INFO - no previously-included directories found matching 'dist' 22:27:55 INFO - no previously-included directories found matching '.git*' 22:27:55 INFO - Installing collected packages: jsonschema, functools32 22:27:55 INFO - Running setup.py install for functools32 22:27:56 INFO - warning: no files found matching '*.txt' 22:27:56 INFO - no previously-included directories found matching 'build' 22:27:56 INFO - no previously-included directories found matching 'dist' 22:27:56 INFO - no previously-included directories found matching '.git*' 22:27:56 INFO - Successfully installed jsonschema functools32 22:27:56 INFO - Cleaning up... 22:27:56 INFO - Return code: 0 22:27:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108dfc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d72570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8598da31a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c10d30>, '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 0x108a36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c08b20>, '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.tvzFx0ZVL3/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.XYd09ed117/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 22:27:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 22:27:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tvzFx0ZVL3/Render', 22:27:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:27:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:27:56 INFO - 'HOME': '/Users/cltbld', 22:27:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:27:56 INFO - 'LOGNAME': 'cltbld', 22:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:56 INFO - 'MOZ_NO_REMOTE': '1', 22:27:56 INFO - 'NO_EM_RESTART': '1', 22:27:56 INFO - 'PAGER': '/bin/cat', 22:27:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:56 INFO - 'PWD': '/builds/slave/test', 22:27:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:27:56 INFO - 'SHELL': '/bin/bash', 22:27:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XYd09ed117/Listeners', 22:27:56 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 22:27:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:27:56 INFO - 'USER': 'cltbld', 22:27:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:27:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:56 INFO - 'XPC_FLAGS': '0x0', 22:27:56 INFO - 'XPC_SERVICE_NAME': '0', 22:27:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:27:56 INFO - Cleaning up... 22:27:56 INFO - Return code: 0 22:27:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108dfc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d72570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8598da31a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c10d30>, '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 0x108a36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c08b20>, '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.tvzFx0ZVL3/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.XYd09ed117/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 22:27:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:27:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tvzFx0ZVL3/Render', 22:27:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:27:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:27:56 INFO - 'HOME': '/Users/cltbld', 22:27:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:27:56 INFO - 'LOGNAME': 'cltbld', 22:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:56 INFO - 'MOZ_NO_REMOTE': '1', 22:27:56 INFO - 'NO_EM_RESTART': '1', 22:27:56 INFO - 'PAGER': '/bin/cat', 22:27:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:56 INFO - 'PWD': '/builds/slave/test', 22:27:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:27:56 INFO - 'SHELL': '/bin/bash', 22:27:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XYd09ed117/Listeners', 22:27:56 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 22:27:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:27:56 INFO - 'USER': 'cltbld', 22:27:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:27:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:56 INFO - 'XPC_FLAGS': '0x0', 22:27:56 INFO - 'XPC_SERVICE_NAME': '0', 22:27:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:56 INFO - Downloading/unpacking blobuploader==1.2.4 22:27:56 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 22:27:56 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 22:27:56 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 22:27:56 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 22:27:56 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 22:27:56 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 22:27:59 INFO - Downloading blobuploader-1.2.4.tar.gz 22:27:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:27:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:27:59 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 22:27:59 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 22:27:59 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 22:27:59 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 22:27:59 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 22:27:59 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 22:27:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:27:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:27:59 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 22:27:59 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 22:27:59 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 22:27:59 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 22:27:59 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 22:27:59 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 22:28:00 INFO - Downloading docopt-0.6.1.tar.gz 22:28:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:28:00 INFO - Installing collected packages: blobuploader, requests, docopt 22:28:00 INFO - Running setup.py install for blobuploader 22:28:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:28:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:28:00 INFO - Running setup.py install for requests 22:28:01 INFO - Running setup.py install for docopt 22:28:01 INFO - Successfully installed blobuploader requests docopt 22:28:01 INFO - Cleaning up... 22:28:01 INFO - Return code: 0 22:28:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:28:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:28:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:01 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 0x108dfc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d72570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8598da31a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c10d30>, '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 0x108a36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c08b20>, '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.tvzFx0ZVL3/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.XYd09ed117/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 22:28:01 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 22:28:01 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 22:28:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tvzFx0ZVL3/Render', 22:28:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:28:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:28:01 INFO - 'HOME': '/Users/cltbld', 22:28:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:28:01 INFO - 'LOGNAME': 'cltbld', 22:28:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:01 INFO - 'MOZ_NO_REMOTE': '1', 22:28:01 INFO - 'NO_EM_RESTART': '1', 22:28:01 INFO - 'PAGER': '/bin/cat', 22:28:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:28:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:01 INFO - 'PWD': '/builds/slave/test', 22:28:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:28:01 INFO - 'SHELL': '/bin/bash', 22:28:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XYd09ed117/Listeners', 22:28:01 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 22:28:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:28:01 INFO - 'USER': 'cltbld', 22:28:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:28:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:28:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:01 INFO - 'XPC_FLAGS': '0x0', 22:28:01 INFO - 'XPC_SERVICE_NAME': '0', 22:28:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:28:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:28:01 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-G8_bvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:28:01 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-L6ixp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:28:01 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-V5XRCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:28:02 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-T2Jmtj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:28:02 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-4_e5Lc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:28:02 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-VSqW7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:28:02 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-PnWT_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:28:02 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-FO0tfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:28:02 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-REBMjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:28:02 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-EuMQMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:28:02 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-9fM9aG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:28:02 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-1tYk9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:28:02 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-1DC3CF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:28:03 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-Pr9iME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:28:03 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-eTrW6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:28:03 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-eGHuLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:28:03 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-8ndQb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:28:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:28:03 INFO - Running setup.py install for manifestparser 22:28:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:28:03 INFO - Running setup.py install for mozcrash 22:28:03 INFO - Running setup.py install for mozdebug 22:28:03 INFO - Running setup.py install for mozdevice 22:28:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:28:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:28:04 INFO - Running setup.py install for mozfile 22:28:04 INFO - Running setup.py install for mozhttpd 22:28:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:28:04 INFO - Running setup.py install for mozinfo 22:28:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:28:04 INFO - Running setup.py install for mozInstall 22:28:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:28:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:28:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:28:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:28:04 INFO - Running setup.py install for mozleak 22:28:04 INFO - Running setup.py install for mozlog 22:28:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:28:04 INFO - Running setup.py install for moznetwork 22:28:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:28:05 INFO - Running setup.py install for mozprocess 22:28:05 INFO - Running setup.py install for mozprofile 22:28:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:28:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:28:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:28:05 INFO - Running setup.py install for mozrunner 22:28:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:28:05 INFO - Running setup.py install for mozscreenshot 22:28:05 INFO - Running setup.py install for moztest 22:28:05 INFO - Running setup.py install for mozversion 22:28:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:28:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:28:06 INFO - Cleaning up... 22:28:06 INFO - Return code: 0 22:28:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:28:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:28:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:06 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 0x108dfc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d72570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8598da31a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c10d30>, '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 0x108a36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c08b20>, '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.tvzFx0ZVL3/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.XYd09ed117/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 22:28:06 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 22:28:06 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 22:28:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tvzFx0ZVL3/Render', 22:28:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:28:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:28:06 INFO - 'HOME': '/Users/cltbld', 22:28:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:28:06 INFO - 'LOGNAME': 'cltbld', 22:28:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:06 INFO - 'MOZ_NO_REMOTE': '1', 22:28:06 INFO - 'NO_EM_RESTART': '1', 22:28:06 INFO - 'PAGER': '/bin/cat', 22:28:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:28:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:06 INFO - 'PWD': '/builds/slave/test', 22:28:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:28:06 INFO - 'SHELL': '/bin/bash', 22:28:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XYd09ed117/Listeners', 22:28:06 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 22:28:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:28:06 INFO - 'USER': 'cltbld', 22:28:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:28:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:28:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:06 INFO - 'XPC_FLAGS': '0x0', 22:28:06 INFO - 'XPC_SERVICE_NAME': '0', 22:28:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:28:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:28:06 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-gktyqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:28:06 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)) 22:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:28:06 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-iECkcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 22:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:28:06 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-kTgGez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:28:06 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)) 22:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:28:06 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-0rze_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:28:06 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)) 22:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:28:06 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-LnZFem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:28:06 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)) 22:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:28:06 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-Ux31f0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:28:06 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)) 22:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:28:06 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-wCoWzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:28:07 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)) 22:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:28:07 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-6AqHek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:28:07 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)) 22:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:28:07 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-9ZC1EG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:28:07 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)) 22:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:28:07 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-khNxjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:28:07 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)) 22:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:28:07 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-Pg87gA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:28:07 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)) 22:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:28:07 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-RV_8Db-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:28:07 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)) 22:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:28:07 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-ArVkj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:28:07 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)) 22:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:28:07 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-8SElJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:28:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 22:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:28:07 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-8SptI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:28:07 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)) 22:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:28:07 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-zx7S0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:28:08 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)) 22:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:28:08 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-Z49Y18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:28:08 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)) 22:28:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:28:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:28:08 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)) 22:28:08 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)) 22:28:08 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)) 22:28:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:10 INFO - Downloading blessings-1.6.tar.gz 22:28:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:28:10 INFO - Installing collected packages: blessings 22:28:10 INFO - Running setup.py install for blessings 22:28:10 INFO - Successfully installed blessings 22:28:10 INFO - Cleaning up... 22:28:11 INFO - Return code: 0 22:28:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:28:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:28:11 INFO - Reading from file tmpfile_stdout 22:28:11 INFO - Current package versions: 22:28:11 INFO - blessings == 1.6 22:28:11 INFO - blobuploader == 1.2.4 22:28:11 INFO - docopt == 0.6.1 22:28:11 INFO - functools32 == 3.2.3-2 22:28:11 INFO - jsonschema == 2.5.1 22:28:11 INFO - manifestparser == 1.1 22:28:11 INFO - mozInstall == 1.12 22:28:11 INFO - mozcrash == 0.17 22:28:11 INFO - mozdebug == 0.1 22:28:11 INFO - mozdevice == 0.48 22:28:11 INFO - mozfile == 1.2 22:28:11 INFO - mozhttpd == 0.7 22:28:11 INFO - mozinfo == 0.9 22:28:11 INFO - mozleak == 0.1 22:28:11 INFO - mozlog == 3.4 22:28:11 INFO - moznetwork == 0.27 22:28:11 INFO - mozprocess == 0.23 22:28:11 INFO - mozprofile == 0.28 22:28:11 INFO - mozrunner == 6.12 22:28:11 INFO - mozscreenshot == 0.1 22:28:11 INFO - mozsystemmonitor == 0.3 22:28:11 INFO - moztest == 0.7 22:28:11 INFO - mozversion == 1.4 22:28:11 INFO - psutil == 3.1.1 22:28:11 INFO - requests == 1.2.3 22:28:11 INFO - wsgiref == 0.1.2 22:28:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:28:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:28:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:12 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 0x108dfc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d72570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8598da31a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c10d30>, '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 0x108a36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c08b20>, '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.tvzFx0ZVL3/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.XYd09ed117/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 22:28:12 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 22:28:12 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 22:28:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tvzFx0ZVL3/Render', 22:28:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:28:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:28:12 INFO - 'HOME': '/Users/cltbld', 22:28:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:28:12 INFO - 'LOGNAME': 'cltbld', 22:28:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:12 INFO - 'MOZ_NO_REMOTE': '1', 22:28:12 INFO - 'NO_EM_RESTART': '1', 22:28:12 INFO - 'PAGER': '/bin/cat', 22:28:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:28:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:12 INFO - 'PWD': '/builds/slave/test', 22:28:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:28:12 INFO - 'SHELL': '/bin/bash', 22:28:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XYd09ed117/Listeners', 22:28:12 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 22:28:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:28:12 INFO - 'USER': 'cltbld', 22:28:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:28:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:28:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:12 INFO - 'XPC_FLAGS': '0x0', 22:28:12 INFO - 'XPC_SERVICE_NAME': '0', 22:28:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:28:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:12 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)) 22:28:12 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)) 22:28:12 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)) 22:28:12 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)) 22:28:12 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)) 22:28:12 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)) 22:28:12 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)) 22:28:12 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)) 22:28:12 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)) 22:28:12 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)) 22:28:12 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)) 22:28:12 INFO - Cleaning up... 22:28:12 INFO - Return code: 0 22:28:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:28:12 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')]} 22:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:12 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')]} 22:28:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:12 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 0x108dfc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d72570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8598da31a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c10d30>, '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 0x108a36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c08b20>, '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.tvzFx0ZVL3/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.XYd09ed117/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 22:28:12 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 22:28:12 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 22:28:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tvzFx0ZVL3/Render', 22:28:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:28:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:28:12 INFO - 'HOME': '/Users/cltbld', 22:28:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:28:12 INFO - 'LOGNAME': 'cltbld', 22:28:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:12 INFO - 'MOZ_NO_REMOTE': '1', 22:28:12 INFO - 'NO_EM_RESTART': '1', 22:28:12 INFO - 'PAGER': '/bin/cat', 22:28:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:28:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:12 INFO - 'PWD': '/builds/slave/test', 22:28:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:28:12 INFO - 'SHELL': '/bin/bash', 22:28:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XYd09ed117/Listeners', 22:28:12 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 22:28:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:28:12 INFO - 'USER': 'cltbld', 22:28:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:28:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:28:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:12 INFO - 'XPC_FLAGS': '0x0', 22:28:12 INFO - 'XPC_SERVICE_NAME': '0', 22:28:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:28:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:28:13 INFO - Cleaning up... 22:28:13 INFO - Return code: 0 22:28:13 INFO - Running post-action listener: _resource_record_post_action 22:28:13 INFO - Running post-action listener: _start_resource_monitoring 22:28:13 INFO - Starting resource monitoring. 22:28:13 INFO - [mozharness: 2016-10-07 05:28:13.043726Z] Finished create-virtualenv step (success) 22:28:13 INFO - [mozharness: 2016-10-07 05:28:13.044708Z] Running install step. 22:28:13 INFO - Running pre-action listener: _resource_record_pre_action 22:28:13 INFO - Running main action method: install 22:28:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:28:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:28:13 INFO - Reading from file tmpfile_stdout 22:28:13 INFO - Detecting whether we're running mozinstall >=1.0... 22:28:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:28:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:28:13 INFO - Reading from file tmpfile_stdout 22:28:13 INFO - Output received: 22:28:13 INFO - Usage: mozinstall [options] installer 22:28:13 INFO - Options: 22:28:13 INFO - -h, --help show this help message and exit 22:28:13 INFO - -d DEST, --destination=DEST 22:28:13 INFO - Directory to install application into. [default: 22:28:13 INFO - "/builds/slave/test"] 22:28:13 INFO - --app=APP Application being installed. [default: firefox] 22:28:13 INFO - mkdir: /builds/slave/test/build/application 22:28:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 22:28:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 22:28:48 INFO - Reading from file tmpfile_stdout 22:28:48 INFO - Output received: 22:28:48 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 22:28:48 INFO - Running post-action listener: _resource_record_post_action 22:28:48 INFO - [mozharness: 2016-10-07 05:28:48.835269Z] Finished install step (success) 22:28:48 INFO - [mozharness: 2016-10-07 05:28:48.835391Z] Running run-tests step. 22:28:48 INFO - Running pre-action listener: _resource_record_pre_action 22:28:48 INFO - Running main action method: run_tests 22:28:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:28:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:28:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:28:48 INFO - 2016-10-06 22:28:48.849 screenresolution[1640:7425] starting screenresolution argv=screenresolution get 22:28:48 INFO - 2016-10-06 22:28:48.852 screenresolution[1640:7425] Display 0: 1600x1200x32@60 22:28:48 INFO - 2016-10-06 22:28:48.858 screenresolution[1641:7427] starting screenresolution argv=screenresolution list 22:28:48 INFO - Available Modes on Display 0 22:28:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:28:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:28:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:28:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:28:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:28:49 INFO - Intel Iris: 22:28:49 INFO - Chipset Model: Intel Iris 22:28:49 INFO - Type: GPU 22:28:49 INFO - Bus: Built-In 22:28:49 INFO - VRAM (Dynamic, Max): 1536 MB 22:28:49 INFO - Vendor: Intel (0x8086) 22:28:49 INFO - Device ID: 0x0a2e 22:28:49 INFO - Revision ID: 0x0009 22:28:49 INFO - Displays: 22:28:49 INFO - Display: 22:28:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:28:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:28:49 INFO - Display Serial Number: 1600x1200 60 22:28:49 INFO - Main Display: Yes 22:28:49 INFO - Mirror: Off 22:28:49 INFO - Online: Yes 22:28:49 INFO - Rotation: Supported 22:28:49 INFO - Return code: 0 22:28:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:28:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:28:49 INFO - Python 2.7.3 22:28:49 INFO - Return code: 0 22:28:49 INFO - grabbing minidump binary from tooltool 22:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:28:49 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 0x108c10d30>, '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 0x108a36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c08b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:28:49 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 22:28:49 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 22:28:49 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 22:28:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:28:49 INFO - Return code: 0 22:28:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:28:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:28:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:28:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:28:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:28:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0010', '--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 22:28:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0010 --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 22:28:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tvzFx0ZVL3/Render', 22:28:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:28:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:28:49 INFO - 'HOME': '/Users/cltbld', 22:28:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:28:49 INFO - 'LOGNAME': 'cltbld', 22:28:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:28:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:28:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:49 INFO - 'MOZ_NO_REMOTE': '1', 22:28:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:28:49 INFO - 'NO_EM_RESTART': '1', 22:28:49 INFO - 'PAGER': '/bin/cat', 22:28:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:28:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:49 INFO - 'PWD': '/builds/slave/test', 22:28:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:28:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:28:49 INFO - 'SHELL': '/bin/bash', 22:28:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XYd09ed117/Listeners', 22:28:49 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 22:28:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:28:49 INFO - 'USER': 'cltbld', 22:28:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:28:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:28:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:49 INFO - 'XPC_FLAGS': '0x0', 22:28:49 INFO - 'XPC_SERVICE_NAME': '0', 22:28:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:28:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0010', '--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 22:28:49 INFO - mozversion application_buildid: 20161006202401 22:28:49 INFO - mozversion application_changeset: 0e67f06bcfcc83f4317a968914232bb6c82965ac 22:28:49 INFO - mozversion application_display_name: Nightly 22:28:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:28:49 INFO - mozversion application_name: Firefox 22:28:49 INFO - mozversion application_remotingname: firefox 22:28:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:28:49 INFO - mozversion application_vendor: Mozilla 22:28:49 INFO - mozversion application_version: 52.0a1 22:28:49 INFO - mozversion platform_buildid: 20161006202401 22:28:49 INFO - mozversion platform_changeset: 0e67f06bcfcc83f4317a968914232bb6c82965ac 22:28:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:28:49 INFO - mozversion platform_version: 52.0a1 22:28:49 INFO - using testdate: 1475818129 22:28:49 INFO - actual date: 1475818129 22:28:49 INFO - starting webserver on 'localhost:49273' 22:28:49 INFO - SUITE-START | Running 2 tests 22:28:49 INFO - TEST-START | dromaeo_css 22:28:49 INFO - operating with platform_type : mac_ 22:28:49 INFO - Initialising browser for dromaeo_css test... 22:28:49 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/tmpyqSZpA/profile http://localhost:49273/getInfo.html) 22:28:51 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 22:28:51 INFO - PROCESS | 1651 | colorDepth:24 22:28:51 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 22:28:51 INFO - PROCESS | 1651 | __metrics 22:28:51 INFO - PROCESS | 1651 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:28:51 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:28:52 INFO - TEST-INFO | 1651: exit 0 22:28:52 INFO - Browser initialized. 22:28:52 INFO - Running cycle 1/1 for dromaeo_css test... 22:28:52 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/tmpyqSZpA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:29:04 INFO - PROCESS | 1653 | RSS: Main: 252395520 22:29:04 INFO - PROCESS | 1653 | 22:29:55 INFO - PROCESS | 1653 | 1475818195838 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] 22:32:09 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 22:32:11 INFO - PROCESS | 1653 | RSS: Main: 384847872 22:32:11 INFO - PROCESS | 1653 | 22:35:13 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 22:35:14 INFO - PROCESS | 1653 | RSS: Main: 395866112 22:35:14 INFO - PROCESS | 1653 | 22:38:16 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 22:38:17 INFO - PROCESS | 1653 | RSS: Main: 376090624 22:38:17 INFO - PROCESS | 1653 | 22:41:19 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 22:41:20 INFO - PROCESS | 1653 | RSS: Main: 361775104 22:41:20 INFO - PROCESS | 1653 | 22:44:23 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 22:44:24 INFO - PROCESS | 1653 | RSS: Main: 349798400 22:44:24 INFO - PROCESS | 1653 | 22:47:27 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 22:47:27 INFO - PROCESS | 1653 | RSS: Main: 439738368 22:47:27 INFO - PROCESS | 1653 | 22:47:27 INFO - PROCESS | 1653 | __start_tp_report 22:47:27 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 22:47:27 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 22:47:27 INFO - PROCESS | 1653 | |i|pagename|runs| 22:47:27 INFO - PROCESS | 1653 | |0;dojo.html;2850.3871667591466;3298.4062868683636;3350.3466823969334;3377.2232386551077;3400.081977865976;5574.60977731559;5660.2358681578025;5730.6275092118985;5740.5120564752;5749.453801888824;4861.829835955742;5672.943270567293;5696.145578163278;5798.7100644967795;5822.825315240539;5056.595472362221;5136.409312929024;5162.174052151657;5193;5213.739313034352;5278.577713782907;5290;5308.867278318035;5328.6269961102735;5375;5270.552003079704;5273.34083239595;5286.127788914863;5327.307450031491;5356.9732151339185;5097.082525145473;5167.09575824233;5188.299579556787;5193.844184674465;5222.451642577551;4924.409070911478;4949.133901567211;4989.126902791997;5164.896702065976;5271.762770675329;5407.702576358299;5419.241306217133;5445.1832225166145;5445.945540544583;5521.889562208733;5863.296404431453;5875.383084776123;5900.350961394243;6090.543209259279;6130.264368275791;5761.88476230473;6188.2883468400805;6205.441510264052;6208.720607572625;6256.280527739277;5847.239858818326;5851.678157701367;5857.531397488191;5858.121281807677;5894.823155305347;6130.306415576139;6211.81364559064;6265.937340626627;6293.685315734195;6304.716287767062;6011.609245399035;6079;6105.114758360013;6115.663638499836;6116.388361163937;6195.101710251988;6247.718852651642;6252.249730032334;6252.3122456529745;6258.061290806324;6040.516758659297;6157.753689852356;6168.9691551541955;6180.072989051589;6199.938000620026;6062.302835174011;6142.109394137914;6262.467690246289;6266.780662676784;6272;4829.420469543677;4890.217565189552;4894.143524883202;4896.2410826321975;4918;4401;4432.047109871393;4469.307257375047;4493.618042466362;4496.5503449655425;5735.684537350402;5764.827055188351;5812.244408226988;5844.298684157843;5851.356350801409;6183.907241391383;6184.165137706352;6190.2571691397325;6193.876122477525;6199.721012554446;5606.803761868397;5648.6893220872425;5768.3654797972185;5783.421657834183;5791.333996590446;5361.731913404315;5368.8657783554945;5371.006363822706;5373.865653358619;5377.5429088527135;6132.600268413531;6152.538559607958;6174.691265436711;6178.5366097543765;6189.04069869162;6197.907031394442;6202.937970620236;6210.782622608187;6212.378762123752;6237.157983672328;6262.780802671885;6270.7805226816845;6278.277998030102;6288.245410550763;6295.150154729236;6070.3929607038945;6112.541559382975;6122.571420000735;6183.628982261079;6209.223847019122;6096.405739310651;6162.075688646739;6163.075538669056;6198.752049917953;6234.127222188807;6124.816255512342;6125.356837532173;6145.354737752472;6150.985087460519;6153.600015998945;5014.297998280316;6117.908231376622;6151.984922487918;6157.261128664589;6160.353162918008;5832.795852145325;5893.970530147321;5910.349861515316;5929.436703513159;5964.224650795369;6103.580118178587;6107.097787096225;6118.314626315779;6124.411449640054;6154;5939.851503712442;5964.850878727893;5979.521638268841;6034.939650603614;6068.908966365596 22:47:27 INFO - PROCESS | 1653 | |1;ext.html;466.19115834027934;472.91937921848563;474.94325126593327;501.0380070265091;524.3445692883895;30211;39148.825535233955;40331;40406.59593404065;42296.365554516706;40541.391879121766;40894.38658420119;40951.795241023756;41069.17861642766;41128.38307425391;9589.760255993586;9749;9761.219102471785;9772.560234789451;9779;9546.427214367126;9599.136077753;9715.659951901685;9718.902810971871;9722.027797220257;9611.134997850191;9709.077637624414;9739.51302434879;9742.464164470952;9752.951235243814;9597.568109435093;9603.519824008807;9704.320697551175;9708.66019689311;9733.756656083584;9507.762305942337;9601.855972160423;9606.087421694929;9614.182794462478;9625.614975400975;39277;39527.80236098801;39560.60439395598;39621.20757584861;39679.20641587181;2720.6327145835257;3249.155219642886;3252.869885204589;3357.244619960514;3720.8325625346924;29636;29787.70212297871;30483.69516304853;30787.076387708406;30833.845830770926;3100.674429184948;3285.917852053718;3293.440115180425;3295.555100061485;3324.6176689680756;413858;415694;415849.7320214406;416866;419778;56054.43945560574;56150.15774763382;56833.86332273414;56965.14552281719;56987.430125698214;59756.80486390248;59790.10314845281;59953.70023149944;59975.70012149911;59978.70010650006;15515.301811418512;15734.9213253933;15996.840031599768;16002.279897404645;16036.599085022968;12426.875731242571;12493.625191244277;12504.874951250371;12506;12530.749385012248;15846.366145354288;16393.754093688603;16409.261583228785;16428.83571164297;16470.6705865882;5967.373425790316;6023.518118550505;6066.120412540157;6069.15031895535;6083.878322433527;836.8744688296804;952.7332346942728;1014.5586669798661;1038.8130136575337;1054.7152268887357;28988.855055724587;29332;29553.408931821672;29802.97659815897;29897.551536726965;809.9473534220257;1005.1807776661997;1059.9629012984508;1087;1102.6251074634663;14239.78640320396;14667.559973200821;15092.849071509365;15541;15601.84398156004;605041;611832;612334;613086;613413;48166;54335.72832135814;54734.17898731522;54860.628484287416;54926.45073549293;1231.199720181871;1318.821959035518;1332.3538084029237;1367.6580854786303;1375.6698392385956;30180.69819301779;30624.846875765477;30657;31349.52975705412;31485;47595.524044759106;48177.27734083922;48213.276800847314;48213.75893120512;48224.27663584979;485816;488220;697550;712763;717071;24956;25124.497510050063;25136.12023579166;25144.62283065719;25205.99176032938;44578.108437830415;44987.55012449965;45128.32307515324;46367.304490432;47397.763011184725;31169.68830311668;37556.81221593874;37580.624193757714;37933.05167370838;38243.235135296585;37400.153955352645;37706.62293377031;38155.28393983919;39318.41022384609;40145.79927100346;37459.81270093632;37500.812495937345;37596;38017.2396552073;38066.857994260215;27797;32567.348653027282;33962.981110566725;34209.48685769765;34276.65723342834;24956.251312460656;25244.116455923955;25323.987040518172;25637.743622563536;25641 22:47:27 INFO - PROCESS | 1653 | |2;jquery.html;292.09741897536605;370.4369358574966;374.1656106881654;380.64790069186006;404.9210403971227;14554.781678274821;15307.081575105487;17165.05592192432;18533;21314.786852131474;19889.104990275435;20647.587048259025;20676.17295308186;21383.35849924501;21426.57146857066;5902.026165682668;6039.6980150992495;6087.086936959469;6111.480524155452;6115.0521669141135;4139.510217433331;4271.231178387889;4308.43990281263;4474.798634061475;6775.085363475917;6764.695588698521;6816.488763342769;6818;6822.010808432774;6837.453003759687;6507.089007538948;6658.833529161737;6708.597484150967;6714.865702685967;6718.428933540655;5498.532624726903;5743.138529220609;5814.098814683731;5817.767289308423;5834;25985.610215846777;26082;26145.08492202783;26330.341741456425;26484;2044.9795502045088;2223.12186686258;2323.1984965186984;2329.685492458513;2364.621660534306;10359.326643768207;10648.041676249175;10654.680359589147;13530.797038044437;14108.435662573485;1730.3424698614572;1746.9213885375189;1880.1069491991332;1953.5311525233983;1975.07171629334;53120.734396327774;100858;107247.46376268147;108028;110346.9999999992;11000.449977501094;11279.492422840993;11295.887041129483;11479.196456247982;11606.187566870238;14495.347709353104;14607.19660418666;14645.633859153606;14665.633359166106;14669.266536673123;7844.705623572161;8126.593670316461;8463.830723385498;8513.702020429255;8522.57387130641;7906.7627971160955;8332.33341332692;8362.498250105013;8556.61495232716;8558.78603034929;4444.088961762831;4549.340345649863;4552.567506086916;4608.493065762764;4617.3304870793545;1702.8931194723282;1871.822176893193;1912.741779859729;1931.3433432632971;1935.1485346447519;728.7595093619093;746.2798399544357;845.4884794699242;879.9252063574668;892.3931726425963;21085.472863178544;21651.88614163304;21745.456363591038;21911.904404780016;22008.44978875509;922.718570835888;928.8606708993705;933.3979583168954;970.6845275285419;1012.9005243953526;10203.693889183336;11311.660650180507;11339;11485.138614603939;11532;454765;464698;532403;537871;538416;101863.98136018692;109297;112597;117763.41118294354;122966.73057628048;923.3905622289257;944.7354740672623;964.4647220792388;967.1005964453126;970.3595626886363;18592.44222673322;18927.526811829815;18974.715379269597;19014.23943042263;19026;50934.49065509297;52180.217296741335;52266.738666306424;53123.73438132785;53446;70017;70411.94382084375;72445.13323001382;74031;76461;7464.581729471383;7508.587027713528;7957.323627491496;8115.715949941724;8127.634256458592;11701.590444334408;12509.374531273583;12542.24746515212;12969.54606588765;13079.346032698137;9617.519124043909;10654.13044881186;10693.57225710994;11033.117350612092;11288.94355528217;10472.842907356548;10652.360858348524;10931.508082136483;11272.943635281772;11316.547338106384;8448.493090414595;10933.781324373309;11187.804573285019;11382.260153090023;11656.475458604553;6905.516613837184;7203.135623725187;7276.599787011765;8036.55798931041;8233.423660343959;10828.296160749525;11200.10399168081;11312.94343528277;11337.03635191018;11344.602938897098 22:47:27 INFO - PROCESS | 1653 | |3;mootools.html;1521.31540806637;1535.4165417141485;1723.1987125986423;1794.4437224460426;1870.971935420969;7995.440319177653;9019.774505637362;9086.454812711225;9094.86357704635;9097;7931.9206807931905;8134.349252059836;8531.91468085319;8769.429987050837;8848;2326.918557850471;2358.433975845793;2358.7523310052457;2359.268626725712;2359.551685179819;2307.065638416444;2342.7188737351544;2343.496148328109;2355.1756885090167;2362.6692263083182;2305.2738387407912;2314.2941402872116;2327.3948773318975;2332.2070496031347;2338.9415264618438;2292.3008482412856;2312.710911136108;2315.108683156997;2316.108298305148;2320.5590937721777;2269.7389800173028;2282.6461898405773;2291.4271432141963;2299.1148407863093;2308.4344335637707;8931.821363572692;8971.102889711043;8989.865152022725;9001.414908030956;9011.053839346905;5197.8440646780655;5376.78492860289;5380.596455265871;5388.91916621251;5405.243265942771;3366.562346894888;3448.81031543265;3600.765950213228;3610.981945090284;3613.1509095362567;931.3340961212698;944.5702205496483;945.4091193004373;945.4469135555709;954;11893.821592676117;11895.821562676567;11908.88091119095;11955;11971.760564788743;4505.234110201273;4594.839180628662;4689.7655117244;4756.7145971241835;4767.284907263869;10067.848982265272;10068.44623545712;10079.395236285847;10088.092071713434;10100.646477373257;5359.866003349947;5362.329708786402;5362.570994320445;5366.812161574326;5370.140777475585;4317.848875289413;4375.890602734957;4874.293227481995;4911.287863259808;4922.163232250526;3379.712724418403;3835.463035175078;3862.864799731996;3919.6668283195677;3978.025383780934;1250.693580072888;1252.3988485526997;1255.0900597067052;1270.231509936475;1273.420593629896;793.9404544659174;803.2569872867574;910.2899738204211;948.990510094904;951.7573018880141;5669.489745922887;5832.3292821326095;6019.4883434908525;6114;6279.497640188774;878.503645440337;915.8626206069143;918.3296193778579;950.1923365139576;961.1637875048752;3769.6041915599017;3899.512560929884;3960.148568057824;4034.7579145250793;4046.5548789633117;10149.035841595036;10554.313969591953;10739.785204296026;10896.836547451636;10951;10720.517576709066;10828.566857325619;10842.241043126905;10851.891481085087;10896.509657065451;8014.19858014194;8187.590620468953;8311.376646751518;8323.292520135736;8330.291925186306;5631.352394474688;5666.601785723079;5763.4812866842185;5766.4233576642;5897.174395584708;10067.647632332833;10114.241431892491;10134.695959121238;10142.645007424704;10144;9639.277054220822;10162.491875406347;10197.84703229467;10206.13247873939;10375;6985.231624521197;7215.386692131227;7248.927510725036;7405.2224516425;7536.849263014599;8101.918980810116;8375.41372103947;8383.832323353621;8457.57712114404;8466.957665211881;7333.266673332838;7424.517406368569;7444.292792184734;7527;7600.391968642385;7254.310840470147;7320.524165929198;7385.150707668687;7396.001539792059;7544.245575442412;6863.553868998499;6994.825129371603;7012.824679383056;7015.789526314219;7021.754238601625;4910.134149023348;4946.233333833262;5047.798088076583;5071.264666623393;5121.206213036985;4959.355283813081;4970.179920313252;5123.948760512347;5170.6380553360905;5261.289725886956 22:47:27 INFO - PROCESS | 1653 | |4;prototype.html;290.72526462492937;292.5334092123063;305.9892903748369;306.5401897154268;312.7076183768177;4317.309230523117;5019.272205530196;5181.274621552986;5231.8953620927605;5294.761735721892;4800.4719480857075;4815.27770834375;4921.311016457699;5131.230315452684;5177.378714554249;3980.1840622672285;3993.321135406973;4002.3596224603925;4018.6584140348104;4052.898677533056;3664.5236119304586;3718.572364178127;3972.8410863565423;4036.697247706419;4042.120414007486;3512.63117372676;3708.1841994761107;3946.033221860648;3967.504061992251;3993.6006399359976;3342.6462282775515;3953.525576930787;3954.584768599299;3957;3977.5823538528616;3034.742046925992;3310.8344582770765;3346.0631023313267;3405.6764607362506;3436.6563343665434;4306.031142992832;4447.621952134073;4669.696469729457;4864.878378040542;5156.845294641167;4457.754823484707;4486.753228572427;4498.887527811831;4541.81992643533;4583.793729282157;5070.797168113271;5381.569474442074;5452.972735136339;5455.672659640434;5463.31708536433;3551.874765283733;3657.7988210648405;3663.029297236208;3732.5894151643297;3793.639604237593;4690.467147740216;5679.460451257124;5686.687232202185;5702.486776190121;5714.228579141846;3508.7543921907863;3754.4743735877;3770.6417890300377;3770.962985179098;3787.750042485973;3830.3105441020884;3852.1301630285616;3853.7302388833073;3871.8644847430205;3873.6564378551134;3376.729861611065;3697.2420653766453;4472.217361961643;4484.730916145042;4485.529019452975;5434.03844904528;5452.563794896399;5452.837354334477;5458.890822183614;5473.808416705476;1079.8110330692098;1264.6594609713734;1276.342683517989;1286.8713128687057;1287.3498883063992;792.8533221354068;868.4714901772799;871.9782005449788;898.7573355194061;911.0889110889111;4257.382679511516;4702.412198475191;4814.988852341047;5000.924986125211;5148.665336753099;4413.801378937891;5289.656172348785;5627.352854421712;5666.603337766317;5673.886522269614;5042.949570504248;5102.005109003709;5110.310108135354;5116.744162791845;5122.052420302256;2415.9033638654255;2430.225935067411;2456.7297597264287;2476.6656501372086;2477.3773178568067;4423.186493537699;4722.645801564828;4867.683600565952;4870.659053866196;4936.7044324389335;4067.633912947849;4509.797059132281;4703.506131856174;4717.716936983792;4739.4075740532435;4199.643030342455;4207.980169518587;4572.954270457253;4748.738819364899;4894;3653.7625054372443;3973.701972352143;4224.634204845296;4561.543845615412;4597.081123198146;4114.465119534441;4214.1150358425075;4482.551744825491;4582.702124361906;4621;4137.834486620622;4785.636093713275;4814.518548145157;4840.394950631171;4855.975720121377;2848.871800768929;2919.4453053919688;3257.039173443887;3279.4916787897914;3296.2748195396975;4564.726116433025;4717.952820471889;5146.4338922717725;5258.605604579749;5679.34687510925;4820.638452116035;5265.920486300376;5486.259354987025;5498.945010549844;5508.834734957958;5501.587380946365;5518.91721624184;5522.088855338824;5558.666480011212;5565.276514053147;4341.674374421994;5342.599305052059;5373.946260537501;5435.864103397288;5461.644993075437;5245.97703447824;5476.096444086681;5479.4520547944885;5501.724913754377;5610.4670056344585;5009.874753131201;5185.714785686823;5296;5451.809186678447;5547.140193270049 22:47:27 INFO - PROCESS | 1653 | |5;yui.html;693.8057343943698;752.5221484357431;772.8222508822971;793.7301317552033;801.1187693537114;14894.553163405088;15394.461193858217;15633.218339083043;15706;15965.92017039916;14299.142051476892;14548.563543093724;14569.562913112624;14575.198364089998;14583.41666333348;670.3296703296703;689.6034780001494;823.5882058970515;849.8427790858711;851.3742399336483;626.28603392133;691.2914262880537;710.5274992130227;853.2960307746134;853.3983541603186;898.4833720610642;901.0808974845653;901.6618767962015;902.62992173209;904.7376260884369;704.7286794584071;899.4108858697564;899.5637115998735;904.7828521154876;904.7873749668822;532.2229544864464;640.6412409050946;659.7097277198018;662.0466528199378;662.8939369700824;14776.335064922105;14841;14860.405583776635;14864.554063378007;14875;13321.866781332159;13644.386002629906;13731.45074197031;13781.448742050306;14027.859721402758;10965.56137754489;11498.942505287503;11679.240849344766;11680.707982300426;11813.527458901634;4535.614472769818;4537.342085397599;4543.795529201194;4698.741569213692;4759.809607615691;100511;102647;102698.48650756698;102772.48613756958;102791.4860425693;10278.22913281507;10367.118794902517;10723.892761072446;10763.892361076445;11038.227324087236;19755;19958.20167193296;20008.89951052677;20016.199352026048;20047;7483.513571617937;7580.1661817200065;7611.4291428142005;7790.844183116306;7848.725294614661;4179.352200408942;4262.062346283813;4268.0823622921225;4429.291313389842;4432.490263619725;3252.1381833814057;3311.2549676323115;3359.7816141950693;3371.6459771723617;3373.375925453799;587.9706014699248;594.390749481776;604.5919004671916;607.5898768331359;614.6127939398151;492.5419359995239;544.4664229055547;571.171800888713;606.1937622961451;646.2051676438008;9029.36794424384;9029.9316262367;9274.21169200612;9341.20599749029;9509.809803804024;588.6732863260931;607.8480379905023;647.7247169952846;679.8606285711418;688.3804575881646;4174.749515029108;4424.84513042042;4574.81700731967;4590.862274131781;4634.606058485067;96243.51878240563;112304.43847780873;114720.85279147101;129657;129798.35100824435;121535.10021848552;121888.78111218952;123568.76431235572;124465.37767311106;125177;66252.668736656;66764.66470670559;94645;106199;109668.4516577412;9424.670136545188;9507.334486586149;9556.76108097303;9588.472634005197;9694.75763105928;50834.745826270635;58234.70882645559;62076;63268;63640.68179659072;56788.14817777654;83315.5834220825;84360.57819710863;90925;92424.53787731018;12263.75472490563;12742.299173545543;12818.166819156724;12997;13467.32663366808;14467.565973020826;14539.563813085624;14738.852611473749;15027.474038408604;15460.613484662974;13184.406701698255;13259.887846757138;13916.025878188835;13955.720885582028;14139.43442262298;13324.866751332751;13451.327433628083;13664.590062298146;13736.65658358549;14237.64405889861;12700.618981430573;13225.470981160646;13436.798448023483;13471.989600779785;13647.38586763618;10793.56825726962;11230.94384528072;11365.374904380338;11656.708582285512;11693.006094482063;10506.744768368822;11301;11315.321080735182;11505.252158609663;11546.307221566733 22:47:27 INFO - PROCESS | 1653 | __end_tp_report 22:47:27 INFO - PROCESS | 1653 | __start_cc_report 22:47:27 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1227 22:47:27 INFO - PROCESS | 1653 | __end_cc_report 22:47:27 INFO - PROCESS | 1653 | __startTimestamp1475819247839__endTimestamp 22:47:27 INFO - PROCESS | 1653 | 22:47:27 INFO - PROCESS | 1653 | ------- Summary: start ------- 22:47:27 INFO - PROCESS | 1653 | Number of tests: 6 22:47:27 INFO - PROCESS | 1653 | 22:47:27 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5706.84 Median:5910.35 stddev:645.11 (10.9%) stddev-sans-first:606.93 22:47:27 INFO - PROCESS | 1653 | Values: 2850.4 3298.4 3350.3 3377.2 3400.1 5574.6 5660.2 5730.6 5740.5 5749.5 4861.8 5672.9 5696.1 5798.7 5822.8 5056.6 5136.4 5162.2 5193.0 5213.7 5278.6 5290.0 5308.9 5328.6 5375.0 5270.6 5273.3 5286.1 5327.3 5357.0 5097.1 5167.1 5188.3 5193.8 5222.5 4924.4 4949.1 4989.1 5164.9 5271.8 5407.7 5419.2 5445.2 5445.9 5521.9 5863.3 5875.4 5900.4 6090.5 6130.3 5761.9 6188.3 6205.4 6208.7 6256.3 5847.2 5851.7 5857.5 5858.1 5894.8 6130.3 6211.8 6265.9 6293.7 6304.7 6011.6 6079.0 6105.1 6115.7 6116.4 6195.1 6247.7 6252.2 6252.3 6258.1 6040.5 6157.8 6169.0 6180.1 6199.9 6062.3 6142.1 6262.5 6266.8 6272.0 4829.4 4890.2 4894.1 4896.2 4918.0 4401.0 4432.0 4469.3 4493.6 4496.6 5735.7 5764.8 5812.2 5844.3 5851.4 6183.9 6184.2 6190.3 6193.9 6199.7 5606.8 5648.7 5768.4 5783.4 5791.3 5361.7 5368.9 5371.0 5373.9 5377.5 6132.6 6152.5 6174.7 6178.5 6189.0 6197.9 6202.9 6210.8 6212.4 6237.2 6262.8 6270.8 6278.3 6288.2 6295.2 6070.4 6112.5 6122.6 6183.6 6209.2 6096.4 6162.1 6163.1 6198.8 6234.1 6124.8 6125.4 6145.4 6151.0 6153.6 5014.3 6117.9 6152.0 6157.3 6160.4 5832.8 5894.0 5910.3 5929.4 5964.2 6103.6 6107.1 6118.3 6124.4 6154.0 5939.9 5964.9 5979.5 6034.9 6068.9 22:47:27 INFO - PROCESS | 1653 | 22:47:27 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:67814.97 Median:39590.91 stddev:150188.61 (379.4%) stddev-sans-first:150524.81 22:47:27 INFO - PROCESS | 1653 | Values: 466.2 472.9 474.9 501.0 524.3 30211.0 39148.8 40331.0 40406.6 42296.4 40541.4 40894.4 40951.8 41069.2 41128.4 9589.8 9749.0 9761.2 9772.6 9779.0 9546.4 9599.1 9715.7 9718.9 9722.0 9611.1 9709.1 9739.5 9742.5 9753.0 9597.6 9603.5 9704.3 9708.7 9733.8 9507.8 9601.9 9606.1 9614.2 9625.6 39277.0 39527.8 39560.6 39621.2 39679.2 2720.6 3249.2 3252.9 3357.2 3720.8 29636.0 29787.7 30483.7 30787.1 30833.8 3100.7 3285.9 3293.4 3295.6 3324.6 413858.0 415694.0 415849.7 416866.0 419778.0 56054.4 56150.2 56833.9 56965.1 56987.4 59756.8 59790.1 59953.7 59975.7 59978.7 15515.3 15734.9 15996.8 16002.3 16036.6 12426.9 12493.6 12504.9 12506.0 12530.7 15846.4 16393.8 16409.3 16428.8 16470.7 5967.4 6023.5 6066.1 6069.2 6083.9 836.9 952.7 1014.6 1038.8 1054.7 28988.9 29332.0 29553.4 29803.0 29897.6 809.9 1005.2 1060.0 1087.0 1102.6 14239.8 14667.6 15092.8 15541.0 15601.8 605041.0 611832.0 612334.0 613086.0 613413.0 48166.0 54335.7 54734.2 54860.6 54926.5 1231.2 1318.8 1332.4 1367.7 1375.7 30180.7 30624.8 30657.0 31349.5 31485.0 47595.5 48177.3 48213.3 48213.8 48224.3 485816.0 488220.0 697550.0 712763.0 717071.0 24956.0 25124.5 25136.1 25144.6 25206.0 44578.1 44987.6 45128.3 46367.3 47397.8 31169.7 37556.8 37580.6 37933.1 38243.2 37400.2 37706.6 38155.3 39318.4 40145.8 37459.8 37500.8 37596.0 38017.2 38066.9 27797.0 32567.3 33963.0 34209.5 34276.7 24956.3 25244.1 25324.0 25637.7 25641.0 22:47:27 INFO - PROCESS | 1653 | 22:47:27 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:31256.52 Median:26237.71 stddev:84626.20 (322.5%) stddev-sans-first:84831.66 22:47:27 INFO - PROCESS | 1653 | Values: 292.1 370.4 374.2 380.6 404.9 14554.8 15307.1 17165.1 18533.0 21314.8 19889.1 20647.6 20676.2 21383.4 21426.6 5902.0 6039.7 6087.1 6111.5 6115.1 4139.5 4271.2 4308.4 4474.8 6775.1 6764.7 6816.5 6818.0 6822.0 6837.5 6507.1 6658.8 6708.6 6714.9 6718.4 5498.5 5743.1 5814.1 5817.8 5834.0 25985.6 26082.0 26145.1 26330.3 26484.0 2045.0 2223.1 2323.2 2329.7 2364.6 10359.3 10648.0 10654.7 13530.8 14108.4 1730.3 1746.9 1880.1 1953.5 1975.1 53120.7 100858.0 107247.5 108028.0 110347.0 11000.4 11279.5 11295.9 11479.2 11606.2 14495.3 14607.2 14645.6 14665.6 14669.3 7844.7 8126.6 8463.8 8513.7 8522.6 7906.8 8332.3 8362.5 8556.6 8558.8 4444.1 4549.3 4552.6 4608.5 4617.3 1702.9 1871.8 1912.7 1931.3 1935.1 728.8 746.3 845.5 879.9 892.4 21085.5 21651.9 21745.5 21911.9 22008.4 922.7 928.9 933.4 970.7 1012.9 10203.7 11311.7 11339.0 11485.1 11532.0 454765.0 464698.0 532403.0 537871.0 538416.0 101864.0 109297.0 112597.0 117763.4 122966.7 923.4 944.7 964.5 967.1 970.4 18592.4 18927.5 18974.7 19014.2 19026.0 50934.5 52180.2 52266.7 53123.7 53446.0 70017.0 70411.9 72445.1 74031.0 76461.0 7464.6 7508.6 7957.3 8115.7 8127.6 11701.6 12509.4 12542.2 12969.5 13079.3 9617.5 10654.1 10693.6 11033.1 11288.9 10472.8 10652.4 10931.5 11272.9 11316.5 8448.5 10933.8 11187.8 11382.3 11656.5 6905.5 7203.1 7276.6 8036.6 8233.4 10828.3 11200.1 11312.9 11337.0 11344.6 22:47:27 INFO - PROCESS | 1653 | 22:47:27 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5727.65 Median:4952.79 stddev:3243.35 (65.5%) stddev-sans-first:3237.05 22:47:27 INFO - PROCESS | 1653 | Values: 1521.3 1535.4 1723.2 1794.4 1871.0 7995.4 9019.8 9086.5 9094.9 9097.0 7931.9 8134.3 8531.9 8769.4 8848.0 2326.9 2358.4 2358.8 2359.3 2359.6 2307.1 2342.7 2343.5 2355.2 2362.7 2305.3 2314.3 2327.4 2332.2 2338.9 2292.3 2312.7 2315.1 2316.1 2320.6 2269.7 2282.6 2291.4 2299.1 2308.4 8931.8 8971.1 8989.9 9001.4 9011.1 5197.8 5376.8 5380.6 5388.9 5405.2 3366.6 3448.8 3600.8 3611.0 3613.2 931.3 944.6 945.4 945.4 954.0 11893.8 11895.8 11908.9 11955.0 11971.8 4505.2 4594.8 4689.8 4756.7 4767.3 10067.8 10068.4 10079.4 10088.1 10100.6 5359.9 5362.3 5362.6 5366.8 5370.1 4317.8 4375.9 4874.3 4911.3 4922.2 3379.7 3835.5 3862.9 3919.7 3978.0 1250.7 1252.4 1255.1 1270.2 1273.4 793.9 803.3 910.3 949.0 951.8 5669.5 5832.3 6019.5 6114.0 6279.5 878.5 915.9 918.3 950.2 961.2 3769.6 3899.5 3960.1 4034.8 4046.6 10149.0 10554.3 10739.8 10896.8 10951.0 10720.5 10828.6 10842.2 10851.9 10896.5 8014.2 8187.6 8311.4 8323.3 8330.3 5631.4 5666.6 5763.5 5766.4 5897.2 10067.6 10114.2 10134.7 10142.6 10144.0 9639.3 10162.5 10197.8 10206.1 10375.0 6985.2 7215.4 7248.9 7405.2 7536.8 8101.9 8375.4 8383.8 8457.6 8467.0 7333.3 7424.5 7444.3 7527.0 7600.4 7254.3 7320.5 7385.2 7396.0 7544.2 6863.6 6994.8 7012.8 7015.8 7021.8 4910.1 4946.2 5047.8 5071.3 5121.2 4959.4 4970.2 5123.9 5170.6 5261.3 22:47:27 INFO - PROCESS | 1653 | 22:47:27 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4220.02 Median:4583.25 stddev:1296.70 (28.3%) stddev-sans-first:1266.35 22:47:27 INFO - PROCESS | 1653 | Values: 290.7 292.5 306.0 306.5 312.7 4317.3 5019.3 5181.3 5231.9 5294.8 4800.5 4815.3 4921.3 5131.2 5177.4 3980.2 3993.3 4002.4 4018.7 4052.9 3664.5 3718.6 3972.8 4036.7 4042.1 3512.6 3708.2 3946.0 3967.5 3993.6 3342.6 3953.5 3954.6 3957.0 3977.6 3034.7 3310.8 3346.1 3405.7 3436.7 4306.0 4447.6 4669.7 4864.9 5156.8 4457.8 4486.8 4498.9 4541.8 4583.8 5070.8 5381.6 5453.0 5455.7 5463.3 3551.9 3657.8 3663.0 3732.6 3793.6 4690.5 5679.5 5686.7 5702.5 5714.2 3508.8 3754.5 3770.6 3771.0 3787.8 3830.3 3852.1 3853.7 3871.9 3873.7 3376.7 3697.2 4472.2 4484.7 4485.5 5434.0 5452.6 5452.8 5458.9 5473.8 1079.8 1264.7 1276.3 1286.9 1287.3 792.9 868.5 872.0 898.8 911.1 4257.4 4702.4 4815.0 5000.9 5148.7 4413.8 5289.7 5627.4 5666.6 5673.9 5042.9 5102.0 5110.3 5116.7 5122.1 2415.9 2430.2 2456.7 2476.7 2477.4 4423.2 4722.6 4867.7 4870.7 4936.7 4067.6 4509.8 4703.5 4717.7 4739.4 4199.6 4208.0 4573.0 4748.7 4894.0 3653.8 3973.7 4224.6 4561.5 4597.1 4114.5 4214.1 4482.6 4582.7 4621.0 4137.8 4785.6 4814.5 4840.4 4856.0 2848.9 2919.4 3257.0 3279.5 3296.3 4564.7 4718.0 5146.4 5258.6 5679.3 4820.6 5265.9 5486.3 5498.9 5508.8 5501.6 5518.9 5522.1 5558.7 5565.3 4341.7 5342.6 5373.9 5435.9 5461.6 5246.0 5476.1 5479.5 5501.7 5610.5 5009.9 5185.7 5296.0 5451.8 5547.1 22:47:27 INFO - PROCESS | 1653 | 22:47:27 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:22594.09 Median:3774.06 stddev:34520.31 (914.7%) stddev-sans-first:34577.99 22:47:27 INFO - PROCESS | 1653 | Values: 693.8 752.5 772.8 793.7 801.1 14894.6 15394.5 15633.2 15706.0 15965.9 14299.1 14548.6 14569.6 14575.2 14583.4 670.3 689.6 823.6 849.8 851.4 626.3 691.3 710.5 853.3 853.4 898.5 901.1 901.7 902.6 904.7 704.7 899.4 899.6 904.8 904.8 532.2 640.6 659.7 662.0 662.9 14776.3 14841.0 14860.4 14864.6 14875.0 13321.9 13644.4 13731.5 13781.4 14027.9 10965.6 11498.9 11679.2 11680.7 11813.5 4535.6 4537.3 4543.8 4698.7 4759.8 100511.0 102647.0 102698.5 102772.5 102791.5 10278.2 10367.1 10723.9 10763.9 11038.2 19755.0 19958.2 20008.9 20016.2 20047.0 7483.5 7580.2 7611.4 7790.8 7848.7 4179.4 4262.1 4268.1 4429.3 4432.5 3252.1 3311.3 3359.8 3371.6 3373.4 588.0 594.4 604.6 607.6 614.6 492.5 544.5 571.2 606.2 646.2 9029.4 9029.9 9274.2 9341.2 9509.8 588.7 607.8 647.7 679.9 688.4 4174.7 4424.8 4574.8 4590.9 4634.6 96243.5 112304.4 114720.9 129657.0 129798.4 121535.1 121888.8 123568.8 124465.4 125177.0 66252.7 66764.7 94645.0 106199.0 109668.5 9424.7 9507.3 9556.8 9588.5 9694.8 50834.7 58234.7 62076.0 63268.0 63640.7 56788.1 83315.6 84360.6 90925.0 92424.5 12263.8 12742.3 12818.2 12997.0 13467.3 14467.6 14539.6 14738.9 15027.5 15460.6 13184.4 13259.9 13916.0 13955.7 14139.4 13324.9 13451.3 13664.6 13736.7 14237.6 12700.6 13225.5 13436.8 13472.0 13647.4 10793.6 11230.9 11365.4 11656.7 11693.0 10506.7 11301.0 11315.3 11505.3 11546.3 22:47:27 INFO - PROCESS | 1653 | -------- Summary: end -------- 22:47:27 INFO - PROCESS | 1653 | 22:47:28 INFO - TEST-INFO | 1653: exit 0 22:47:28 INFO - TEST-OK | dromaeo_css | took 1119029ms 22:47:28 INFO - TEST-START | kraken 22:47:28 INFO - operating with platform_type : mac_ 22:47:28 INFO - Initialising browser for kraken test... 22:47:28 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/tmpYEks55/profile http://localhost:49273/getInfo.html) 22:47:30 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 22:47:30 INFO - PROCESS | 1663 | colorDepth:24 22:47:30 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 22:47:30 INFO - PROCESS | 1663 | __metrics 22:47:30 INFO - PROCESS | 1663 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:47:30 INFO - PROCESS | 1663 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:47:31 INFO - TEST-INFO | 1663: exit 0 22:47:31 INFO - Browser initialized. 22:47:31 INFO - Running cycle 1/1 for kraken test... 22:47:31 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/tmpYEks55/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:47:43 INFO - PROCESS | 1664 | RSS: Main: 257761280 22:47:43 INFO - PROCESS | 1664 | 22:47:46 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 22:47:47 INFO - PROCESS | 1664 | RSS: Main: 313937920 22:47:47 INFO - PROCESS | 1664 | 22:47:49 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 22:47:50 INFO - PROCESS | 1664 | RSS: Main: 313573376 22:47:50 INFO - PROCESS | 1664 | 22:47:53 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 22:47:54 INFO - PROCESS | 1664 | RSS: Main: 398921728 22:47:54 INFO - PROCESS | 1664 | 22:47:56 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 22:47:57 INFO - PROCESS | 1664 | RSS: Main: 301219840 22:47:57 INFO - PROCESS | 1664 | 22:47:59 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:47:59 INFO - PROCESS | 1664 | RSS: Main: 306380800 22:47:59 INFO - PROCESS | 1664 | 22:48:02 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 22:48:03 INFO - PROCESS | 1664 | RSS: Main: 345325568 22:48:03 INFO - PROCESS | 1664 | 22:48:05 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 22:48:06 INFO - PROCESS | 1664 | RSS: Main: 344649728 22:48:06 INFO - PROCESS | 1664 | 22:48:09 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 22:48:09 INFO - PROCESS | 1664 | RSS: Main: 343617536 22:48:09 INFO - PROCESS | 1664 | 22:48:11 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:48:12 INFO - PROCESS | 1664 | RSS: Main: 319578112 22:48:12 INFO - PROCESS | 1664 | 22:48:13 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:48:14 INFO - PROCESS | 1664 | RSS: Main: 322420736 22:48:14 INFO - PROCESS | 1664 | 22:48:16 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:48:17 INFO - PROCESS | 1664 | RSS: Main: 330866688 22:48:17 INFO - PROCESS | 1664 | 22:48:20 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:48:21 INFO - PROCESS | 1664 | RSS: Main: 338227200 22:48:21 INFO - PROCESS | 1664 | 22:48:23 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:48:24 INFO - PROCESS | 1664 | RSS: Main: 337727488 22:48:24 INFO - PROCESS | 1664 | 22:48:26 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 22:48:26 INFO - PROCESS | 1664 | RSS: Main: 381976576 22:48:26 INFO - PROCESS | 1664 | 22:48:26 INFO - PROCESS | 1664 | __start_tp_report 22:48:26 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 22:48:26 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 22:48:26 INFO - PROCESS | 1664 | |i|pagename|runs| 22:48:26 INFO - PROCESS | 1664 | |0;ai-astar;114;112;114;113;112;113;113;113;113;113 22:48:26 INFO - PROCESS | 1664 | |1;audio-beat-detection;151;113;130;152;114;112;113;112;145;112 22:48:26 INFO - PROCESS | 1664 | |2;audio-dft;184;196;252;205;184;185;179;186;181;184 22:48:26 INFO - PROCESS | 1664 | |3;audio-fft;79;58;58;89;60;60;59;58;83;57 22:48:26 INFO - PROCESS | 1664 | |4;audio-oscillator;83;71;91;72;67;69;91;67;68;90 22:48:26 INFO - PROCESS | 1664 | |5;imaging-gaussian-blur;90;87;91;87;90;91;91;87;90;87 22:48:26 INFO - PROCESS | 1664 | |6;imaging-darkroom;95;94;95;95;95;95;94;95;94;95 22:48:26 INFO - PROCESS | 1664 | |7;imaging-desaturate;86;88;85;85;86;85;85;85;83;83 22:48:26 INFO - PROCESS | 1664 | |8;json-parse-financial;55;55;55;55;55;56;55;53;53;55 22:48:26 INFO - PROCESS | 1664 | |9;json-stringify-tinderbox;65;72;70;70;76;70;70;69;71;70 22:48:26 INFO - PROCESS | 1664 | |10;stanford-crypto-aes;90;87;86;86;86;87;88;89;89;93 22:48:26 INFO - PROCESS | 1664 | |11;stanford-crypto-ccm;144;145;141;132;155;148;152;146;174;155 22:48:26 INFO - PROCESS | 1664 | |12;stanford-crypto-pbkdf2;173;178;174;173;173;170;173;173;170;172 22:48:26 INFO - PROCESS | 1664 | |13;stanford-crypto-sha256-iterative;69;70;70;70;69;69;66;70;67;68 22:48:26 INFO - PROCESS | 1664 | __end_tp_report 22:48:26 INFO - PROCESS | 1664 | __start_cc_report 22:48:26 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,1970 22:48:26 INFO - PROCESS | 1664 | __end_cc_report 22:48:26 INFO - PROCESS | 1664 | __startTimestamp1475819306601__endTimestamp 22:48:26 INFO - PROCESS | 1664 | 22:48:26 INFO - PROCESS | 1664 | ------- Summary: start ------- 22:48:26 INFO - PROCESS | 1664 | Number of tests: 14 22:48:26 INFO - PROCESS | 1664 | 22:48:26 INFO - PROCESS | 1664 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 22:48:26 INFO - PROCESS | 1664 | Values: 114.0 112.0 114.0 113.0 112.0 113.0 113.0 113.0 113.0 113.0 22:48:26 INFO - PROCESS | 1664 | 22:48:26 INFO - PROCESS | 1664 | [#1] audio-beat-detection Cycles:10 Average:125.40 Median:122.00 stddev:17.46 (14.3%) stddev-sans-first:15.88 22:48:26 INFO - PROCESS | 1664 | Values: 151.0 113.0 130.0 152.0 114.0 112.0 113.0 112.0 145.0 112.0 22:48:26 INFO - PROCESS | 1664 | 22:48:26 INFO - PROCESS | 1664 | [#2] audio-dft Cycles:10 Average:193.60 Median:185.50 stddev:21.93 (11.8%) stddev-sans-first:22.98 22:48:26 INFO - PROCESS | 1664 | Values: 184.0 196.0 252.0 205.0 184.0 185.0 179.0 186.0 181.0 184.0 22:48:26 INFO - PROCESS | 1664 | 22:48:26 INFO - PROCESS | 1664 | [#3] audio-fft Cycles:10 Average:66.10 Median:60.00 stddev:12.39 (20.6%) stddev-sans-first:12.23 22:48:26 INFO - PROCESS | 1664 | Values: 79.0 58.0 58.0 89.0 60.0 60.0 59.0 58.0 83.0 57.0 22:48:26 INFO - PROCESS | 1664 | 22:48:26 INFO - PROCESS | 1664 | [#4] audio-oscillator Cycles:10 Average:76.90 Median:77.50 stddev:10.56 (13.6%) stddev-sans-first:10.96 22:48:26 INFO - PROCESS | 1664 | Values: 83.0 71.0 91.0 72.0 67.0 69.0 91.0 67.0 68.0 90.0 22:48:26 INFO - PROCESS | 1664 | 22:48:26 INFO - PROCESS | 1664 | [#5] imaging-gaussian-blur Cycles:10 Average:89.10 Median:90.00 stddev:1.85 (2.1%) stddev-sans-first:1.94 22:48:26 INFO - PROCESS | 1664 | Values: 90.0 87.0 91.0 87.0 90.0 91.0 91.0 87.0 90.0 87.0 22:48:26 INFO - PROCESS | 1664 | 22:48:26 INFO - PROCESS | 1664 | [#6] imaging-darkroom Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 22:48:26 INFO - PROCESS | 1664 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 22:48:26 INFO - PROCESS | 1664 | 22:48:26 INFO - PROCESS | 1664 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:1.45 (1.7%) stddev-sans-first:1.50 22:48:26 INFO - PROCESS | 1664 | Values: 86.0 88.0 85.0 85.0 86.0 85.0 85.0 85.0 83.0 83.0 22:48:26 INFO - PROCESS | 1664 | 22:48:26 INFO - PROCESS | 1664 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:0.95 (1.7%) stddev-sans-first:1.00 22:48:26 INFO - PROCESS | 1664 | Values: 55.0 55.0 55.0 55.0 55.0 56.0 55.0 53.0 53.0 55.0 22:48:26 INFO - PROCESS | 1664 | 22:48:26 INFO - PROCESS | 1664 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:70.00 stddev:2.71 (3.9%) stddev-sans-first:2.09 22:48:26 INFO - PROCESS | 1664 | Values: 65.0 72.0 70.0 70.0 76.0 70.0 70.0 69.0 71.0 70.0 22:48:26 INFO - PROCESS | 1664 | 22:48:26 INFO - PROCESS | 1664 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:88.50 stddev:2.23 (2.5%) stddev-sans-first:2.26 22:48:26 INFO - PROCESS | 1664 | Values: 90.0 87.0 86.0 86.0 86.0 87.0 88.0 89.0 89.0 93.0 22:48:26 INFO - PROCESS | 1664 | 22:48:26 INFO - PROCESS | 1664 | [#11] stanford-crypto-ccm Cycles:10 Average:149.20 Median:150.00 stddev:11.10 (7.4%) stddev-sans-first:11.62 22:48:26 INFO - PROCESS | 1664 | Values: 144.0 145.0 141.0 132.0 155.0 148.0 152.0 146.0 174.0 155.0 22:48:26 INFO - PROCESS | 1664 | 22:48:26 INFO - PROCESS | 1664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.90 Median:173.00 stddev:2.23 (1.3%) stddev-sans-first:2.37 22:48:26 INFO - PROCESS | 1664 | Values: 173.0 178.0 174.0 173.0 173.0 170.0 173.0 173.0 170.0 172.0 22:48:26 INFO - PROCESS | 1664 | 22:48:26 INFO - PROCESS | 1664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.50 stddev:1.40 (2.0%) stddev-sans-first:1.48 22:48:26 INFO - PROCESS | 1664 | Values: 69.0 70.0 70.0 70.0 69.0 69.0 66.0 70.0 67.0 68.0 22:48:26 INFO - PROCESS | 1664 | -------- Summary: end -------- 22:48:26 INFO - PROCESS | 1664 | 22:48:27 INFO - TEST-INFO | 1664: exit 0 22:48:27 INFO - TEST-OK | kraken | took 58997ms 22:48:27 INFO - SUITE-END | took 1178s 22:48:27 INFO - Completed test suite (00:19:38) 22:48:27 INFO - javascript benchmark 22:48:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2850.3871667591466, 3298.4062868683636, 3350.3466823969334, 3377.2232386551077, 3400.081977865976, 5574.60977731559, 5660.2358681578025, 5730.6275092118985, 5740.5120564752, 5749.453801888824, 4861.829835955742, 5672.943270567293, 5696.145578163278, 5798.7100644967795, 5822.825315240539, 5056.595472362221, 5136.409312929024, 5162.174052151657, 5193.0, 5213.739313034352, 5278.577713782907, 5290.0, 5308.867278318035, 5328.6269961102735, 5375.0, 5270.552003079704, 5273.34083239595, 5286.127788914863, 5327.307450031491, 5356.9732151339185, 5097.082525145473, 5167.09575824233, 5188.299579556787, 5193.844184674465, 5222.451642577551, 4924.409070911478, 4949.133901567211, 4989.126902791997, 5164.896702065976, 5271.762770675329, 5407.702576358299, 5419.241306217133, 5445.1832225166145, 5445.945540544583, 5521.889562208733, 5863.296404431453, 5875.383084776123, 5900.350961394243, 6090.543209259279, 6130.264368275791, 5761.88476230473, 6188.2883468400805, 6205.441510264052, 6208.720607572625, 6256.280527739277, 5847.239858818326, 5851.678157701367, 5857.531397488191, 5858.121281807677, 5894.823155305347, 6130.306415576139, 6211.81364559064, 6265.937340626627, 6293.685315734195, 6304.716287767062, 6011.609245399035, 6079.0, 6105.114758360013, 6115.663638499836, 6116.388361163937, 6195.101710251988, 6247.718852651642, 6252.249730032334, 6252.3122456529745, 6258.061290806324, 6040.516758659297, 6157.753689852356, 6168.9691551541955, 6180.072989051589, 6199.938000620026, 6062.302835174011, 6142.109394137914, 6262.467690246289, 6266.780662676784, 6272.0, 4829.420469543677, 4890.217565189552, 4894.143524883202, 4896.2410826321975, 4918.0, 4401.0, 4432.047109871393, 4469.307257375047, 4493.618042466362, 4496.5503449655425, 5735.684537350402, 5764.827055188351, 5812.244408226988, 5844.298684157843, 5851.356350801409, 6183.907241391383, 6184.165137706352, 6190.2571691397325, 6193.876122477525, 6199.721012554446, 5606.803761868397, 5648.6893220872425, 5768.3654797972185, 5783.421657834183, 5791.333996590446, 5361.731913404315, 5368.8657783554945, 5371.006363822706, 5373.865653358619, 5377.5429088527135, 6132.600268413531, 6152.538559607958, 6174.691265436711, 6178.5366097543765, 6189.04069869162, 6197.907031394442, 6202.937970620236, 6210.782622608187, 6212.378762123752, 6237.157983672328, 6262.780802671885, 6270.7805226816845, 6278.277998030102, 6288.245410550763, 6295.150154729236, 6070.3929607038945, 6112.541559382975, 6122.571420000735, 6183.628982261079, 6209.223847019122, 6096.405739310651, 6162.075688646739, 6163.075538669056, 6198.752049917953, 6234.127222188807, 6124.816255512342, 6125.356837532173, 6145.354737752472, 6150.985087460519, 6153.600015998945, 5014.297998280316, 6117.908231376622, 6151.984922487918, 6157.261128664589, 6160.353162918008, 5832.795852145325, 5893.970530147321, 5910.349861515316, 5929.436703513159, 5964.224650795369, 6103.580118178587, 6107.097787096225, 6118.314626315779, 6124.411449640054, 6154.0, 5939.851503712442, 5964.850878727893, 5979.521638268841, 6034.939650603614, 6068.908966365596], "value": 5664.519320753408, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [466.19115834027934, 472.91937921848563, 474.94325126593327, 501.0380070265091, 524.3445692883895, 30211.0, 39148.825535233955, 40331.0, 40406.59593404065, 42296.365554516706, 40541.391879121766, 40894.38658420119, 40951.795241023756, 41069.17861642766, 41128.38307425391, 9589.760255993586, 9749.0, 9761.219102471785, 9772.560234789451, 9779.0, 9546.427214367126, 9599.136077753, 9715.659951901685, 9718.902810971871, 9722.027797220257, 9611.134997850191, 9709.077637624414, 9739.51302434879, 9742.464164470952, 9752.951235243814, 9597.568109435093, 9603.519824008807, 9704.320697551175, 9708.66019689311, 9733.756656083584, 9507.762305942337, 9601.855972160423, 9606.087421694929, 9614.182794462478, 9625.614975400975, 39277.0, 39527.80236098801, 39560.60439395598, 39621.20757584861, 39679.20641587181, 2720.6327145835257, 3249.155219642886, 3252.869885204589, 3357.244619960514, 3720.8325625346924, 29636.0, 29787.70212297871, 30483.69516304853, 30787.076387708406, 30833.845830770926, 3100.674429184948, 3285.917852053718, 3293.440115180425, 3295.555100061485, 3324.6176689680756, 413858.0, 415694.0, 415849.7320214406, 416866.0, 419778.0, 56054.43945560574, 56150.15774763382, 56833.86332273414, 56965.14552281719, 56987.430125698214, 59756.80486390248, 59790.10314845281, 59953.70023149944, 59975.70012149911, 59978.70010650006, 15515.301811418512, 15734.9213253933, 15996.840031599768, 16002.279897404645, 16036.599085022968, 12426.875731242571, 12493.625191244277, 12504.874951250371, 12506.0, 12530.749385012248, 15846.366145354288, 16393.754093688603, 16409.261583228785, 16428.83571164297, 16470.6705865882, 5967.373425790316, 6023.518118550505, 6066.120412540157, 6069.15031895535, 6083.878322433527, 836.8744688296804, 952.7332346942728, 1014.5586669798661, 1038.8130136575337, 1054.7152268887357, 28988.855055724587, 29332.0, 29553.408931821672, 29802.97659815897, 29897.551536726965, 809.9473534220257, 1005.1807776661997, 1059.9629012984508, 1087.0, 1102.6251074634663, 14239.78640320396, 14667.559973200821, 15092.849071509365, 15541.0, 15601.84398156004, 605041.0, 611832.0, 612334.0, 613086.0, 613413.0, 48166.0, 54335.72832135814, 54734.17898731522, 54860.628484287416, 54926.45073549293, 1231.199720181871, 1318.821959035518, 1332.3538084029237, 1367.6580854786303, 1375.6698392385956, 30180.69819301779, 30624.846875765477, 30657.0, 31349.52975705412, 31485.0, 47595.524044759106, 48177.27734083922, 48213.276800847314, 48213.75893120512, 48224.27663584979, 485816.0, 488220.0, 697550.0, 712763.0, 717071.0, 24956.0, 25124.497510050063, 25136.12023579166, 25144.62283065719, 25205.99176032938, 44578.108437830415, 44987.55012449965, 45128.32307515324, 46367.304490432, 47397.763011184725, 31169.68830311668, 37556.81221593874, 37580.624193757714, 37933.05167370838, 38243.235135296585, 37400.153955352645, 37706.62293377031, 38155.28393983919, 39318.41022384609, 40145.79927100346, 37459.81270093632, 37500.812495937345, 37596.0, 38017.2396552073, 38066.857994260215, 27797.0, 32567.348653027282, 33962.981110566725, 34209.48685769765, 34276.65723342834, 24956.251312460656, 25244.116455923955, 25323.987040518172, 25637.743622563536, 25641.0], "value": 19331.369308979727, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.09741897536605, 370.4369358574966, 374.1656106881654, 380.64790069186006, 404.9210403971227, 14554.781678274821, 15307.081575105487, 17165.05592192432, 18533.0, 21314.786852131474, 19889.104990275435, 20647.587048259025, 20676.17295308186, 21383.35849924501, 21426.57146857066, 5902.026165682668, 6039.6980150992495, 6087.086936959469, 6111.480524155452, 6115.0521669141135, 4139.510217433331, 4271.231178387889, 4308.43990281263, 4474.798634061475, 6775.085363475917, 6764.695588698521, 6816.488763342769, 6818.0, 6822.010808432774, 6837.453003759687, 6507.089007538948, 6658.833529161737, 6708.597484150967, 6714.865702685967, 6718.428933540655, 5498.532624726903, 5743.138529220609, 5814.098814683731, 5817.767289308423, 5834.0, 25985.610215846777, 26082.0, 26145.08492202783, 26330.341741456425, 26484.0, 2044.9795502045088, 2223.12186686258, 2323.1984965186984, 2329.685492458513, 2364.621660534306, 10359.326643768207, 10648.041676249175, 10654.680359589147, 13530.797038044437, 14108.435662573485, 1730.3424698614572, 1746.9213885375189, 1880.1069491991332, 1953.5311525233983, 1975.07171629334, 53120.734396327774, 100858.0, 107247.46376268147, 108028.0, 110346.9999999992, 11000.449977501094, 11279.492422840993, 11295.887041129483, 11479.196456247982, 11606.187566870238, 14495.347709353104, 14607.19660418666, 14645.633859153606, 14665.633359166106, 14669.266536673123, 7844.705623572161, 8126.593670316461, 8463.830723385498, 8513.702020429255, 8522.57387130641, 7906.7627971160955, 8332.33341332692, 8362.498250105013, 8556.61495232716, 8558.78603034929, 4444.088961762831, 4549.340345649863, 4552.567506086916, 4608.493065762764, 4617.3304870793545, 1702.8931194723282, 1871.822176893193, 1912.741779859729, 1931.3433432632971, 1935.1485346447519, 728.7595093619093, 746.2798399544357, 845.4884794699242, 879.9252063574668, 892.3931726425963, 21085.472863178544, 21651.88614163304, 21745.456363591038, 21911.904404780016, 22008.44978875509, 922.718570835888, 928.8606708993705, 933.3979583168954, 970.6845275285419, 1012.9005243953526, 10203.693889183336, 11311.660650180507, 11339.0, 11485.138614603939, 11532.0, 454765.0, 464698.0, 532403.0, 537871.0, 538416.0, 101863.98136018692, 109297.0, 112597.0, 117763.41118294354, 122966.73057628048, 923.3905622289257, 944.7354740672623, 964.4647220792388, 967.1005964453126, 970.3595626886363, 18592.44222673322, 18927.526811829815, 18974.715379269597, 19014.23943042263, 19026.0, 50934.49065509297, 52180.217296741335, 52266.738666306424, 53123.73438132785, 53446.0, 70017.0, 70411.94382084375, 72445.13323001382, 74031.0, 76461.0, 7464.581729471383, 7508.587027713528, 7957.323627491496, 8115.715949941724, 8127.634256458592, 11701.590444334408, 12509.374531273583, 12542.24746515212, 12969.54606588765, 13079.346032698137, 9617.519124043909, 10654.13044881186, 10693.57225710994, 11033.117350612092, 11288.94355528217, 10472.842907356548, 10652.360858348524, 10931.508082136483, 11272.943635281772, 11316.547338106384, 8448.493090414595, 10933.781324373309, 11187.804573285019, 11382.260153090023, 11656.475458604553, 6905.516613837184, 7203.135623725187, 7276.599787011765, 8036.55798931041, 8233.423660343959, 10828.296160749525, 11200.10399168081, 11312.94343528277, 11337.03635191018, 11344.602938897098], "value": 9364.4023834829, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1521.31540806637, 1535.4165417141485, 1723.1987125986423, 1794.4437224460426, 1870.971935420969, 7995.440319177653, 9019.774505637362, 9086.454812711225, 9094.86357704635, 9097.0, 7931.9206807931905, 8134.349252059836, 8531.91468085319, 8769.429987050837, 8848.0, 2326.918557850471, 2358.433975845793, 2358.7523310052457, 2359.268626725712, 2359.551685179819, 2307.065638416444, 2342.7188737351544, 2343.496148328109, 2355.1756885090167, 2362.6692263083182, 2305.2738387407912, 2314.2941402872116, 2327.3948773318975, 2332.2070496031347, 2338.9415264618438, 2292.3008482412856, 2312.710911136108, 2315.108683156997, 2316.108298305148, 2320.5590937721777, 2269.7389800173028, 2282.6461898405773, 2291.4271432141963, 2299.1148407863093, 2308.4344335637707, 8931.821363572692, 8971.102889711043, 8989.865152022725, 9001.414908030956, 9011.053839346905, 5197.8440646780655, 5376.78492860289, 5380.596455265871, 5388.91916621251, 5405.243265942771, 3366.562346894888, 3448.81031543265, 3600.765950213228, 3610.981945090284, 3613.1509095362567, 931.3340961212698, 944.5702205496483, 945.4091193004373, 945.4469135555709, 954.0, 11893.821592676117, 11895.821562676567, 11908.88091119095, 11955.0, 11971.760564788743, 4505.234110201273, 4594.839180628662, 4689.7655117244, 4756.7145971241835, 4767.284907263869, 10067.848982265272, 10068.44623545712, 10079.395236285847, 10088.092071713434, 10100.646477373257, 5359.866003349947, 5362.329708786402, 5362.570994320445, 5366.812161574326, 5370.140777475585, 4317.848875289413, 4375.890602734957, 4874.293227481995, 4911.287863259808, 4922.163232250526, 3379.712724418403, 3835.463035175078, 3862.864799731996, 3919.6668283195677, 3978.025383780934, 1250.693580072888, 1252.3988485526997, 1255.0900597067052, 1270.231509936475, 1273.420593629896, 793.9404544659174, 803.2569872867574, 910.2899738204211, 948.990510094904, 951.7573018880141, 5669.489745922887, 5832.3292821326095, 6019.4883434908525, 6114.0, 6279.497640188774, 878.503645440337, 915.8626206069143, 918.3296193778579, 950.1923365139576, 961.1637875048752, 3769.6041915599017, 3899.512560929884, 3960.148568057824, 4034.7579145250793, 4046.5548789633117, 10149.035841595036, 10554.313969591953, 10739.785204296026, 10896.836547451636, 10951.0, 10720.517576709066, 10828.566857325619, 10842.241043126905, 10851.891481085087, 10896.509657065451, 8014.19858014194, 8187.590620468953, 8311.376646751518, 8323.292520135736, 8330.291925186306, 5631.352394474688, 5666.601785723079, 5763.4812866842185, 5766.4233576642, 5897.174395584708, 10067.647632332833, 10114.241431892491, 10134.695959121238, 10142.645007424704, 10144.0, 9639.277054220822, 10162.491875406347, 10197.84703229467, 10206.13247873939, 10375.0, 6985.231624521197, 7215.386692131227, 7248.927510725036, 7405.2224516425, 7536.849263014599, 8101.918980810116, 8375.41372103947, 8383.832323353621, 8457.57712114404, 8466.957665211881, 7333.266673332838, 7424.517406368569, 7444.292792184734, 7527.0, 7600.391968642385, 7254.310840470147, 7320.524165929198, 7385.150707668687, 7396.001539792059, 7544.245575442412, 6863.553868998499, 6994.825129371603, 7012.824679383056, 7015.789526314219, 7021.754238601625, 4910.134149023348, 4946.233333833262, 5047.798088076583, 5071.264666623393, 5121.206213036985, 4959.355283813081, 4970.179920313252, 5123.948760512347, 5170.6380553360905, 5261.289725886956], "value": 4575.196320894751, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.72526462492937, 292.5334092123063, 305.9892903748369, 306.5401897154268, 312.7076183768177, 4317.309230523117, 5019.272205530196, 5181.274621552986, 5231.8953620927605, 5294.761735721892, 4800.4719480857075, 4815.27770834375, 4921.311016457699, 5131.230315452684, 5177.378714554249, 3980.1840622672285, 3993.321135406973, 4002.3596224603925, 4018.6584140348104, 4052.898677533056, 3664.5236119304586, 3718.572364178127, 3972.8410863565423, 4036.697247706419, 4042.120414007486, 3512.63117372676, 3708.1841994761107, 3946.033221860648, 3967.504061992251, 3993.6006399359976, 3342.6462282775515, 3953.525576930787, 3954.584768599299, 3957.0, 3977.5823538528616, 3034.742046925992, 3310.8344582770765, 3346.0631023313267, 3405.6764607362506, 3436.6563343665434, 4306.031142992832, 4447.621952134073, 4669.696469729457, 4864.878378040542, 5156.845294641167, 4457.754823484707, 4486.753228572427, 4498.887527811831, 4541.81992643533, 4583.793729282157, 5070.797168113271, 5381.569474442074, 5452.972735136339, 5455.672659640434, 5463.31708536433, 3551.874765283733, 3657.7988210648405, 3663.029297236208, 3732.5894151643297, 3793.639604237593, 4690.467147740216, 5679.460451257124, 5686.687232202185, 5702.486776190121, 5714.228579141846, 3508.7543921907863, 3754.4743735877, 3770.6417890300377, 3770.962985179098, 3787.750042485973, 3830.3105441020884, 3852.1301630285616, 3853.7302388833073, 3871.8644847430205, 3873.6564378551134, 3376.729861611065, 3697.2420653766453, 4472.217361961643, 4484.730916145042, 4485.529019452975, 5434.03844904528, 5452.563794896399, 5452.837354334477, 5458.890822183614, 5473.808416705476, 1079.8110330692098, 1264.6594609713734, 1276.342683517989, 1286.8713128687057, 1287.3498883063992, 792.8533221354068, 868.4714901772799, 871.9782005449788, 898.7573355194061, 911.0889110889111, 4257.382679511516, 4702.412198475191, 4814.988852341047, 5000.924986125211, 5148.665336753099, 4413.801378937891, 5289.656172348785, 5627.352854421712, 5666.603337766317, 5673.886522269614, 5042.949570504248, 5102.005109003709, 5110.310108135354, 5116.744162791845, 5122.052420302256, 2415.9033638654255, 2430.225935067411, 2456.7297597264287, 2476.6656501372086, 2477.3773178568067, 4423.186493537699, 4722.645801564828, 4867.683600565952, 4870.659053866196, 4936.7044324389335, 4067.633912947849, 4509.797059132281, 4703.506131856174, 4717.716936983792, 4739.4075740532435, 4199.643030342455, 4207.980169518587, 4572.954270457253, 4748.738819364899, 4894.0, 3653.7625054372443, 3973.701972352143, 4224.634204845296, 4561.543845615412, 4597.081123198146, 4114.465119534441, 4214.1150358425075, 4482.551744825491, 4582.702124361906, 4621.0, 4137.834486620622, 4785.636093713275, 4814.518548145157, 4840.394950631171, 4855.975720121377, 2848.871800768929, 2919.4453053919688, 3257.039173443887, 3279.4916787897914, 3296.2748195396975, 4564.726116433025, 4717.952820471889, 5146.4338922717725, 5258.605604579749, 5679.34687510925, 4820.638452116035, 5265.920486300376, 5486.259354987025, 5498.945010549844, 5508.834734957958, 5501.587380946365, 5518.91721624184, 5522.088855338824, 5558.666480011212, 5565.276514053147, 4341.674374421994, 5342.599305052059, 5373.946260537501, 5435.864103397288, 5461.644993075437, 5245.97703447824, 5476.096444086681, 5479.4520547944885, 5501.724913754377, 5610.4670056344585, 5009.874753131201, 5185.714785686823, 5296.0, 5451.809186678447, 5547.140193270049], "value": 3814.874324627139, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.8057343943698, 752.5221484357431, 772.8222508822971, 793.7301317552033, 801.1187693537114, 14894.553163405088, 15394.461193858217, 15633.218339083043, 15706.0, 15965.92017039916, 14299.142051476892, 14548.563543093724, 14569.562913112624, 14575.198364089998, 14583.41666333348, 670.3296703296703, 689.6034780001494, 823.5882058970515, 849.8427790858711, 851.3742399336483, 626.28603392133, 691.2914262880537, 710.5274992130227, 853.2960307746134, 853.3983541603186, 898.4833720610642, 901.0808974845653, 901.6618767962015, 902.62992173209, 904.7376260884369, 704.7286794584071, 899.4108858697564, 899.5637115998735, 904.7828521154876, 904.7873749668822, 532.2229544864464, 640.6412409050946, 659.7097277198018, 662.0466528199378, 662.8939369700824, 14776.335064922105, 14841.0, 14860.405583776635, 14864.554063378007, 14875.0, 13321.866781332159, 13644.386002629906, 13731.45074197031, 13781.448742050306, 14027.859721402758, 10965.56137754489, 11498.942505287503, 11679.240849344766, 11680.707982300426, 11813.527458901634, 4535.614472769818, 4537.342085397599, 4543.795529201194, 4698.741569213692, 4759.809607615691, 100511.0, 102647.0, 102698.48650756698, 102772.48613756958, 102791.4860425693, 10278.22913281507, 10367.118794902517, 10723.892761072446, 10763.892361076445, 11038.227324087236, 19755.0, 19958.20167193296, 20008.89951052677, 20016.199352026048, 20047.0, 7483.513571617937, 7580.1661817200065, 7611.4291428142005, 7790.844183116306, 7848.725294614661, 4179.352200408942, 4262.062346283813, 4268.0823622921225, 4429.291313389842, 4432.490263619725, 3252.1381833814057, 3311.2549676323115, 3359.7816141950693, 3371.6459771723617, 3373.375925453799, 587.9706014699248, 594.390749481776, 604.5919004671916, 607.5898768331359, 614.6127939398151, 492.5419359995239, 544.4664229055547, 571.171800888713, 606.1937622961451, 646.2051676438008, 9029.36794424384, 9029.9316262367, 9274.21169200612, 9341.20599749029, 9509.809803804024, 588.6732863260931, 607.8480379905023, 647.7247169952846, 679.8606285711418, 688.3804575881646, 4174.749515029108, 4424.84513042042, 4574.81700731967, 4590.862274131781, 4634.606058485067, 96243.51878240563, 112304.43847780873, 114720.85279147101, 129657.0, 129798.35100824435, 121535.10021848552, 121888.78111218952, 123568.76431235572, 124465.37767311106, 125177.0, 66252.668736656, 66764.66470670559, 94645.0, 106199.0, 109668.4516577412, 9424.670136545188, 9507.334486586149, 9556.76108097303, 9588.472634005197, 9694.75763105928, 50834.745826270635, 58234.70882645559, 62076.0, 63268.0, 63640.68179659072, 56788.14817777654, 83315.5834220825, 84360.57819710863, 90925.0, 92424.53787731018, 12263.75472490563, 12742.299173545543, 12818.166819156724, 12997.0, 13467.32663366808, 14467.565973020826, 14539.563813085624, 14738.852611473749, 15027.474038408604, 15460.613484662974, 13184.406701698255, 13259.887846757138, 13916.025878188835, 13955.720885582028, 14139.43442262298, 13324.866751332751, 13451.327433628083, 13664.590062298146, 13736.65658358549, 14237.64405889861, 12700.618981430573, 13225.470981160646, 13436.798448023483, 13471.989600779785, 13647.38586763618, 10793.56825726962, 11230.94384528072, 11365.374904380338, 11656.708582285512, 11693.006094482063, 10506.744768368822, 11301.0, 11315.321080735182, 11505.252158609663, 11546.307221566733], "value": 7558.8619347808035, "unit": "score"}], "name": "dromaeo_css", "value": 7165.008252757808, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 112.0, 114.0, 113.0, 112.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 113.0, 130.0, 152.0, 114.0, 112.0, 113.0, 112.0, 145.0, 112.0], "value": 125.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 196.0, 252.0, 205.0, 184.0, 185.0, 179.0, 186.0, 181.0, 184.0], "value": 193.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 58.0, 89.0, 60.0, 60.0, 59.0, 58.0, 83.0, 57.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 71.0, 91.0, 72.0, 67.0, 69.0, 91.0, 67.0, 68.0, 90.0], "value": 76.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 91.0, 87.0, 90.0, 91.0, 91.0, 87.0, 90.0, 87.0], "value": 89.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 85.0, 85.0, 86.0, 85.0, 85.0, 85.0, 83.0, 83.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 55.0, 55.0, 56.0, 55.0, 53.0, 53.0, 55.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 70.0, 70.0, 76.0, 70.0, 70.0, 69.0, 71.0, 70.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 86.0, 86.0, 86.0, 87.0, 88.0, 89.0, 89.0, 93.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 145.0, 141.0, 132.0, 155.0, 148.0, 152.0, 146.0, 174.0, 155.0], "value": 149.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 178.0, 174.0, 173.0, 173.0, 170.0, 173.0, 173.0, 170.0, 172.0], "value": 172.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 70.0, 70.0, 69.0, 69.0, 66.0, 70.0, 67.0, 68.0], "value": 68.8, "unit": "score"}], "name": "kraken", "value": 1447.9, "alertThreshold": 2.0}]} 22:48:27 INFO - Return code: 0 22:48:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:48:27 INFO - # TBPL SUCCESS # 22:48:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:48:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:48:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:48:27 INFO - 2016-10-06 22:48:27.930 screenresolution[1668:9686] starting screenresolution argv=screenresolution get 22:48:27 INFO - 2016-10-06 22:48:27.933 screenresolution[1668:9686] Display 0: 1600x1200x32@60 22:48:27 INFO - 2016-10-06 22:48:27.939 screenresolution[1669:9689] starting screenresolution argv=screenresolution list 22:48:27 INFO - Available Modes on Display 0 22:48:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:48:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:48:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:48:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:48:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:48:28 INFO - Intel Iris: 22:48:28 INFO - Chipset Model: Intel Iris 22:48:28 INFO - Type: GPU 22:48:28 INFO - Bus: Built-In 22:48:28 INFO - VRAM (Dynamic, Max): 1536 MB 22:48:28 INFO - Vendor: Intel (0x8086) 22:48:28 INFO - Device ID: 0x0a2e 22:48:28 INFO - Revision ID: 0x0009 22:48:28 INFO - Displays: 22:48:28 INFO - Display: 22:48:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:48:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:48:28 INFO - Display Serial Number: 1600x1200 60 22:48:28 INFO - Main Display: Yes 22:48:28 INFO - Mirror: Off 22:48:28 INFO - Online: Yes 22:48:28 INFO - Rotation: Supported 22:48:28 INFO - Return code: 0 22:48:28 INFO - Running post-action listener: _resource_record_post_action 22:48:28 INFO - [mozharness: 2016-10-07 05:48:28.173578Z] Finished run-tests step (success) 22:48:28 INFO - Running post-run listener: _resource_record_post_run 22:48:28 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 38745088; Write bytes: 708054528; Read time: 379; Write time: 1791 22:48:28 INFO - TinderboxPrint: CPU usage
53.5% 22:48:28 INFO - TinderboxPrint: I/O read bytes / time
38,745,088 / 379 22:48:28 INFO - TinderboxPrint: I/O write bytes / time
708,054,528 / 1,791 22:48:28 INFO - TinderboxPrint: CPU idle
2,257.6 (46.5%) 22:48:28 INFO - TinderboxPrint: CPU system
968.6 (19.9%) 22:48:28 INFO - TinderboxPrint: CPU user
1,631.5 (33.6%) 22:48:28 INFO - TinderboxPrint: Swap in / out
446,369,792 / 0 22:48:28 INFO - install - Wall time: 36s; CPU: 54.0%; Read bytes: 392008192; Write bytes: 387037184; Read time: 30532; Write time: 687 22:48:28 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 37749760; Write bytes: 296666624; Read time: 363; Write time: 1058 22:48:28 INFO - Running post-run listener: _upload_blobber_files 22:48:28 INFO - Blob upload gear active. 22:48:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:48:28 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 22:48:28 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:48:28 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:48:29 INFO - (blobuploader) - INFO - Open directory for files ... 22:48:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:48:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:48:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:48:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:48:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:48:30 INFO - (blobuploader) - INFO - Done attempting. 22:48:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:48:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:48:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:48:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:48:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:48:31 INFO - (blobuploader) - INFO - Done attempting. 22:48:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:48:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:48:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:48:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:48:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:48:33 INFO - (blobuploader) - INFO - Done attempting. 22:48:33 INFO - (blobuploader) - INFO - Iteration through files over. 22:48:33 INFO - Return code: 0 22:48:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:48:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:48:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/223f884d5689f11b2e80d0d09c8d369bf37b163380e588d09043f0dfb405b54a5eb2105589f177150af8fcf96b4a9793871e46b02f4dc9c7dad65876bdd0826d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3621356e2c9b17633f04d6dc754af29c709dd3422a4121016fb8ec6debcf3136a03c5b28ca4a8de79574b6cef3bc52d0667b8999581b06d941e3d13d8bf4139e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f7862230e2a644c029fc236bf4409d2b39485e18cd4e71c6aad0be64216b7c402a104043ba2fd7a5169dd28aaa51d1b8febb110bcfebc864613ba39bb6330e30"} 22:48:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:48:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:48:33 INFO - Contents: 22:48:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/223f884d5689f11b2e80d0d09c8d369bf37b163380e588d09043f0dfb405b54a5eb2105589f177150af8fcf96b4a9793871e46b02f4dc9c7dad65876bdd0826d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3621356e2c9b17633f04d6dc754af29c709dd3422a4121016fb8ec6debcf3136a03c5b28ca4a8de79574b6cef3bc52d0667b8999581b06d941e3d13d8bf4139e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f7862230e2a644c029fc236bf4409d2b39485e18cd4e71c6aad0be64216b7c402a104043ba2fd7a5169dd28aaa51d1b8febb110bcfebc864613ba39bb6330e30"} 22:48:33 INFO - Running post-run listener: copy_logs_to_upload_dir 22:48:33 INFO - Copying logs to upload dir... 22:48:33 INFO - mkdir: /builds/slave/test/build/upload/logs 22:48:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.396893 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-06 22:48:33.611929) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 22:48:33.615718) ========= 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.tvzFx0ZVL3/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.XYd09ed117/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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/Fx-Team/sha512/223f884d5689f11b2e80d0d09c8d369bf37b163380e588d09043f0dfb405b54a5eb2105589f177150af8fcf96b4a9793871e46b02f4dc9c7dad65876bdd0826d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3621356e2c9b17633f04d6dc754af29c709dd3422a4121016fb8ec6debcf3136a03c5b28ca4a8de79574b6cef3bc52d0667b8999581b06d941e3d13d8bf4139e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f7862230e2a644c029fc236bf4409d2b39485e18cd4e71c6aad0be64216b7c402a104043ba2fd7a5169dd28aaa51d1b8febb110bcfebc864613ba39bb6330e30"} build_url:https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011080 build_url: 'https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/223f884d5689f11b2e80d0d09c8d369bf37b163380e588d09043f0dfb405b54a5eb2105589f177150af8fcf96b4a9793871e46b02f4dc9c7dad65876bdd0826d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3621356e2c9b17633f04d6dc754af29c709dd3422a4121016fb8ec6debcf3136a03c5b28ca4a8de79574b6cef3bc52d0667b8999581b06d941e3d13d8bf4139e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f7862230e2a644c029fc236bf4409d2b39485e18cd4e71c6aad0be64216b7c402a104043ba2fd7a5169dd28aaa51d1b8febb110bcfebc864613ba39bb6330e30"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 22:48:33.649156) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 22:48:33.649549) ========= 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.tvzFx0ZVL3/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.XYd09ed117/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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.005077 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 22:48:33.698530) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 22:48:33.698886) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 22:48:33.699269) ========= ========= Total master_lag: 0.27 =========