builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0139 starttime: 1480582737.75 results: success (0) buildid: 20161130233044 builduid: b41c85fe5e0940bc946892bfdb846613 revision: 95098568797bbcd89a19e17f4d444acab7aec4d8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-01 00:58:57.746078) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-01 00:58:57.746513) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-01 00:58:57.746815) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-01 00:58:57.772336) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 00:58:57.772800) ========= 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.w36iOoTGmQ/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.orks0XGmwa/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-01 00:58:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.89M=0.001s 2016-12-01 00:58:57 (7.89 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125451 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 00:58:57.922135) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 00:58:57.922445) ========= 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.w36iOoTGmQ/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.orks0XGmwa/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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.019253 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 00:58:57.971924) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-01 00:58:57.972269) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 95098568797bbcd89a19e17f4d444acab7aec4d8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 95098568797bbcd89a19e17f4d444acab7aec4d8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.w36iOoTGmQ/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.orks0XGmwa/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-01 00:58:58,046 truncating revision to first 12 chars 2016-12-01 00:58:58,046 Setting DEBUG logging. 2016-12-01 00:58:58,046 attempt 1/10 2016-12-01 00:58:58,046 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/95098568797b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-01 00:58:59,788 unpacking tar archive at: graphics-95098568797b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.993910 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-01 00:58:59.990717) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-01 00:58:59.991071) ========= script_repo_revision: 95098568797bbcd89a19e17f4d444acab7aec4d8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-01 00:58:59.991656) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-01 00:58:59.992115) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-01 00:59:00.013864) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-12-01 00:59:00.014364) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Graphics', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.w36iOoTGmQ/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.orks0XGmwa/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 00:59:00 INFO - MultiFileLogger online at 20161201 00:59:00 in /builds/slave/test 00:59:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 00:59:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:59:00 INFO - {'append_to_log': False, 00:59:00 INFO - 'base_work_dir': '/builds/slave/test', 00:59:00 INFO - 'blob_upload_branch': 'Graphics', 00:59:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:59:00 INFO - 'branch': 'Graphics', 00:59:00 INFO - 'buildbot_json_path': 'buildprops.json', 00:59:00 INFO - 'config_files': ('talos/mac_config.py',), 00:59:00 INFO - 'default_actions': ('clobber', 00:59:00 INFO - 'read-buildbot-config', 00:59:00 INFO - 'download-and-extract', 00:59:00 INFO - 'populate-webroot', 00:59:00 INFO - 'create-virtualenv', 00:59:00 INFO - 'install', 00:59:00 INFO - 'run-tests'), 00:59:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:59:00 INFO - 'download_minidump_stackwalk': True, 00:59:00 INFO - 'download_symbols': 'ondemand', 00:59:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:59:00 INFO - 'tooltool.py': '/tools/tooltool.py', 00:59:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:59:00 INFO - '/tools/misc-python/virtualenv.py')}, 00:59:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:59:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:59:00 INFO - 'installer_path': 'installer.exe', 00:59:00 INFO - 'log_level': 'info', 00:59:00 INFO - 'log_name': 'talos', 00:59:00 INFO - 'log_to_console': True, 00:59:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:59:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:59:00 INFO - 'opt_config_files': (), 00:59:00 INFO - 'pip_index': False, 00:59:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:59:00 INFO - 'cmd': ('bash', 00:59:00 INFO - '-c', 00:59:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:59:00 INFO - 'enabled': True, 00:59:00 INFO - 'halt_on_failure': False, 00:59:00 INFO - 'name': 'check_screen_resolution'},), 00:59:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:59:00 INFO - 'cmd': ('bash', 00:59:00 INFO - '-c', 00:59:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:59:00 INFO - 'enabled': True, 00:59:00 INFO - 'halt_on_failure': False, 00:59:00 INFO - 'name': 'check_screen_resolution'},), 00:59:00 INFO - 'run_cmd_checks_enabled': True, 00:59:00 INFO - 'sps_profile': False, 00:59:00 INFO - 'sps_profile_interval': 0, 00:59:00 INFO - 'suite': 'dromaeojs', 00:59:00 INFO - 'system_bits': '32', 00:59:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:59:00 INFO - 'title': 't-yosemite-r7-0139', 00:59:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:59:00 INFO - 'use_talos_json': True, 00:59:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:59:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:59:00 INFO - 'work_dir': 'build'} 00:59:00 INFO - [mozharness: 2016-12-01 08:59:00.213815Z] Running clobber step. 00:59:00 INFO - Running pre-action listener: _resource_record_pre_action 00:59:00 INFO - Running main action method: clobber 00:59:00 INFO - rmtree: /builds/slave/test/build 00:59:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:59:01 INFO - Running post-action listener: _resource_record_post_action 00:59:01 INFO - [mozharness: 2016-12-01 08:59:01.771673Z] Finished clobber step (success) 00:59:01 INFO - [mozharness: 2016-12-01 08:59:01.771858Z] Running read-buildbot-config step. 00:59:01 INFO - Running pre-action listener: _resource_record_pre_action 00:59:01 INFO - Running main action method: read_buildbot_config 00:59:01 INFO - Using buildbot properties: 00:59:01 INFO - { 00:59:01 INFO - "project": "", 00:59:01 INFO - "product": "firefox", 00:59:01 INFO - "script_repo_revision": "default", 00:59:01 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 00:59:01 INFO - "repository": "", 00:59:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 00:59:01 INFO - "buildid": "20161130233044", 00:59:01 INFO - "pgo_build": "False", 00:59:01 INFO - "basedir": "/builds/slave/test", 00:59:01 INFO - "buildnumber": 3, 00:59:01 INFO - "slavename": "t-yosemite-r7-0139", 00:59:01 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 00:59:01 INFO - "platform": "yosemite_r7", 00:59:01 INFO - "scheduler": "tests-graphics-macosx64-talos", 00:59:01 INFO - "branch": "graphics", 00:59:01 INFO - "repo_path": "projects/graphics", 00:59:01 INFO - "revision": "95098568797bbcd89a19e17f4d444acab7aec4d8", 00:59:01 INFO - "stage_platform": "macosx64", 00:59:01 INFO - "builduid": "b41c85fe5e0940bc946892bfdb846613", 00:59:01 INFO - "slavebuilddir": "test" 00:59:01 INFO - } 00:59:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/JdR8dXiZR42XAcH5GCQhNw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 00:59:01 INFO - Running post-action listener: _resource_record_post_action 00:59:01 INFO - [mozharness: 2016-12-01 08:59:01.777374Z] Finished read-buildbot-config step (success) 00:59:01 INFO - [mozharness: 2016-12-01 08:59:01.777535Z] Running download-and-extract step. 00:59:01 INFO - Running pre-action listener: _resource_record_pre_action 00:59:01 INFO - Running main action method: download_and_extract 00:59:01 INFO - mkdir: /builds/slave/test/build/tests 00:59: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')]} 00:59:01 INFO - trying https://queue.taskcluster.net/v1/task/JdR8dXiZR42XAcH5GCQhNw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 00:59:01 INFO - Downloading https://queue.taskcluster.net/v1/task/JdR8dXiZR42XAcH5GCQhNw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 00:59:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JdR8dXiZR42XAcH5GCQhNw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 00:59:02 INFO - Downloaded 1199 bytes. 00:59:02 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 00:59:02 INFO - Using the following test package requirements: 00:59:02 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 00:59:02 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 00:59:02 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 00:59:02 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 00:59:02 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 00:59:02 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 00:59:02 INFO - u'jsshell-mac.zip'], 00:59:02 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 00:59:02 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 00:59:02 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 00:59:02 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 00:59:02 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 00:59:02 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 00:59:02 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 00:59:02 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 00:59:02 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 00:59:02 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 00:59:02 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 00:59:02 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 00:59:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JdR8dXiZR42XAcH5GCQhNw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 00:59:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JdR8dXiZR42XAcH5GCQhNw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 00:59:02 INFO - Fetch https://queue.taskcluster.net/v1/task/JdR8dXiZR42XAcH5GCQhNw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 00:59:03 INFO - Http code: 200 00:59:03 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 00:59:03 INFO - x-amz-cf-id: fJEgcJ_XT9R_xNbsVyNjPkhayJE5Uw1BdNLT8QUiZbcOB7joVhyKbA== 00:59:03 INFO - x-amz-version-id: KVVcbLQEp8lGxOY1K37aipLIOhlaLhhL 00:59:03 INFO - Expected file size: 16282545 00:59:03 INFO - Obtained file size: 16282545 00:59:10 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 00:59:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JdR8dXiZR42XAcH5GCQhNw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 00:59:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JdR8dXiZR42XAcH5GCQhNw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 00:59:10 INFO - Fetch https://queue.taskcluster.net/v1/task/JdR8dXiZR42XAcH5GCQhNw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 00:59:11 INFO - Http code: 200 00:59:11 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 00:59:11 INFO - x-amz-cf-id: g87U5_4Bb7XrtfhdpFvHDy2QpeIB_9K2Dci7-JffoLIJbihsBajcVw== 00:59:11 INFO - x-amz-version-id: KVVcbLQEp8lGxOY1K37aipLIOhlaLhhL 00:59:11 INFO - Expected file size: 16282545 00:59:11 INFO - Obtained file size: 16282545 00:59:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JdR8dXiZR42XAcH5GCQhNw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 00:59:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JdR8dXiZR42XAcH5GCQhNw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 00:59:17 INFO - Fetch https://queue.taskcluster.net/v1/task/JdR8dXiZR42XAcH5GCQhNw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 00:59:18 INFO - Http code: 200 00:59:18 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 00:59:18 INFO - x-amz-cf-id: bxm9MtWYFHMLSe0Cg2lZd8xYyizFj2LhR68r4xGjPhvvwyaT0CYBhw== 00:59:18 INFO - x-amz-version-id: 6gIick9jhTCw7ZnW.ka_Z8nI.Oq.Nnke 00:59:18 INFO - Expected file size: 14409702 00:59:18 INFO - Obtained file size: 14409702 00:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:59:18 INFO - trying https://queue.taskcluster.net/v1/task/JdR8dXiZR42XAcH5GCQhNw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 00:59:18 INFO - Downloading https://queue.taskcluster.net/v1/task/JdR8dXiZR42XAcH5GCQhNw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 00:59:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JdR8dXiZR42XAcH5GCQhNw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 00:59:22 INFO - Downloaded 107603766 bytes. 00:59:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JdR8dXiZR42XAcH5GCQhNw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 00:59:22 INFO - mkdir: /builds/slave/test/properties 00:59:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:59:22 INFO - Writing to file /builds/slave/test/properties/build_url 00:59:22 INFO - Contents: 00:59:22 INFO - build_url:https://queue.taskcluster.net/v1/task/JdR8dXiZR42XAcH5GCQhNw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 00:59:22 INFO - Running post-action listener: _resource_record_post_action 00:59:22 INFO - Running post-action listener: set_extra_try_arguments 00:59:22 INFO - [mozharness: 2016-12-01 08:59:22.692438Z] Finished download-and-extract step (success) 00:59:22 INFO - [mozharness: 2016-12-01 08:59:22.692557Z] Running populate-webroot step. 00:59:22 INFO - Running pre-action listener: _resource_record_pre_action 00:59:22 INFO - Running main action method: populate_webroot 00:59:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:59:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:59:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:59:22 INFO - '--tppagecycles', 00:59:22 INFO - '7'], 00:59:22 INFO - 'tests': ['tsvgm']}}, 00:59:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:59:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:59:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:59:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:59:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:59:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:59:22 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 00:59:22 INFO - 'talos_options': ['--disable-e10s'], 00:59:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:59:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 00:59:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:59:22 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 00:59:22 INFO - 'talos_options': ['--disable-e10s'], 00:59:22 INFO - 'tests': ['damp', 'tps']}, 00:59:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 00:59:22 INFO - 'tests': ['damp', 'tps']}, 00:59:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:59:22 INFO - 'tests': ['dromaeo_dom']}, 00:59:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:59:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:59:22 INFO - 'tests': ['basic_compositor_video']}, 00:59:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:59:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:59:22 INFO - 'tests': ['a11yr', 00:59:22 INFO - 'ts_paint', 00:59:22 INFO - 'tpaint', 00:59:22 INFO - 'sessionrestore', 00:59:22 INFO - 'sessionrestore_no_auto_restore', 00:59:22 INFO - 'tabpaint']}, 00:59:22 INFO - 'other-e10s': {'tests': ['a11yr', 00:59:22 INFO - 'ts_paint', 00:59:22 INFO - 'tpaint', 00:59:22 INFO - 'sessionrestore', 00:59:22 INFO - 'sessionrestore_no_auto_restore', 00:59:22 INFO - 'tabpaint']}, 00:59:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:59:22 INFO - 'ts_paint', 00:59:22 INFO - 'tpaint', 00:59:22 INFO - 'sessionrestore', 00:59:22 INFO - 'sessionrestore_no_auto_restore', 00:59:22 INFO - 'tabpaint']}, 00:59:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:59:22 INFO - 'ts_paint', 00:59:22 INFO - 'tpaint', 00:59:22 INFO - 'sessionrestore', 00:59:22 INFO - 'sessionrestore_no_auto_restore', 00:59:22 INFO - 'tabpaint']}, 00:59:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:59:22 INFO - 'tests': ['a11yr', 00:59:22 INFO - 'ts_paint', 00:59:22 INFO - 'tpaint', 00:59:22 INFO - 'sessionrestore', 00:59:22 INFO - 'sessionrestore_no_auto_restore', 00:59:22 INFO - 'tabpaint']}, 00:59:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:59:22 INFO - 'tests': ['a11yr', 00:59:22 INFO - 'ts_paint', 00:59:22 INFO - 'tpaint', 00:59:22 INFO - 'sessionrestore', 00:59:22 INFO - 'sessionrestore_no_auto_restore', 00:59:22 INFO - 'tabpaint']}, 00:59:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:59:22 INFO - 'tests': ['tsvgx', 00:59:22 INFO - 'tsvgr_opacity', 00:59:22 INFO - 'tart', 00:59:22 INFO - 'tscrollx', 00:59:22 INFO - 'cart', 00:59:22 INFO - 'tsvg_static']}, 00:59:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:59:22 INFO - 'tsvgr_opacity', 00:59:22 INFO - 'tart', 00:59:22 INFO - 'tscrollx', 00:59:22 INFO - 'cart', 00:59:22 INFO - 'tsvg_static']}, 00:59:22 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 00:59:22 INFO - 'talos_options': ['--disable-e10s'], 00:59:22 INFO - 'tests': ['tp5o']}, 00:59:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 00:59:22 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 00:59:22 INFO - 'talos_options': ['--disable-e10s', 00:59:22 INFO - '--xperf_path', 00:59:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:59:22 INFO - 'tests': ['tp5n']}, 00:59:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 00:59:22 INFO - 'talos_options': ['--xperf_path', 00:59:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:59:22 INFO - 'tests': ['tp5n']}}, 00:59:22 INFO - 'talos.zip': {'path': '', 00:59:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:59:22 INFO - Running post-action listener: _resource_record_post_action 00:59:22 INFO - [mozharness: 2016-12-01 08:59:22.710562Z] Finished populate-webroot step (success) 00:59:22 INFO - [mozharness: 2016-12-01 08:59:22.710686Z] Running create-virtualenv step. 00:59:22 INFO - Running pre-action listener: _resource_record_pre_action 00:59:22 INFO - Running main action method: create_virtualenv 00:59:22 INFO - Creating virtualenv /builds/slave/test/build/venv 00:59:22 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 00:59:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:59:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:59:22 INFO - Using real prefix '/tools/python27' 00:59:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:59:23 INFO - Installing distribute.............................................................................................................................................................................................done. 00:59:26 INFO - Installing pip.................done. 00:59:26 INFO - Return code: 0 00:59:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:59:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:59:26 INFO - Reading from file tmpfile_stdout 00:59:26 INFO - Output received: 00:59:26 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) 00:59:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:59:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:26 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 0x10a15e3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1a347cee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f74d30>, '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 0x109ddbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f6cb20>, '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.w36iOoTGmQ/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.orks0XGmwa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 00:59:26 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 00:59:26 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 00:59:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w36iOoTGmQ/Render', 00:59:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:59:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:59:26 INFO - 'HOME': '/Users/cltbld', 00:59:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:59:26 INFO - 'LOGNAME': 'cltbld', 00:59:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:26 INFO - 'MOZ_NO_REMOTE': '1', 00:59:26 INFO - 'NO_EM_RESTART': '1', 00:59:26 INFO - 'PAGER': '/bin/cat', 00:59:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:59:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:26 INFO - 'PWD': '/builds/slave/test', 00:59:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:59:26 INFO - 'SHELL': '/bin/bash', 00:59:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.orks0XGmwa/Listeners', 00:59:26 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 00:59:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:59:26 INFO - 'USER': 'cltbld', 00:59:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:59:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:59:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:26 INFO - 'XPC_FLAGS': '0x0', 00:59:26 INFO - 'XPC_SERVICE_NAME': '0', 00:59:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:59:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:26 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 00:59:26 INFO - Cleaning up... 00:59:26 INFO - Return code: 0 00:59:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:59:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:26 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 0x10a15e3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1a347cee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f74d30>, '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 0x109ddbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f6cb20>, '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.w36iOoTGmQ/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.orks0XGmwa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 00:59:26 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 00:59:26 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 00:59:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w36iOoTGmQ/Render', 00:59:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:59:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:59:26 INFO - 'HOME': '/Users/cltbld', 00:59:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:59:26 INFO - 'LOGNAME': 'cltbld', 00:59:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:26 INFO - 'MOZ_NO_REMOTE': '1', 00:59:26 INFO - 'NO_EM_RESTART': '1', 00:59:26 INFO - 'PAGER': '/bin/cat', 00:59:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:59:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:26 INFO - 'PWD': '/builds/slave/test', 00:59:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:59:26 INFO - 'SHELL': '/bin/bash', 00:59:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.orks0XGmwa/Listeners', 00:59:26 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 00:59:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:59:26 INFO - 'USER': 'cltbld', 00:59:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:59:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:59:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:26 INFO - 'XPC_FLAGS': '0x0', 00:59:26 INFO - 'XPC_SERVICE_NAME': '0', 00:59:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:59:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:27 INFO - Downloading/unpacking psutil>=3.1.1 00:59:27 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 00:59:27 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 00:59:27 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 00:59:27 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 00:59:27 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 00:59:27 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 00:59:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:59:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:59:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:59:30 INFO - Installing collected packages: psutil 00:59:30 INFO - Running setup.py install for psutil 00:59:30 INFO - building 'psutil._psutil_osx' extension 00:59:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 00:59:31 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 00:59:31 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 00:59:31 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 00:59:31 INFO - building 'psutil._psutil_posix' extension 00:59:31 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 00:59:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:59:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:59:31 INFO - ^ 00:59:31 INFO - 1 warning generated. 00:59:31 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 00:59:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:59:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:59:31 INFO - Successfully installed psutil 00:59:31 INFO - Cleaning up... 00:59:31 INFO - Return code: 0 00:59:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:59:31 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')]} 00:59:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:31 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')]} 00:59:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:31 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 0x10a15e3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1a347cee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f74d30>, '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 0x109ddbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f6cb20>, '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.w36iOoTGmQ/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.orks0XGmwa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 00:59:31 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 00:59:31 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 00:59:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w36iOoTGmQ/Render', 00:59:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:59:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:59:31 INFO - 'HOME': '/Users/cltbld', 00:59:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:59:31 INFO - 'LOGNAME': 'cltbld', 00:59:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:31 INFO - 'MOZ_NO_REMOTE': '1', 00:59:31 INFO - 'NO_EM_RESTART': '1', 00:59:31 INFO - 'PAGER': '/bin/cat', 00:59:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:59:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:31 INFO - 'PWD': '/builds/slave/test', 00:59:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:59:31 INFO - 'SHELL': '/bin/bash', 00:59:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.orks0XGmwa/Listeners', 00:59:31 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 00:59:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:59:31 INFO - 'USER': 'cltbld', 00:59:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:59:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:59:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:31 INFO - 'XPC_FLAGS': '0x0', 00:59:31 INFO - 'XPC_SERVICE_NAME': '0', 00:59:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:59:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:59:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:59:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:59:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:59:34 INFO - Installing collected packages: mozsystemmonitor 00:59:34 INFO - Running setup.py install for mozsystemmonitor 00:59:34 INFO - Successfully installed mozsystemmonitor 00:59:34 INFO - Cleaning up... 00:59:34 INFO - Return code: 0 00:59:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:59:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a15e3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1a347cee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f74d30>, '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 0x109ddbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f6cb20>, '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.w36iOoTGmQ/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.orks0XGmwa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 00:59:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 00:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 00:59:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w36iOoTGmQ/Render', 00:59:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:59:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:59:34 INFO - 'HOME': '/Users/cltbld', 00:59:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:59:34 INFO - 'LOGNAME': 'cltbld', 00:59:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:34 INFO - 'MOZ_NO_REMOTE': '1', 00:59:34 INFO - 'NO_EM_RESTART': '1', 00:59:34 INFO - 'PAGER': '/bin/cat', 00:59:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:59:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:34 INFO - 'PWD': '/builds/slave/test', 00:59:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:59:34 INFO - 'SHELL': '/bin/bash', 00:59:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.orks0XGmwa/Listeners', 00:59:34 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 00:59:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:59:34 INFO - 'USER': 'cltbld', 00:59:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:59:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:59:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:34 INFO - 'XPC_FLAGS': '0x0', 00:59:34 INFO - 'XPC_SERVICE_NAME': '0', 00:59:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:59:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:35 INFO - Downloading/unpacking jsonschema==2.5.1 00:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:59:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:59:37 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 00:59:37 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 00:59:37 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 00:59:37 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 00:59:37 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 00:59:37 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 00:59:37 INFO - Downloading functools32-3.2.3-2.tar.gz 00:59:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:59:38 INFO - warning: no files found matching '*.txt' 00:59:38 INFO - no previously-included directories found matching 'build' 00:59:38 INFO - no previously-included directories found matching 'dist' 00:59:38 INFO - no previously-included directories found matching '.git*' 00:59:38 INFO - Installing collected packages: jsonschema, functools32 00:59:38 INFO - Running setup.py install for functools32 00:59:38 INFO - warning: no files found matching '*.txt' 00:59:38 INFO - no previously-included directories found matching 'build' 00:59:38 INFO - no previously-included directories found matching 'dist' 00:59:38 INFO - no previously-included directories found matching '.git*' 00:59:38 INFO - Successfully installed jsonschema functools32 00:59:38 INFO - Cleaning up... 00:59:38 INFO - Return code: 0 00:59:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:59:38 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')]} 00:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:38 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')]} 00:59:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:38 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 0x10a15e3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1a347cee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f74d30>, '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 0x109ddbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f6cb20>, '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.w36iOoTGmQ/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.orks0XGmwa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 00:59:38 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 00:59:38 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 00:59:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w36iOoTGmQ/Render', 00:59:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:59:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:59:38 INFO - 'HOME': '/Users/cltbld', 00:59:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:59:38 INFO - 'LOGNAME': 'cltbld', 00:59:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:38 INFO - 'MOZ_NO_REMOTE': '1', 00:59:38 INFO - 'NO_EM_RESTART': '1', 00:59:38 INFO - 'PAGER': '/bin/cat', 00:59:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:59:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:38 INFO - 'PWD': '/builds/slave/test', 00:59:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:59:38 INFO - 'SHELL': '/bin/bash', 00:59:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.orks0XGmwa/Listeners', 00:59:38 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 00:59:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:59:38 INFO - 'USER': 'cltbld', 00:59:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:59:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:59:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:38 INFO - 'XPC_FLAGS': '0x0', 00:59:38 INFO - 'XPC_SERVICE_NAME': '0', 00:59:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:59:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:59:38 INFO - Cleaning up... 00:59:38 INFO - Return code: 0 00:59:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:59:38 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')]} 00:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:38 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')]} 00:59:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:38 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 0x10a15e3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1a347cee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f74d30>, '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 0x109ddbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f6cb20>, '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.w36iOoTGmQ/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.orks0XGmwa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 00:59:38 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 00:59:38 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 00:59:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w36iOoTGmQ/Render', 00:59:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:59:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:59:38 INFO - 'HOME': '/Users/cltbld', 00:59:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:59:38 INFO - 'LOGNAME': 'cltbld', 00:59:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:38 INFO - 'MOZ_NO_REMOTE': '1', 00:59:38 INFO - 'NO_EM_RESTART': '1', 00:59:38 INFO - 'PAGER': '/bin/cat', 00:59:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:59:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:38 INFO - 'PWD': '/builds/slave/test', 00:59:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:59:38 INFO - 'SHELL': '/bin/bash', 00:59:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.orks0XGmwa/Listeners', 00:59:38 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 00:59:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:59:38 INFO - 'USER': 'cltbld', 00:59:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:59:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:59:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:38 INFO - 'XPC_FLAGS': '0x0', 00:59:38 INFO - 'XPC_SERVICE_NAME': '0', 00:59:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:59:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:38 INFO - Downloading/unpacking blobuploader==1.2.4 00:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:41 INFO - Downloading blobuploader-1.2.4.tar.gz 00:59:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:59:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:59:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:59:42 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 00:59:42 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 00:59:42 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 00:59:42 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 00:59:42 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 00:59:42 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 00:59:42 INFO - Downloading docopt-0.6.1.tar.gz 00:59:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:59:42 INFO - Installing collected packages: blobuploader, requests, docopt 00:59:42 INFO - Running setup.py install for blobuploader 00:59:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:59:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:59:42 INFO - Running setup.py install for requests 00:59:43 INFO - Running setup.py install for docopt 00:59:43 INFO - Successfully installed blobuploader requests docopt 00:59:43 INFO - Cleaning up... 00:59:43 INFO - Return code: 0 00:59:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:59:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a15e3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1a347cee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f74d30>, '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 0x109ddbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f6cb20>, '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.w36iOoTGmQ/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.orks0XGmwa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 00:59:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 00:59:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:59:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w36iOoTGmQ/Render', 00:59:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:59:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:59:43 INFO - 'HOME': '/Users/cltbld', 00:59:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:59:43 INFO - 'LOGNAME': 'cltbld', 00:59:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:43 INFO - 'MOZ_NO_REMOTE': '1', 00:59:43 INFO - 'NO_EM_RESTART': '1', 00:59:43 INFO - 'PAGER': '/bin/cat', 00:59:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:59:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:43 INFO - 'PWD': '/builds/slave/test', 00:59:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:59:43 INFO - 'SHELL': '/bin/bash', 00:59:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.orks0XGmwa/Listeners', 00:59:43 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 00:59:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:59:43 INFO - 'USER': 'cltbld', 00:59:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:59:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:59:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:43 INFO - 'XPC_FLAGS': '0x0', 00:59:43 INFO - 'XPC_SERVICE_NAME': '0', 00:59:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:59:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:59:43 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-DsFfng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:59:43 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-7zt_xY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:59:44 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-RW54i1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:59:44 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-6Rg4VC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:59:44 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-YRDSSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:59:44 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-E8Ec5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:59:44 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-bsVlex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:59:44 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-NzFU1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:59:44 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-dG2JnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:59:44 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-Tguo7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:59:44 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-FvA2LH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:59:45 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-EX6TX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:59:45 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-CvEE8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:59:45 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-hhMzCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:59:45 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-zdama1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:59:45 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-ItrXdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:59:45 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-9KO5Kr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:59:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:59:45 INFO - Running setup.py install for manifestparser 00:59:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:59:45 INFO - Running setup.py install for mozcrash 00:59:45 INFO - Running setup.py install for mozdebug 00:59:46 INFO - Running setup.py install for mozdevice 00:59:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:59:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:59:46 INFO - Running setup.py install for mozfile 00:59:46 INFO - Running setup.py install for mozhttpd 00:59:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:59:46 INFO - Running setup.py install for mozinfo 00:59:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:59:46 INFO - Running setup.py install for mozInstall 00:59:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:59:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:59:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:59:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:59:46 INFO - Running setup.py install for mozleak 00:59:46 INFO - Running setup.py install for mozlog 00:59:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:59:47 INFO - Running setup.py install for moznetwork 00:59:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:59:47 INFO - Running setup.py install for mozprocess 00:59:47 INFO - Running setup.py install for mozprofile 00:59:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:59:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:59:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:59:47 INFO - Running setup.py install for mozrunner 00:59:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:59:47 INFO - Running setup.py install for mozscreenshot 00:59:47 INFO - Running setup.py install for moztest 00:59:48 INFO - Running setup.py install for mozversion 00:59:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:59:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:59:48 INFO - Cleaning up... 00:59:48 INFO - Return code: 0 00:59:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a15e3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1a347cee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f74d30>, '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 0x109ddbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f6cb20>, '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.w36iOoTGmQ/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.orks0XGmwa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 00:59:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 00:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:59:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w36iOoTGmQ/Render', 00:59:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:59:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:59:48 INFO - 'HOME': '/Users/cltbld', 00:59:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:59:48 INFO - 'LOGNAME': 'cltbld', 00:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:48 INFO - 'MOZ_NO_REMOTE': '1', 00:59:48 INFO - 'NO_EM_RESTART': '1', 00:59:48 INFO - 'PAGER': '/bin/cat', 00:59:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:48 INFO - 'PWD': '/builds/slave/test', 00:59:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:59:48 INFO - 'SHELL': '/bin/bash', 00:59:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.orks0XGmwa/Listeners', 00:59:48 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 00:59:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:59:48 INFO - 'USER': 'cltbld', 00:59:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:59:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:48 INFO - 'XPC_FLAGS': '0x0', 00:59:48 INFO - 'XPC_SERVICE_NAME': '0', 00:59:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:59:48 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-GiGdEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:59:48 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)) 00:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:59:48 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-7XftB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:59:48 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-83xyVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:59:48 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)) 00:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:59:48 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-PfJBvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 00:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:59:48 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-oMYiSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 00:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:59:49 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-uwbI6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 00:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:59:49 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-OWQ3dQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 00:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:59:49 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-9JFklt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 00:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:59:49 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-e2YJAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 00:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:59:49 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-4sjwm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:59:49 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)) 00:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:59:49 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-EJjoVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:59:49 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)) 00:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:59:49 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-RITzry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:59:49 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)) 00:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:59:49 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-2ectz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:59:49 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)) 00:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:59:49 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-gFEF6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:59:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 00:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:59:50 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-OQSCYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:59:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 00:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:59:50 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-3R5sm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:59:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 00:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:59:50 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-3zCtbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:59:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 00:59:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:59:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:59:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:59:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:59:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:59:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:52 INFO - Downloading blessings-1.6.tar.gz 00:59:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:59:52 INFO - Installing collected packages: blessings 00:59:52 INFO - Running setup.py install for blessings 00:59:53 INFO - Successfully installed blessings 00:59:53 INFO - Cleaning up... 00:59:53 INFO - Return code: 0 00:59:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:59:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:59:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:59:53 INFO - Reading from file tmpfile_stdout 00:59:53 INFO - Current package versions: 00:59:53 INFO - blessings == 1.6 00:59:53 INFO - blobuploader == 1.2.4 00:59:53 INFO - docopt == 0.6.1 00:59:53 INFO - functools32 == 3.2.3-2 00:59:53 INFO - jsonschema == 2.5.1 00:59:53 INFO - manifestparser == 1.1 00:59:53 INFO - mozInstall == 1.12 00:59:53 INFO - mozcrash == 1.0 00:59:53 INFO - mozdebug == 0.1 00:59:53 INFO - mozdevice == 0.49 00:59:53 INFO - mozfile == 1.2 00:59:53 INFO - mozhttpd == 0.7 00:59:53 INFO - mozinfo == 0.9 00:59:53 INFO - mozleak == 0.1 00:59:53 INFO - mozlog == 3.4 00:59:53 INFO - moznetwork == 0.27 00:59:53 INFO - mozprocess == 0.23 00:59:53 INFO - mozprofile == 0.28 00:59:53 INFO - mozrunner == 6.13 00:59:53 INFO - mozscreenshot == 0.1 00:59:53 INFO - mozsystemmonitor == 0.3 00:59:53 INFO - moztest == 0.7 00:59:53 INFO - mozversion == 1.4 00:59:53 INFO - psutil == 3.1.1 00:59:53 INFO - requests == 1.2.3 00:59:53 INFO - wsgiref == 0.1.2 00:59:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:59:53 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')]} 00:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:53 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')]} 00:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a15e3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1a347cee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f74d30>, '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 0x109ddbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f6cb20>, '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.w36iOoTGmQ/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.orks0XGmwa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 00:59:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 00:59:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:59:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w36iOoTGmQ/Render', 00:59:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:59:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:59:54 INFO - 'HOME': '/Users/cltbld', 00:59:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:59:54 INFO - 'LOGNAME': 'cltbld', 00:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:54 INFO - 'MOZ_NO_REMOTE': '1', 00:59:54 INFO - 'NO_EM_RESTART': '1', 00:59:54 INFO - 'PAGER': '/bin/cat', 00:59:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:54 INFO - 'PWD': '/builds/slave/test', 00:59:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:59:54 INFO - 'SHELL': '/bin/bash', 00:59:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.orks0XGmwa/Listeners', 00:59:54 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 00:59:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:59:54 INFO - 'USER': 'cltbld', 00:59:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:59:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:54 INFO - 'XPC_FLAGS': '0x0', 00:59:54 INFO - 'XPC_SERVICE_NAME': '0', 00:59:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:59:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 00:59:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 00:59:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:59:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 00:59:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 00:59:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 00:59:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 00:59:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 00:59:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:59:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:59:54 INFO - Cleaning up... 00:59:54 INFO - Return code: 0 00:59:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:55 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 0x10a15e3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1a347cee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f74d30>, '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 0x109ddbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f6cb20>, '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.w36iOoTGmQ/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.orks0XGmwa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 00:59:55 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 00:59:55 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 00:59:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w36iOoTGmQ/Render', 00:59:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:59:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:59:55 INFO - 'HOME': '/Users/cltbld', 00:59:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:59:55 INFO - 'LOGNAME': 'cltbld', 00:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:55 INFO - 'MOZ_NO_REMOTE': '1', 00:59:55 INFO - 'NO_EM_RESTART': '1', 00:59:55 INFO - 'PAGER': '/bin/cat', 00:59:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:55 INFO - 'PWD': '/builds/slave/test', 00:59:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:59:55 INFO - 'SHELL': '/bin/bash', 00:59:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.orks0XGmwa/Listeners', 00:59:55 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 00:59:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:59:55 INFO - 'USER': 'cltbld', 00:59:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:59:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:55 INFO - 'XPC_FLAGS': '0x0', 00:59:55 INFO - 'XPC_SERVICE_NAME': '0', 00:59:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:59:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:59:55 INFO - Cleaning up... 00:59:55 INFO - Return code: 0 00:59:55 INFO - Running post-action listener: _resource_record_post_action 00:59:55 INFO - Running post-action listener: _start_resource_monitoring 00:59:55 INFO - Starting resource monitoring. 00:59:55 INFO - [mozharness: 2016-12-01 08:59:55.363993Z] Finished create-virtualenv step (success) 00:59:55 INFO - [mozharness: 2016-12-01 08:59:55.364957Z] Running install step. 00:59:55 INFO - Running pre-action listener: _resource_record_pre_action 00:59:55 INFO - Running main action method: install 00:59:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:59:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:59:55 INFO - Reading from file tmpfile_stdout 00:59:55 INFO - Detecting whether we're running mozinstall >=1.0... 00:59:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:59:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:59:55 INFO - Reading from file tmpfile_stdout 00:59:55 INFO - Output received: 00:59:55 INFO - Usage: mozinstall [options] installer 00:59:55 INFO - Options: 00:59:55 INFO - -h, --help show this help message and exit 00:59:55 INFO - -d DEST, --destination=DEST 00:59:55 INFO - Directory to install application into. [default: 00:59:55 INFO - "/builds/slave/test"] 00:59:55 INFO - --app=APP Application being installed. [default: firefox] 00:59:55 INFO - mkdir: /builds/slave/test/build/application 00:59:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 00:59:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 01:00:28 INFO - Reading from file tmpfile_stdout 01:00:28 INFO - Output received: 01:00:28 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:00:28 INFO - Running post-action listener: _resource_record_post_action 01:00:28 INFO - [mozharness: 2016-12-01 09:00:28.376039Z] Finished install step (success) 01:00:28 INFO - [mozharness: 2016-12-01 09:00:28.376175Z] Running run-tests step. 01:00:28 INFO - Running pre-action listener: _resource_record_pre_action 01:00:28 INFO - Running main action method: run_tests 01:00:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:00:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:00:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:00:28 INFO - 2016-12-01 01:00:28.390 screenresolution[2165:23818] starting screenresolution argv=screenresolution get 01:00:28 INFO - 2016-12-01 01:00:28.393 screenresolution[2165:23818] Display 0: 1600x1200x32@60 01:00:28 INFO - 2016-12-01 01:00:28.399 screenresolution[2166:23821] starting screenresolution argv=screenresolution list 01:00:28 INFO - Available Modes on Display 0 01:00:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:00:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:00:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:00:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:00:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:00:28 INFO - Intel Iris: 01:00:28 INFO - Chipset Model: Intel Iris 01:00:28 INFO - Type: GPU 01:00:28 INFO - Bus: Built-In 01:00:28 INFO - VRAM (Dynamic, Max): 1536 MB 01:00:28 INFO - Vendor: Intel (0x8086) 01:00:28 INFO - Device ID: 0x0a2e 01:00:28 INFO - Revision ID: 0x0009 01:00:28 INFO - Displays: 01:00:28 INFO - Display: 01:00:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:00:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:00:28 INFO - Display Serial Number: 1600x1200 60 01:00:28 INFO - Main Display: Yes 01:00:28 INFO - Mirror: Off 01:00:28 INFO - Online: Yes 01:00:28 INFO - Rotation: Supported 01:00:28 INFO - Return code: 0 01:00:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:00:28 INFO - Python 2.7.3 01:00:28 INFO - Return code: 0 01:00:28 INFO - grabbing minidump binary from tooltool 01:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:00:28 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 0x109f74d30>, '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 0x109ddbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f6cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:00:28 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 01:00:28 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 01:00:28 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 01:00:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:00:28 INFO - Return code: 0 01:00:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:00:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:00:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:00:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:00:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:00:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JdR8dXiZR42XAcH5GCQhNw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0139', '--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 01:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JdR8dXiZR42XAcH5GCQhNw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0139 --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 01:00:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w36iOoTGmQ/Render', 01:00:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:00:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:00:28 INFO - 'HOME': '/Users/cltbld', 01:00:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:00:28 INFO - 'LOGNAME': 'cltbld', 01:00:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:00:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:28 INFO - 'MOZ_NO_REMOTE': '1', 01:00:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:00:28 INFO - 'NO_EM_RESTART': '1', 01:00:28 INFO - 'PAGER': '/bin/cat', 01:00:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:28 INFO - 'PWD': '/builds/slave/test', 01:00:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:00:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:00:28 INFO - 'SHELL': '/bin/bash', 01:00:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.orks0XGmwa/Listeners', 01:00:28 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 01:00:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:00:28 INFO - 'USER': 'cltbld', 01:00:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:00:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:28 INFO - 'XPC_FLAGS': '0x0', 01:00:28 INFO - 'XPC_SERVICE_NAME': '0', 01:00:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:00:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JdR8dXiZR42XAcH5GCQhNw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0139', '--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 01:00:28 INFO - mozversion application_buildid: 20161130233044 01:00:28 INFO - mozversion application_changeset: 95098568797bbcd89a19e17f4d444acab7aec4d8 01:00:28 INFO - mozversion application_display_name: Nightly 01:00:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:00:28 INFO - mozversion application_name: Firefox 01:00:28 INFO - mozversion application_remotingname: firefox 01:00:28 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 01:00:28 INFO - mozversion application_vendor: Mozilla 01:00:28 INFO - mozversion application_version: 53.0a1 01:00:28 INFO - mozversion platform_buildid: 20161130233044 01:00:28 INFO - mozversion platform_changeset: 95098568797bbcd89a19e17f4d444acab7aec4d8 01:00:28 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 01:00:28 INFO - mozversion platform_version: 53.0a1 01:00:28 INFO - using testdate: 1480582828 01:00:28 INFO - actual date: 1480582828 01:00:28 INFO - starting webserver on 'localhost:56028' 01:00:28 INFO - SUITE-START | Running 2 tests 01:00:28 INFO - TEST-START | dromaeo_css 01:00:28 INFO - operating with platform_type : mac_ 01:00:28 INFO - Initialising browser for dromaeo_css test... 01:00:28 INFO - TEST-INFO | started process 2176 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmpCeucdh/profile http://localhost:56028/getInfo.html) 01:00:31 INFO - PROCESS | 2176 | __metrics Screen width/height:1600/1200 01:00:31 INFO - PROCESS | 2176 | colorDepth:24 01:00:31 INFO - PROCESS | 2176 | Browser inner width/height: 1024/689 01:00:31 INFO - PROCESS | 2176 | __metrics 01:00:31 INFO - PROCESS | 2176 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:00:31 INFO - PROCESS | 2176 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:00:32 INFO - TEST-INFO | 2176: exit 0 01:00:32 INFO - Browser initialized. 01:00:32 INFO - Running cycle 1/1 for dromaeo_css test... 01:00:32 INFO - TEST-INFO | started process 2178 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmpCeucdh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:00:44 INFO - PROCESS | 2178 | RSS: Main: 236810240 01:00:44 INFO - PROCESS | 2178 | 01:01:35 INFO - PROCESS | 2178 | 1480582895863 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] 01:03:49 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:56028/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56028/tests/dromaeo/cssquery-ext.html) 01:03:51 INFO - PROCESS | 2178 | RSS: Main: 376877056 01:03:51 INFO - PROCESS | 2178 | 01:06:54 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:56028/tests/dromaeo/cssquery-ext.html (next: http://localhost:56028/tests/dromaeo/cssquery-jquery.html) 01:06:54 INFO - PROCESS | 2178 | RSS: Main: 368332800 01:06:54 INFO - PROCESS | 2178 | 01:09:57 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:56028/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56028/tests/dromaeo/cssquery-mootools.html) 01:09:58 INFO - PROCESS | 2178 | RSS: Main: 341786624 01:09:58 INFO - PROCESS | 2178 | 01:13:00 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:56028/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56028/tests/dromaeo/cssquery-prototype.html) 01:13:01 INFO - PROCESS | 2178 | RSS: Main: 341860352 01:13:01 INFO - PROCESS | 2178 | 01:16:04 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:56028/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56028/tests/dromaeo/cssquery-yui.html) 01:16:05 INFO - PROCESS | 2178 | RSS: Main: 329203712 01:16:05 INFO - PROCESS | 2178 | 01:19:08 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:56028/tests/dromaeo/cssquery-yui.html (next: http://localhost:56028/tests/dromaeo/cssquery-dojo.html) 01:19:09 INFO - PROCESS | 2178 | RSS: Main: 379174912 01:19:09 INFO - PROCESS | 2178 | 01:19:09 INFO - PROCESS | 2178 | __start_tp_report 01:19:09 INFO - PROCESS | 2178 | _x_x_mozilla_page_load 01:19:09 INFO - PROCESS | 2178 | _x_x_mozilla_page_load_details 01:19:09 INFO - PROCESS | 2178 | |i|pagename|runs| 01:19:09 INFO - PROCESS | 2178 | |0;dojo.html;3153.511205763107;3270.738340932726;3316.1378041709163;3321.9003429897098;3337.399268131738;4562.885927851797;5496.367917689467;5566.248556444879;5612.69130197839;5682.090865461532;5535.501804837564;5620.213170156181;5627.015272327347;5632.802851900185;5664.971675141618;4946.505349465061;5075.9746201268945;5096.541311281984;5137.511936366058;5143;5063.493650634926;5237.6071794615555;5238.764255608507;5243.003829272445;5261.526462618363;5183.092958732244;5183.896322073538;5226.1899405592;5241.10901146804;5272.551833094191;4210.936835947463;4587.288970209623;4967.900641987176;5057.963117560891;5099.260607211971;5093.821716239914;5114.514121158484;5115.335006449175;5132.358455193101;5161.483851614846;5576.10782274834;5577.386487486373;5578.665280083167;5619.269494965669;5631.887362252773;5898.557608179361;5952.553558483131;5965.761369545213;6127.142200091991;6158.414950579688;4738.881527961828;6095.238095238095;6144.003198960311;6196.473299769525;6197.721102550396;5617.634853734494;5680.943190568124;5698.800541981011;5700.23046888673;5704.172894930253;6127.494965205055;6282.089097080989;6282.4974002079725;6298.338674439118;6307.590006649553;5817.563682723812;5862.618929769551;5955.166276721263;5969.403059694083;5970.253718285215;6155.84610384744;6164.722587483574;6186.4741496973265;6189.690515474208;6199.845003874939;6032.4570788629235;6072.726727297282;6092.086187071975;6092.786752463731;6135.049067394561;5917.704114794243;5975.940240597538;5988.610740301867;6099.512039036867;6118.908216376758;4795.017021510582;4842.15262329091;4849.830255941025;4855.441624213261;4864.902701945941;4308.763018034038;4385.276429389115;4435.2016637005645;4442.022754993896;4442.48911375196;5644.266245388156;5646.265985421869;5647.943520564824;5659.971700141473;5660.603757737002;6094.169091873587;6111.13596929516;6116.853194528077;6127.403330890726;6135.477655820289;5666.036773748473;5743.368229494752;5748.051571490741;5757.424257574293;5759.539236861041;4536.546345365503;5282.9170020145775;5332.413434522199;5345.492178243061;5349.144136938071;6325.841853953688;6326;6330.651814150266;6333.050042493663;6342.619442833445;6040.879182416239;6112.786052488142;6114.145302971568;6115.480184184395;6142.959235178615;6301.873962520633;6329.46199573023;6342.112104305494;6348.873022539431;6358.650274234961;6100.6949652516305;6112.663803490673;6119.112728654409;6125.84685382869;6134.294556126102;5983.34183239852;6035.69821508914;6103.755849765959;6111.77406523465;6225.750969961151;6012.549058820518;6013.789517366871;6013.849653758691;6019.398060193946;6075.119107729266;4960.181570040902;5708.34354049273;6032.788852390146;6035.849103772441;6040.84897877539;5635.211070450058;5728.1694154348215;5746.281714785652;5814.592978491465;5824.330202026652;5904.61619994699;5952.077427998667;6038.7282572283475;6041.063635136561;6053.636781793107;5798.6810725410505;5812.883742325214;5815.738291776965;5849.502792262705;5878.882422351615 01:19:09 INFO - PROCESS | 2178 | |1;ext.html;458.2667731629392;490.2205493265707;499.2984856276932;502.5828562293297;567.3787203012699;36668;38630.22739545207;38830.02924926878;38841.61158388415;38862.83411497656;31768;39286.41070383939;39416.80291598545;39971.60028399715;40065.798026059194;8423.831523369528;8547.786305342353;8649.437786543855;8853.778655533615;9518.000609935962;9488.478133702643;11108.389038602874;11388.601398951037;11511.079113670887;11515.25150865191;11291.830622540669;11369;11379.658610241706;11402.543898244101;11445.771084578304;8461.492310461392;8686.478811271281;11283.717907052349;11299.435028248554;11324;9464;10998.670039898816;11278.943605282004;11433.828492572618;11485.712857178554;38994.41508377377;39397.01507462308;39403.40894886579;39429;39535.60464395348;3194.0577529628818;3209.951850722241;3308.3217940322415;3491.493733408667;3606.8196590170387;29540.643099660432;29627.851860740775;29757.702422975708;29961.70038299633;30900.690993090007;3129.640091389497;3138.8744450221966;3141.27750617357;3152.0386282183927;3261.6086069671555;446155.7692211551;463694;464647;468750.65624672;470784;58266;58512;58539.536511587554;58645.70677146672;58718.41281587215;56787.86424271574;56879;56944.715276424184;56973;57062;15022;15492.612684682974;15495.690086198438;15499.5350139496;15503.302351394213;10828.729281768019;11120.332780033063;11136.109111271078;11776.293422394683;12028.21816581937;16600.08699521538;16633.168341582874;16673.83326166747;16836.32654693823;17037.40369087076;6610.140681711443;6645.435138013227;6683.632400217937;6707.228668703064;6721.831954201184;838.9119142489951;926.2682480840195;939.5912777941618;957.818014577228;1049.9107575856137;23997.880010599834;26070.34824129412;27316;28983.85508072446;29636.851815741215;986.7187851462298;993.7068564773409;1026.2816028779885;1044.770150566874;1062.0759938853248;14142.292885355691;14515.85484145166;15179.848201517843;15201.163935983406;15502.767458488132;512102;592767;595871;600082;603112;55553.72223138859;55858.44141558532;55858.720706396205;56036;56295.155572666445;1202.8015377462796;1221.3038568016145;1322.9536966206138;1337.2043634037732;1350.1696456679267;24061;25455.981760730105;26381.736182638695;30185.698143019166;30993.225169370948;47607.28589071098;52654;54163.18755218753;54512.72743636256;56760;547756;548529;549032;551984;555112;24895;25127.623085654097;25366.49267014686;25602.359941001625;25719.742802571735;43886.34170487509;44359.609471171134;44662.77668611636;45071.32393014173;45456.772716136205;30129.548056779604;32282.35435291328;36532.81733591315;36976.63023369732;38256.61743382642;36697.63302366942;37428;37664.44511714027;38215;38457.42313865238;35834.28331433409;37070.8146459266;37453.4381984265;37499.625003749614;37536.624633753316;24565.50868982646;30166.84916575403;31855.20361990876;33146.66853331532;33251.667483324854;24476.69870501266;24493.020279189346;24937.750622493542;24948.750512494644;25023.87488062548 01:19:09 INFO - PROCESS | 2178 | |2;jquery.html;348.1852465231358;365.9798711070891;370.8776103885716;378.57599488572794;397.60438363827996;14257.215853128087;14989.775153372708;19312.613747725038;20124;20212.090455929465;11409.201355905068;11509.654710358682;11633.534658613666;11783.113137281356;11848;5105.259737338084;5312.867178320535;5325.3077099976945;5369.033573956686;5369.382521010075;4968.155413579682;5292.788288468457;5323.973380133094;5332.413434522199;5333.599980001496;5213;5219.478052194788;5320.973395133019;5339.305890234284;5347.010803001457;5314.415414304423;5749.511291540203;5794.565407594448;5805.448482394187;5823.505002074829;4917.262410638397;5163.7676304566385;5164.974175129138;5167.844964651066;5170.922436163461;12958.352082395937;13245.403956821967;13258.933705331508;13261.204327740366;13274.004449666218;2072.295419557358;2088;2092.780258072911;2117.8411619128474;2134.285014520122;9835;10316.948415257952;10352.689419317358;10446.744959271682;12053.0960177987;1606.8152162501344;1682.1337011438995;1826;1861.525311045688;1899.6675581773272;109080;121393;126830.99999999908;127948;128237;11117.277376970633;11181.385023823605;11435.371054592077;11478.713032174262;11516.251443656136;12870.16343937641;13201.53794617203;13365.799513007312;13461.990350723734;13993.720125597634;7869.134395216522;7884.566348850868;7972.3622110231045;8173.18268173178;8386.622601982925;8070.636821342936;8112.594370281462;8136.430449868452;8216.699324189118;8295.336373090138;4066.755994640331;4238.724482908601;4259.744415335028;4265.445492086009;4384.364267181241;1785.5326322316291;1873.1664409337986;1882.2471011595471;1885.5003424092627;1924.6054558815408;812.6911773526023;836.2599099796602;886.8448021596324;920.9676618151084;952.8142012307673;15500.844991550166;18548;19186.944718040642;20899.955002249826;21013.05441255147;904.7918978634951;917.4403613795579;926.2173463423396;934.500042477285;936.5598168860624;10343.224258180666;10519.737006574896;10990.560377584807;11051.281666691639;11078;486527;494058.52970734914;495515;505353.47323263885;511916;116321.62301335455;120367;122465.38767306284;122821;126413.36793316159;934.5700977550403;981.4062492192263;986.2800155886387;999.2156157416393;1000.8798944126752;18799.154038068045;19194;19207.615847683246;19212.135453904888;19297;37992.620073798906;42294.731158065304;53459.198112027574;53669;54235.18647220216;77240.61379693066;79409.20590794018;79699.60150199212;81448;82574.17425825905;7252.238514956065;8025.03699556057;8175.877361839696;8259.297959673495;8304.003519577689;8114.959425202836;9407.165602707406;11661.475233614337;12485.313307767796;12954.611361659165;10774.407407592658;10817.405042722727;11048.447577621248;11090.112790976864;11170;7294.379977701955;8075.192480751878;8160.26557609818;10878.728031799268;11064.28082174656;6833.829154271183;7678.469702875331;7865.4155549560455;8131.9593402032615;8173.836523269621;10170.542325595217;11012.724681883017;11964.683884772494;12021.699457513632;12354.567590134302;11382.601608943647;11505.712357191138;11652.88347116518;12002.339871307162;12035.338056406981 01:19:09 INFO - PROCESS | 2178 | |3;mootools.html;1382.3572039001863;1460.5837336359136;1623.5778697538644;1817.482017624977;1848.1498510685076;7794.298513133816;8182.91817081829;8188.590570471475;8189.91810081899;8195.959020204898;7200.855982880339;7457.925420745804;7459.104907411118;7790.688372465094;7984.321332686729;2253.312739614417;2288.3592594073684;2288.5079707862806;2293.2317673579287;2295.5638428698576;2279.7036385269976;2299.275728145629;2311.90752369905;2316.9805285674333;2319.6868422762964;1863.6272745450897;2262.468319944812;2287.1994801819396;2298.436882963668;2300.160441438871;2191.3973657244305;2225.833062520301;2237.59723249815;2238.798508134276;2239.9664005039936;2220.123051394706;2275.5448910217856;2276.829237807171;2277.4078739527677;2287.977120228793;7957.482763620404;8020.799480012988;8087.878681819719;8096.595170241464;8104.189581041907;4929.383827021622;4960.206366981266;4972.453030166679;5019.071471777696;5084.694918304914;3048.84755762211;3112.766542509321;3326.8502917368533;3336.0492259705866;3338.96661033389;960.9423434593947;967.908048735369;986.6645340584164;1016.9440680762555;1021.4994652620163;10358.792824143475;10381.325213861075;10588.57645694179;10592.841107383472;10594.993475619804;4262.381954616625;4572.9314060289125;4605.286180642006;4610.749421657723;4612.469565999953;9077.409968352036;9081.500517471603;9083.545822708838;9085.863712044325;9091.227245684191;4286.507051689034;5071.340725705634;5073.315102461121;5074.112030394666;5079.720615366116;3889.4554762333296;4101.048722415477;4541.455025396974;4674.6260299176665;4675.111728771522;3192.4732419151046;3607.206414588786;3654.8720794772057;3747.793871337048;3750.0812300985885;1192.3680449361852;1199.2744389644315;1211.0614273937592;1218.226426219357;1221.8594861590852;747.8242612986053;840.260570697782;893.2050475077186;898.9190972812347;918.8070505193984;4957;5525.11598144295;5685.687287199161;5756.856078597984;5937.7921772737745;941.3363578677016;953.8903026151943;976.4239098931664;993.2252842782641;1033.0547548992738;2895.5946167536563;3507.9649203508147;3666.505021822073;3787.772733635991;3808.1241314497265;9449.055094490495;9860.30977831545;9915.752106197402;9920.603175872884;9935.453550054672;9834.409935403755;9854.950725246328;9876.308658393988;9879.80240395188;9906.55420506079;7215.386692131123;7481.21447248042;7515.21090285523;7528.623568821647;7662.65518051689;5222.634415591024;5499.835004949858;5530.198121272473;5593.758396608542;5600.0759874620235;8769.298456123368;8811.251043661361;9018.143276388733;9119.316051296311;9156.932427636817;7480.915267286105;8903.643854246016;8921.643134274556;9079.228265597498;9306.441613503212;6956.860862782817;7180.281971802987;7190.856182876418;7339.743108991373;7569.545827250383;7495.737649182252;7713.537187768752;7722.575258360844;7830.334421574002;7836.059672839296;6911.930880691129;6943.965280173769;7024.824379390556;7026.086608740831;7152.535085219444;6857.417119544894;6868.450523957971;6889.311068893271;6941.93058069433;6966.233714291323;6264.780732674334;6428.485721142204;6517.413432790882;6576.934230657632;6578.473722102316;4650.232711602548;4659.743714095757;4696.953030469652;4747.074320507468;4826.420829500483;4369.431973843507;4511.300748384006;4638.93041604383;4794.113089078532;4827.275908613596 01:19:09 INFO - PROCESS | 2178 | |4;prototype.html;298.93722318313155;307.5095223119126;307.59244001697755;315.451115059796;317.37002050928885;4209.894752631182;5285.973570132149;5327.227552004957;5344.385395679498;5345.4120046794915;5170.276161337416;5190.494756520614;5244.475552444754;5251.816186433466;5263.86840328992;3765.9246815063616;3806.6574008339244;3900.7375722081265;3927.5286965564173;3997.7601343919314;3956.4460975463458;4007.83968641254;4012.8394864205397;4062.5531191568903;4062.573429789874;3302.570665813441;3844.3656796628525;3932.9016774580577;3946.3228128045607;3956.9802150989203;3228.2736384313575;3741.663250307485;3966.246413181501;3973.443717879499;3999.7400168988925;2692.636494073314;3109.2693217093965;3131.7942592101977;3277.852751536967;3417.3507033663773;5048.899022019576;5059.822906198266;5067.721275329855;5069.366329208849;5069.493050694938;3608.1881576645305;3701.2782507411066;4093.3217380874;4503.752293623849;4505.594496495331;4419.756913369763;4927.7536123193695;5307.840764777063;5415.593830462692;5453.836384908459;3719.925601487955;3719.962800372016;3724.5976345257427;3728.850845966158;3753.680937120348;4826.734529600871;5159.896802063975;5685.658860468344;5721.5708821838525;5746.913796293059;3618.3125206210734;3647.28877868813;3753.1609511339793;3796.981015094907;3809.4095415210686;3850.9229815403537;3861.6331448512346;3869.3808990561374;3884.7280690351404;3889.86385476507;4151.6886233532605;4456.353828694886;4459.0413061192;4490.259107247268;4492.595666389975;4901.142300097468;5305.389880163753;5417.59368047398;5420.268263784417;5480.780768769284;1007.8488226765897;1142.3317359344876;1164.4119719541577;1230.3725100198963;1255.1465003797505;744.6723441685641;787.6455594982281;810.6291081628808;847.9146692233951;849.1720572441943;4167.333226683716;4348.956510434855;4762.285657151455;5175.663581867242;5178.97410512945;4914.57477331577;5264.394359720322;5595.328560572757;5616.971915140398;5621.269234999506;3873;4630.32860235264;4849.908770526603;5087.465816089331;5169.302144210484;2627.6861569215394;2668.198965698146;2736.781057515394;2817.60553522507;2819;4322.675799315001;4997.575206107522;5138.790320162366;5511.338639363302;5569;5392;5492.340919089735;5566.916496252559;5588.552915766729;5906.40935906406;5291;5841.94158058414;5876.08920617305;5916.615419997686;5941.287045554474;5224.320838290998;5704.286964129484;5710.2862142232225;5730.856728581819;5771.538276937918;4571.748553829439;5500.559955203494;5635.88728225425;5650.63270887391;5650.830475085754;5312.335958005249;5404.972975135099;5820.912686309624;5861.296644402699;5873.970630146993;3104.286014216698;3766.0396598867114;3787.3750831112557;3806.3529200035505;3831.501904752364;5227.268182454535;5400.297961265011;5687.090065589486;5742.253507044057;5791.247137872049;5478.260434841245;5508.0360936835095;5511.807086751945;5514.80698175562;5517.089680202722;5263.447338029605;5479.917801232905;5505.082306377626;5541.362743284574;5544.306961629796;3987.624269626974;5382.30030096085;5432.876096244596;5488.725563721718;5503.614746967834;4932.695094286908;5264.578833693372;5420.430854760193;5429.864253393696;5432.837014889559;4180.011291926287;4830.4444988826735;5412.377576578587;5423.430539793423;5424.864378390414 01:19:09 INFO - PROCESS | 2178 | |5;yui.html;694.5207806613437;707.8159678483593;758.6586036283674;760.5056713136457;791.2285521616423;13730.794038089423;14397.352119154637;14416.783748243784;14424.639384015418;14467.782983255247;12808.615741527768;12859.485620575166;12867.29229892358;12884.3557822109;12898.613041608744;666.2970566052812;683.8256244657605;690.6132565763163;812.3704129299796;835.9122292159327;810.9675612975474;834.8121672623641;835.5863847395548;853.4026181672854;854.1373213054798;892.5849479991803;900.0144841398658;900.5677274908048;902.0122965352928;902.8058967322024;701.8280521272321;887.9023307436177;890.132121181849;891.527490430073;893.9106089391074;535.456511640685;633.8763941031501;653.7156336993376;656.4846595422571;662.7647185249264;12684.175528590613;12973.935130324287;13940.51208207718;13949.372278247503;14206.431742730278;12531;12774.48902043917;13233.801492977613;13253.337333133304;13425.597232083053;10062.849057264148;10119.675202998125;10499.895001049968;10838.72903177419;11063;4191.266528357525;4232.978835105805;4246.320588705792;4376.343548467724;4378.6934914555995;105669.47165264124;106686.46656766666;107527;109569.45215273953;110773.33839992326;9286;9327.860082098774;9331.72004839856;9411.43531388119;9717.514124293757;17621;17622;18428;18697.439076827715;18780.342688005854;7267.672954717051;7334.266573342729;7355.668994895243;7558.735444259424;7574.280443357872;4062.0339994035426;4067.262427192215;4069.2268468990796;4126.360414135814;4148.045949431647;3192.521121831744;3305.8512366943546;3345.1469875181674;3348.430766769655;3354.480055591387;624.4161708802285;624.4848000399688;625.627751487864;638.779621030753;642.858571114354;533.3280067115462;556.3851943602342;571.3600767140829;615.9784407545715;621.9937800622026;7895.535381171496;8510.234078932926;8552.871706924401;8665.480071195749;8685.826283474422;575.1832397994857;608.0848323273445;614.532954954238;626.3579830673596;633.5153607490273;3318.7468920934857;4050.250703619781;4234.915301694011;4289.356596510486;4313.698041137153;88074.55962720273;90557.09442905619;93633.12733745424;95889;107129.92870071356;83608.70390916259;86451.13548864557;89340;91996;92587;72036.19909502304;74284.62857685678;75395;76083.23916760762;77658;9444.724962130025;9589.089036541518;9625.229981601595;9649.421034737938;9742.415455072718;48804.02391952212;49827.75086124546;50122.749386252835;52020.479795201565;53890.461095390114;72878.27121728715;74254.25745742474;74440;75324.62337688277;76020.23979760132;9850.458224797418;12499.812502812283;12520.749585008067;12588.622341329774;12677.556285529961;12222.938885305517;14024.509142179975;14122.646933826325;14682;14976.925115374353;12252.448639811051;12930.547430839875;13000.219986800823;13024.413901374272;13865.722685546434;11222.438878055902;13126.358150885168;13603.251821149932;13763.518276860263;13913.721725565634;13050.608481745563;13233.801492977806;13350.771020949887;13513.864861351261;13654.949695689977;9128.634854605742;10277.691669249934;10704.8929510707;10788.406637635006;10857.728556786144;10704.30422022566;11109.11127109813;11359.375234361858;11376.976072153546;11422.885771142182 01:19:09 INFO - PROCESS | 2178 | __end_tp_report 01:19:09 INFO - PROCESS | 2178 | __start_cc_report 01:19:09 INFO - PROCESS | 2178 | _x_x_mozilla_cycle_collect,1719 01:19:09 INFO - PROCESS | 2178 | __end_cc_report 01:19:09 INFO - PROCESS | 2178 | __startTimestamp1480583949243__endTimestamp 01:19:09 INFO - PROCESS | 2178 | 01:19:09 INFO - PROCESS | 2178 | ------- Summary: start ------- 01:19:09 INFO - PROCESS | 2178 | Number of tests: 6 01:19:09 INFO - PROCESS | 2178 | 01:19:09 INFO - PROCESS | 2178 | [#0] dojo.html Cycles:165 Average:5623.99 Median:5812.88 stddev:656.38 (11.3%) stddev-sans-first:629.13 01:19:09 INFO - PROCESS | 2178 | Values: 3153.5 3270.7 3316.1 3321.9 3337.4 4562.9 5496.4 5566.2 5612.7 5682.1 5535.5 5620.2 5627.0 5632.8 5665.0 4946.5 5076.0 5096.5 5137.5 5143.0 5063.5 5237.6 5238.8 5243.0 5261.5 5183.1 5183.9 5226.2 5241.1 5272.6 4210.9 4587.3 4967.9 5058.0 5099.3 5093.8 5114.5 5115.3 5132.4 5161.5 5576.1 5577.4 5578.7 5619.3 5631.9 5898.6 5952.6 5965.8 6127.1 6158.4 4738.9 6095.2 6144.0 6196.5 6197.7 5617.6 5680.9 5698.8 5700.2 5704.2 6127.5 6282.1 6282.5 6298.3 6307.6 5817.6 5862.6 5955.2 5969.4 5970.3 6155.8 6164.7 6186.5 6189.7 6199.8 6032.5 6072.7 6092.1 6092.8 6135.0 5917.7 5975.9 5988.6 6099.5 6118.9 4795.0 4842.2 4849.8 4855.4 4864.9 4308.8 4385.3 4435.2 4442.0 4442.5 5644.3 5646.3 5647.9 5660.0 5660.6 6094.2 6111.1 6116.9 6127.4 6135.5 5666.0 5743.4 5748.1 5757.4 5759.5 4536.5 5282.9 5332.4 5345.5 5349.1 6325.8 6326.0 6330.7 6333.1 6342.6 6040.9 6112.8 6114.1 6115.5 6143.0 6301.9 6329.5 6342.1 6348.9 6358.7 6100.7 6112.7 6119.1 6125.8 6134.3 5983.3 6035.7 6103.8 6111.8 6225.8 6012.5 6013.8 6013.8 6019.4 6075.1 4960.2 5708.3 6032.8 6035.8 6040.8 5635.2 5728.2 5746.3 5814.6 5824.3 5904.6 5952.1 6038.7 6041.1 6053.6 5798.7 5812.9 5815.7 5849.5 5878.9 01:19:09 INFO - PROCESS | 2178 | 01:19:09 INFO - PROCESS | 2178 | [#1] ext.html Cycles:180 Average:66159.13 Median:36682.82 stddev:142548.85 (388.6%) stddev-sans-first:142863.39 01:19:09 INFO - PROCESS | 2178 | Values: 458.3 490.2 499.3 502.6 567.4 36668.0 38630.2 38830.0 38841.6 38862.8 31768.0 39286.4 39416.8 39971.6 40065.8 8423.8 8547.8 8649.4 8853.8 9518.0 9488.5 11108.4 11388.6 11511.1 11515.3 11291.8 11369.0 11379.7 11402.5 11445.8 8461.5 8686.5 11283.7 11299.4 11324.0 9464.0 10998.7 11278.9 11433.8 11485.7 38994.4 39397.0 39403.4 39429.0 39535.6 3194.1 3210.0 3308.3 3491.5 3606.8 29540.6 29627.9 29757.7 29961.7 30900.7 3129.6 3138.9 3141.3 3152.0 3261.6 446155.8 463694.0 464647.0 468750.7 470784.0 58266.0 58512.0 58539.5 58645.7 58718.4 56787.9 56879.0 56944.7 56973.0 57062.0 15022.0 15492.6 15495.7 15499.5 15503.3 10828.7 11120.3 11136.1 11776.3 12028.2 16600.1 16633.2 16673.8 16836.3 17037.4 6610.1 6645.4 6683.6 6707.2 6721.8 838.9 926.3 939.6 957.8 1049.9 23997.9 26070.3 27316.0 28983.9 29636.9 986.7 993.7 1026.3 1044.8 1062.1 14142.3 14515.9 15179.8 15201.2 15502.8 512102.0 592767.0 595871.0 600082.0 603112.0 55553.7 55858.4 55858.7 56036.0 56295.2 1202.8 1221.3 1323.0 1337.2 1350.2 24061.0 25456.0 26381.7 30185.7 30993.2 47607.3 52654.0 54163.2 54512.7 56760.0 547756.0 548529.0 549032.0 551984.0 555112.0 24895.0 25127.6 25366.5 25602.4 25719.7 43886.3 44359.6 44662.8 45071.3 45456.8 30129.5 32282.4 36532.8 36976.6 38256.6 36697.6 37428.0 37664.4 38215.0 38457.4 35834.3 37070.8 37453.4 37499.6 37536.6 24565.5 30166.8 31855.2 33146.7 33251.7 24476.7 24493.0 24937.8 24948.8 25023.9 01:19:09 INFO - PROCESS | 2178 | 01:19:09 INFO - PROCESS | 2178 | [#2] jquery.html Cycles:180 Average:31231.76 Median:357.08 stddev:84445.81 (23648.8%) stddev-sans-first:84650.87 01:19:09 INFO - PROCESS | 2178 | Values: 348.2 366.0 370.9 378.6 397.6 14257.2 14989.8 19312.6 20124.0 20212.1 11409.2 11509.7 11633.5 11783.1 11848.0 5105.3 5312.9 5325.3 5369.0 5369.4 4968.2 5292.8 5324.0 5332.4 5333.6 5213.0 5219.5 5321.0 5339.3 5347.0 5314.4 5749.5 5794.6 5805.4 5823.5 4917.3 5163.8 5165.0 5167.8 5170.9 12958.4 13245.4 13258.9 13261.2 13274.0 2072.3 2088.0 2092.8 2117.8 2134.3 9835.0 10316.9 10352.7 10446.7 12053.1 1606.8 1682.1 1826.0 1861.5 1899.7 109080.0 121393.0 126831.0 127948.0 128237.0 11117.3 11181.4 11435.4 11478.7 11516.3 12870.2 13201.5 13365.8 13462.0 13993.7 7869.1 7884.6 7972.4 8173.2 8386.6 8070.6 8112.6 8136.4 8216.7 8295.3 4066.8 4238.7 4259.7 4265.4 4384.4 1785.5 1873.2 1882.2 1885.5 1924.6 812.7 836.3 886.8 921.0 952.8 15500.8 18548.0 19186.9 20900.0 21013.1 904.8 917.4 926.2 934.5 936.6 10343.2 10519.7 10990.6 11051.3 11078.0 486527.0 494058.5 495515.0 505353.5 511916.0 116321.6 120367.0 122465.4 122821.0 126413.4 934.6 981.4 986.3 999.2 1000.9 18799.2 19194.0 19207.6 19212.1 19297.0 37992.6 42294.7 53459.2 53669.0 54235.2 77240.6 79409.2 79699.6 81448.0 82574.2 7252.2 8025.0 8175.9 8259.3 8304.0 8115.0 9407.2 11661.5 12485.3 12954.6 10774.4 10817.4 11048.4 11090.1 11170.0 7294.4 8075.2 8160.3 10878.7 11064.3 6833.8 7678.5 7865.4 8132.0 8173.8 10170.5 11012.7 11964.7 12021.7 12354.6 11382.6 11505.7 11652.9 12002.3 12035.3 01:19:09 INFO - PROCESS | 2178 | 01:19:09 INFO - PROCESS | 2178 | [#3] mootools.html Cycles:180 Average:5280.55 Median:5512.48 stddev:2883.49 (52.3%) stddev-sans-first:2876.70 01:19:09 INFO - PROCESS | 2178 | Values: 1382.4 1460.6 1623.6 1817.5 1848.1 7794.3 8182.9 8188.6 8189.9 8196.0 7200.9 7457.9 7459.1 7790.7 7984.3 2253.3 2288.4 2288.5 2293.2 2295.6 2279.7 2299.3 2311.9 2317.0 2319.7 1863.6 2262.5 2287.2 2298.4 2300.2 2191.4 2225.8 2237.6 2238.8 2240.0 2220.1 2275.5 2276.8 2277.4 2288.0 7957.5 8020.8 8087.9 8096.6 8104.2 4929.4 4960.2 4972.5 5019.1 5084.7 3048.8 3112.8 3326.9 3336.0 3339.0 960.9 967.9 986.7 1016.9 1021.5 10358.8 10381.3 10588.6 10592.8 10595.0 4262.4 4572.9 4605.3 4610.7 4612.5 9077.4 9081.5 9083.5 9085.9 9091.2 4286.5 5071.3 5073.3 5074.1 5079.7 3889.5 4101.0 4541.5 4674.6 4675.1 3192.5 3607.2 3654.9 3747.8 3750.1 1192.4 1199.3 1211.1 1218.2 1221.9 747.8 840.3 893.2 898.9 918.8 4957.0 5525.1 5685.7 5756.9 5937.8 941.3 953.9 976.4 993.2 1033.1 2895.6 3508.0 3666.5 3787.8 3808.1 9449.1 9860.3 9915.8 9920.6 9935.5 9834.4 9855.0 9876.3 9879.8 9906.6 7215.4 7481.2 7515.2 7528.6 7662.7 5222.6 5499.8 5530.2 5593.8 5600.1 8769.3 8811.3 9018.1 9119.3 9156.9 7480.9 8903.6 8921.6 9079.2 9306.4 6956.9 7180.3 7190.9 7339.7 7569.5 7495.7 7713.5 7722.6 7830.3 7836.1 6911.9 6944.0 7024.8 7026.1 7152.5 6857.4 6868.5 6889.3 6941.9 6966.2 6264.8 6428.5 6517.4 6576.9 6578.5 4650.2 4659.7 4697.0 4747.1 4826.4 4369.4 4511.3 4638.9 4794.1 4827.3 01:19:09 INFO - PROCESS | 2178 | 01:19:09 INFO - PROCESS | 2178 | [#4] prototype.html Cycles:180 Average:4399.42 Median:5063.77 stddev:1387.12 (27.4%) stddev-sans-first:1356.43 01:19:09 INFO - PROCESS | 2178 | Values: 298.9 307.5 307.6 315.5 317.4 4209.9 5286.0 5327.2 5344.4 5345.4 5170.3 5190.5 5244.5 5251.8 5263.9 3765.9 3806.7 3900.7 3927.5 3997.8 3956.4 4007.8 4012.8 4062.6 4062.6 3302.6 3844.4 3932.9 3946.3 3957.0 3228.3 3741.7 3966.2 3973.4 3999.7 2692.6 3109.3 3131.8 3277.9 3417.4 5048.9 5059.8 5067.7 5069.4 5069.5 3608.2 3701.3 4093.3 4503.8 4505.6 4419.8 4927.8 5307.8 5415.6 5453.8 3719.9 3720.0 3724.6 3728.9 3753.7 4826.7 5159.9 5685.7 5721.6 5746.9 3618.3 3647.3 3753.2 3797.0 3809.4 3850.9 3861.6 3869.4 3884.7 3889.9 4151.7 4456.4 4459.0 4490.3 4492.6 4901.1 5305.4 5417.6 5420.3 5480.8 1007.8 1142.3 1164.4 1230.4 1255.1 744.7 787.6 810.6 847.9 849.2 4167.3 4349.0 4762.3 5175.7 5179.0 4914.6 5264.4 5595.3 5617.0 5621.3 3873.0 4630.3 4849.9 5087.5 5169.3 2627.7 2668.2 2736.8 2817.6 2819.0 4322.7 4997.6 5138.8 5511.3 5569.0 5392.0 5492.3 5566.9 5588.6 5906.4 5291.0 5841.9 5876.1 5916.6 5941.3 5224.3 5704.3 5710.3 5730.9 5771.5 4571.7 5500.6 5635.9 5650.6 5650.8 5312.3 5405.0 5820.9 5861.3 5874.0 3104.3 3766.0 3787.4 3806.4 3831.5 5227.3 5400.3 5687.1 5742.3 5791.2 5478.3 5508.0 5511.8 5514.8 5517.1 5263.4 5479.9 5505.1 5541.4 5544.3 3987.6 5382.3 5432.9 5488.7 5503.6 4932.7 5264.6 5420.4 5429.9 5432.8 4180.0 4830.4 5412.4 5423.4 5424.9 01:19:09 INFO - PROCESS | 2178 | 01:19:09 INFO - PROCESS | 2178 | [#5] yui.html Cycles:180 Average:19978.80 Median:49975.25 stddev:29296.53 (58.6%) stddev-sans-first:29342.93 01:19:09 INFO - PROCESS | 2178 | Values: 694.5 707.8 758.7 760.5 791.2 13730.8 14397.4 14416.8 14424.6 14467.8 12808.6 12859.5 12867.3 12884.4 12898.6 666.3 683.8 690.6 812.4 835.9 811.0 834.8 835.6 853.4 854.1 892.6 900.0 900.6 902.0 902.8 701.8 887.9 890.1 891.5 893.9 535.5 633.9 653.7 656.5 662.8 12684.2 12973.9 13940.5 13949.4 14206.4 12531.0 12774.5 13233.8 13253.3 13425.6 10062.8 10119.7 10499.9 10838.7 11063.0 4191.3 4233.0 4246.3 4376.3 4378.7 105669.5 106686.5 107527.0 109569.5 110773.3 9286.0 9327.9 9331.7 9411.4 9717.5 17621.0 17622.0 18428.0 18697.4 18780.3 7267.7 7334.3 7355.7 7558.7 7574.3 4062.0 4067.3 4069.2 4126.4 4148.0 3192.5 3305.9 3345.1 3348.4 3354.5 624.4 624.5 625.6 638.8 642.9 533.3 556.4 571.4 616.0 622.0 7895.5 8510.2 8552.9 8665.5 8685.8 575.2 608.1 614.5 626.4 633.5 3318.7 4050.3 4234.9 4289.4 4313.7 88074.6 90557.1 93633.1 95889.0 107129.9 83608.7 86451.1 89340.0 91996.0 92587.0 72036.2 74284.6 75395.0 76083.2 77658.0 9444.7 9589.1 9625.2 9649.4 9742.4 48804.0 49827.8 50122.7 52020.5 53890.5 72878.3 74254.3 74440.0 75324.6 76020.2 9850.5 12499.8 12520.7 12588.6 12677.6 12222.9 14024.5 14122.6 14682.0 14976.9 12252.4 12930.5 13000.2 13024.4 13865.7 11222.4 13126.4 13603.3 13763.5 13913.7 13050.6 13233.8 13350.8 13513.9 13654.9 9128.6 10277.7 10704.9 10788.4 10857.7 10704.3 11109.1 11359.4 11377.0 11422.9 01:19:09 INFO - PROCESS | 2178 | -------- Summary: end -------- 01:19:09 INFO - PROCESS | 2178 | 01:19:09 INFO - TEST-INFO | 2178: exit 0 01:19:09 INFO - TEST-OK | dromaeo_css | took 1120893ms 01:19:09 INFO - TEST-START | kraken 01:19:09 INFO - operating with platform_type : mac_ 01:19:09 INFO - Initialising browser for kraken test... 01:19:09 INFO - TEST-INFO | started process 2181 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmpssQv7N/profile http://localhost:56028/getInfo.html) 01:19:12 INFO - PROCESS | 2181 | __metrics Screen width/height:1600/1200 01:19:12 INFO - PROCESS | 2181 | colorDepth:24 01:19:12 INFO - PROCESS | 2181 | Browser inner width/height: 1024/689 01:19:12 INFO - PROCESS | 2181 | __metrics 01:19:12 INFO - PROCESS | 2181 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:19:12 INFO - PROCESS | 2181 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:19:13 INFO - TEST-INFO | 2181: exit 0 01:19:13 INFO - Browser initialized. 01:19:13 INFO - Running cycle 1/1 for kraken test... 01:19:13 INFO - TEST-INFO | started process 2182 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmpssQv7N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:19:25 INFO - PROCESS | 2182 | RSS: Main: 245170176 01:19:25 INFO - PROCESS | 2182 | 01:19:28 INFO - PROCESS | 2182 | Cycle 1(1): loaded http://localhost:56028/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56028/tests/kraken/driver.html?testName=audio-beat-detection) 01:19:29 INFO - PROCESS | 2182 | RSS: Main: 295276544 01:19:29 INFO - PROCESS | 2182 | 01:19:32 INFO - PROCESS | 2182 | Cycle 1(1): loaded http://localhost:56028/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56028/tests/kraken/driver.html?testName=audio-dft) 01:19:32 INFO - PROCESS | 2182 | RSS: Main: 296185856 01:19:32 INFO - PROCESS | 2182 | 01:19:36 INFO - PROCESS | 2182 | Cycle 1(1): loaded http://localhost:56028/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56028/tests/kraken/driver.html?testName=audio-fft) 01:19:36 INFO - PROCESS | 2182 | RSS: Main: 387256320 01:19:36 INFO - PROCESS | 2182 | 01:19:38 INFO - PROCESS | 2182 | Cycle 1(1): loaded http://localhost:56028/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56028/tests/kraken/driver.html?testName=audio-oscillator) 01:19:39 INFO - PROCESS | 2182 | RSS: Main: 290189312 01:19:39 INFO - PROCESS | 2182 | 01:19:41 INFO - PROCESS | 2182 | Cycle 1(1): loaded http://localhost:56028/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56028/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:19:42 INFO - PROCESS | 2182 | RSS: Main: 293203968 01:19:42 INFO - PROCESS | 2182 | 01:19:45 INFO - PROCESS | 2182 | Cycle 1(1): loaded http://localhost:56028/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56028/tests/kraken/driver.html?testName=imaging-darkroom) 01:19:45 INFO - PROCESS | 2182 | RSS: Main: 335642624 01:19:45 INFO - PROCESS | 2182 | 01:19:48 INFO - PROCESS | 2182 | Cycle 1(1): loaded http://localhost:56028/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56028/tests/kraken/driver.html?testName=imaging-desaturate) 01:19:49 INFO - PROCESS | 2182 | RSS: Main: 336711680 01:19:49 INFO - PROCESS | 2182 | 01:19:51 INFO - PROCESS | 2182 | Cycle 1(1): loaded http://localhost:56028/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56028/tests/kraken/driver.html?testName=json-parse-financial) 01:19:52 INFO - PROCESS | 2182 | RSS: Main: 335331328 01:19:52 INFO - PROCESS | 2182 | 01:19:54 INFO - PROCESS | 2182 | Cycle 1(1): loaded http://localhost:56028/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56028/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:19:54 INFO - PROCESS | 2182 | RSS: Main: 311689216 01:19:54 INFO - PROCESS | 2182 | 01:19:56 INFO - PROCESS | 2182 | Cycle 1(1): loaded http://localhost:56028/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56028/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:19:57 INFO - PROCESS | 2182 | RSS: Main: 316452864 01:19:57 INFO - PROCESS | 2182 | 01:19:59 INFO - PROCESS | 2182 | Cycle 1(1): loaded http://localhost:56028/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56028/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:20:00 INFO - PROCESS | 2182 | RSS: Main: 317313024 01:20:00 INFO - PROCESS | 2182 | 01:20:03 INFO - PROCESS | 2182 | Cycle 1(1): loaded http://localhost:56028/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56028/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:20:03 INFO - PROCESS | 2182 | RSS: Main: 335036416 01:20:03 INFO - PROCESS | 2182 | 01:20:06 INFO - PROCESS | 2182 | Cycle 1(1): loaded http://localhost:56028/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56028/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:20:07 INFO - PROCESS | 2182 | RSS: Main: 329179136 01:20:07 INFO - PROCESS | 2182 | 01:20:09 INFO - PROCESS | 2182 | Cycle 1(1): loaded http://localhost:56028/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56028/tests/kraken/driver.html?testName=ai-astar) 01:20:09 INFO - PROCESS | 2182 | RSS: Main: 373710848 01:20:09 INFO - PROCESS | 2182 | 01:20:09 INFO - PROCESS | 2182 | __start_tp_report 01:20:09 INFO - PROCESS | 2182 | _x_x_mozilla_page_load 01:20:09 INFO - PROCESS | 2182 | _x_x_mozilla_page_load_details 01:20:09 INFO - PROCESS | 2182 | |i|pagename|runs| 01:20:09 INFO - PROCESS | 2182 | |0;ai-astar;113;115;114;119;167;172;114;119;164;170 01:20:09 INFO - PROCESS | 2182 | |1;audio-beat-detection;150;114;110;150;120;114;118;117;136;114 01:20:09 INFO - PROCESS | 2182 | |2;audio-dft;184;183;184;184;182;183;210;242;185;183 01:20:09 INFO - PROCESS | 2182 | |3;audio-fft;81;60;59;88;62;58;60;58;73;57 01:20:09 INFO - PROCESS | 2182 | |4;audio-oscillator;89;71;86;70;69;69;82;67;72;108 01:20:09 INFO - PROCESS | 2182 | |5;imaging-gaussian-blur;88;86;87;85;88;91;135;85;88;87 01:20:09 INFO - PROCESS | 2182 | |6;imaging-darkroom;93;94;97;94;94;97;98;93;93;92 01:20:09 INFO - PROCESS | 2182 | |7;imaging-desaturate;85;85;85;88;87;85;84;85;88;87 01:20:09 INFO - PROCESS | 2182 | |8;json-parse-financial;57;55;54;54;56;57;57;55;55;56 01:20:09 INFO - PROCESS | 2182 | |9;json-stringify-tinderbox;66;68;78;76;74;71;75;74;71;72 01:20:09 INFO - PROCESS | 2182 | |10;stanford-crypto-aes;88;89;89;88;89;99;108;87;92;87 01:20:09 INFO - PROCESS | 2182 | |11;stanford-crypto-ccm;151;149;150;145;150;144;148;151;188;148 01:20:09 INFO - PROCESS | 2182 | |12;stanford-crypto-pbkdf2;176;178;174;174;174;173;174;174;173;172 01:20:09 INFO - PROCESS | 2182 | |13;stanford-crypto-sha256-iterative;71;69;71;69;68;70;67;68;69;69 01:20:09 INFO - PROCESS | 2182 | __end_tp_report 01:20:09 INFO - PROCESS | 2182 | __start_cc_report 01:20:09 INFO - PROCESS | 2182 | _x_x_mozilla_cycle_collect,2018 01:20:09 INFO - PROCESS | 2182 | __end_cc_report 01:20:09 INFO - PROCESS | 2182 | __startTimestamp1480584009404__endTimestamp 01:20:09 INFO - PROCESS | 2182 | 01:20:09 INFO - PROCESS | 2182 | ------- Summary: start ------- 01:20:09 INFO - PROCESS | 2182 | Number of tests: 14 01:20:09 INFO - PROCESS | 2182 | 01:20:09 INFO - PROCESS | 2182 | [#0] ai-astar Cycles:10 Average:136.70 Median:141.50 stddev:27.30 (19.3%) stddev-sans-first:27.58 01:20:09 INFO - PROCESS | 2182 | Values: 113.0 115.0 114.0 119.0 167.0 172.0 114.0 119.0 164.0 170.0 01:20:09 INFO - PROCESS | 2182 | 01:20:09 INFO - PROCESS | 2182 | [#1] audio-beat-detection Cycles:10 Average:124.30 Median:119.00 stddev:15.25 (12.8%) stddev-sans-first:13.03 01:20:09 INFO - PROCESS | 2182 | Values: 150.0 114.0 110.0 150.0 120.0 114.0 118.0 117.0 136.0 114.0 01:20:09 INFO - PROCESS | 2182 | 01:20:09 INFO - PROCESS | 2182 | [#2] audio-dft Cycles:10 Average:192.00 Median:184.00 stddev:19.46 (10.6%) stddev-sans-first:20.42 01:20:09 INFO - PROCESS | 2182 | Values: 184.0 183.0 184.0 184.0 182.0 183.0 210.0 242.0 185.0 183.0 01:20:09 INFO - PROCESS | 2182 | 01:20:09 INFO - PROCESS | 2182 | [#3] audio-fft Cycles:10 Average:65.60 Median:61.00 stddev:11.07 (18.1%) stddev-sans-first:10.24 01:20:09 INFO - PROCESS | 2182 | Values: 81.0 60.0 59.0 88.0 62.0 58.0 60.0 58.0 73.0 57.0 01:20:09 INFO - PROCESS | 2182 | 01:20:09 INFO - PROCESS | 2182 | [#4] audio-oscillator Cycles:10 Average:78.30 Median:71.50 stddev:13.05 (18.2%) stddev-sans-first:13.25 01:20:09 INFO - PROCESS | 2182 | Values: 89.0 71.0 86.0 70.0 69.0 69.0 82.0 67.0 72.0 108.0 01:20:09 INFO - PROCESS | 2182 | 01:20:09 INFO - PROCESS | 2182 | [#5] imaging-gaussian-blur Cycles:10 Average:92.00 Median:87.50 stddev:15.21 (17.4%) stddev-sans-first:16.06 01:20:09 INFO - PROCESS | 2182 | Values: 88.0 86.0 87.0 85.0 88.0 91.0 135.0 85.0 88.0 87.0 01:20:09 INFO - PROCESS | 2182 | 01:20:09 INFO - PROCESS | 2182 | [#6] imaging-darkroom Cycles:10 Average:94.50 Median:94.00 stddev:2.07 (2.2%) stddev-sans-first:2.12 01:20:09 INFO - PROCESS | 2182 | Values: 93.0 94.0 97.0 94.0 94.0 97.0 98.0 93.0 93.0 92.0 01:20:09 INFO - PROCESS | 2182 | 01:20:09 INFO - PROCESS | 2182 | [#7] imaging-desaturate Cycles:10 Average:85.90 Median:86.00 stddev:1.45 (1.7%) stddev-sans-first:1.50 01:20:09 INFO - PROCESS | 2182 | Values: 85.0 85.0 85.0 88.0 87.0 85.0 84.0 85.0 88.0 87.0 01:20:09 INFO - PROCESS | 2182 | 01:20:09 INFO - PROCESS | 2182 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:1.17 (2.1%) stddev-sans-first:1.13 01:20:09 INFO - PROCESS | 2182 | Values: 57.0 55.0 54.0 54.0 56.0 57.0 57.0 55.0 55.0 56.0 01:20:09 INFO - PROCESS | 2182 | 01:20:09 INFO - PROCESS | 2182 | [#9] json-stringify-tinderbox Cycles:10 Average:72.50 Median:74.00 stddev:3.66 (4.9%) stddev-sans-first:3.03 01:20:09 INFO - PROCESS | 2182 | Values: 66.0 68.0 78.0 76.0 74.0 71.0 75.0 74.0 71.0 72.0 01:20:09 INFO - PROCESS | 2182 | 01:20:09 INFO - PROCESS | 2182 | [#10] stanford-crypto-aes Cycles:10 Average:91.60 Median:89.00 stddev:6.77 (7.6%) stddev-sans-first:7.05 01:20:09 INFO - PROCESS | 2182 | Values: 88.0 89.0 89.0 88.0 89.0 99.0 108.0 87.0 92.0 87.0 01:20:09 INFO - PROCESS | 2182 | 01:20:09 INFO - PROCESS | 2182 | [#11] stanford-crypto-ccm Cycles:10 Average:152.40 Median:150.00 stddev:12.73 (8.5%) stddev-sans-first:13.49 01:20:09 INFO - PROCESS | 2182 | Values: 151.0 149.0 150.0 145.0 150.0 144.0 148.0 151.0 188.0 148.0 01:20:09 INFO - PROCESS | 2182 | 01:20:09 INFO - PROCESS | 2182 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.20 Median:174.00 stddev:1.69 (1.0%) stddev-sans-first:1.66 01:20:09 INFO - PROCESS | 2182 | Values: 176.0 178.0 174.0 174.0 174.0 173.0 174.0 174.0 173.0 172.0 01:20:09 INFO - PROCESS | 2182 | 01:20:09 INFO - PROCESS | 2182 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:1.29 (1.9%) stddev-sans-first:1.17 01:20:09 INFO - PROCESS | 2182 | Values: 71.0 69.0 71.0 69.0 68.0 70.0 67.0 68.0 69.0 69.0 01:20:09 INFO - PROCESS | 2182 | -------- Summary: end -------- 01:20:09 INFO - PROCESS | 2182 | 01:20:10 INFO - TEST-INFO | 2182: exit 0 01:20:10 INFO - TEST-OK | kraken | took 60633ms 01:20:10 INFO - SUITE-END | took 1181s 01:20:10 INFO - Completed test suite (00:19:41) 01:20:10 INFO - javascript benchmark 01:20:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3153.511205763107, 3270.738340932726, 3316.1378041709163, 3321.9003429897098, 3337.399268131738, 4562.885927851797, 5496.367917689467, 5566.248556444879, 5612.69130197839, 5682.090865461532, 5535.501804837564, 5620.213170156181, 5627.015272327347, 5632.802851900185, 5664.971675141618, 4946.505349465061, 5075.9746201268945, 5096.541311281984, 5137.511936366058, 5143.0, 5063.493650634926, 5237.6071794615555, 5238.764255608507, 5243.003829272445, 5261.526462618363, 5183.092958732244, 5183.896322073538, 5226.1899405592, 5241.10901146804, 5272.551833094191, 4210.936835947463, 4587.288970209623, 4967.900641987176, 5057.963117560891, 5099.260607211971, 5093.821716239914, 5114.514121158484, 5115.335006449175, 5132.358455193101, 5161.483851614846, 5576.10782274834, 5577.386487486373, 5578.665280083167, 5619.269494965669, 5631.887362252773, 5898.557608179361, 5952.553558483131, 5965.761369545213, 6127.142200091991, 6158.414950579688, 4738.881527961828, 6095.238095238095, 6144.003198960311, 6196.473299769525, 6197.721102550396, 5617.634853734494, 5680.943190568124, 5698.800541981011, 5700.23046888673, 5704.172894930253, 6127.494965205055, 6282.089097080989, 6282.4974002079725, 6298.338674439118, 6307.590006649553, 5817.563682723812, 5862.618929769551, 5955.166276721263, 5969.403059694083, 5970.253718285215, 6155.84610384744, 6164.722587483574, 6186.4741496973265, 6189.690515474208, 6199.845003874939, 6032.4570788629235, 6072.726727297282, 6092.086187071975, 6092.786752463731, 6135.049067394561, 5917.704114794243, 5975.940240597538, 5988.610740301867, 6099.512039036867, 6118.908216376758, 4795.017021510582, 4842.15262329091, 4849.830255941025, 4855.441624213261, 4864.902701945941, 4308.763018034038, 4385.276429389115, 4435.2016637005645, 4442.022754993896, 4442.48911375196, 5644.266245388156, 5646.265985421869, 5647.943520564824, 5659.971700141473, 5660.603757737002, 6094.169091873587, 6111.13596929516, 6116.853194528077, 6127.403330890726, 6135.477655820289, 5666.036773748473, 5743.368229494752, 5748.051571490741, 5757.424257574293, 5759.539236861041, 4536.546345365503, 5282.9170020145775, 5332.413434522199, 5345.492178243061, 5349.144136938071, 6325.841853953688, 6326.0, 6330.651814150266, 6333.050042493663, 6342.619442833445, 6040.879182416239, 6112.786052488142, 6114.145302971568, 6115.480184184395, 6142.959235178615, 6301.873962520633, 6329.46199573023, 6342.112104305494, 6348.873022539431, 6358.650274234961, 6100.6949652516305, 6112.663803490673, 6119.112728654409, 6125.84685382869, 6134.294556126102, 5983.34183239852, 6035.69821508914, 6103.755849765959, 6111.77406523465, 6225.750969961151, 6012.549058820518, 6013.789517366871, 6013.849653758691, 6019.398060193946, 6075.119107729266, 4960.181570040902, 5708.34354049273, 6032.788852390146, 6035.849103772441, 6040.84897877539, 5635.211070450058, 5728.1694154348215, 5746.281714785652, 5814.592978491465, 5824.330202026652, 5904.61619994699, 5952.077427998667, 6038.7282572283475, 6041.063635136561, 6053.636781793107, 5798.6810725410505, 5812.883742325214, 5815.738291776965, 5849.502792262705, 5878.882422351615], "value": 5581.932269306101, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [458.2667731629392, 490.2205493265707, 499.2984856276932, 502.5828562293297, 567.3787203012699, 36668.0, 38630.22739545207, 38830.02924926878, 38841.61158388415, 38862.83411497656, 31768.0, 39286.41070383939, 39416.80291598545, 39971.60028399715, 40065.798026059194, 8423.831523369528, 8547.786305342353, 8649.437786543855, 8853.778655533615, 9518.000609935962, 9488.478133702643, 11108.389038602874, 11388.601398951037, 11511.079113670887, 11515.25150865191, 11291.830622540669, 11369.0, 11379.658610241706, 11402.543898244101, 11445.771084578304, 8461.492310461392, 8686.478811271281, 11283.717907052349, 11299.435028248554, 11324.0, 9464.0, 10998.670039898816, 11278.943605282004, 11433.828492572618, 11485.712857178554, 38994.41508377377, 39397.01507462308, 39403.40894886579, 39429.0, 39535.60464395348, 3194.0577529628818, 3209.951850722241, 3308.3217940322415, 3491.493733408667, 3606.8196590170387, 29540.643099660432, 29627.851860740775, 29757.702422975708, 29961.70038299633, 30900.690993090007, 3129.640091389497, 3138.8744450221966, 3141.27750617357, 3152.0386282183927, 3261.6086069671555, 446155.7692211551, 463694.0, 464647.0, 468750.65624672, 470784.0, 58266.0, 58512.0, 58539.536511587554, 58645.70677146672, 58718.41281587215, 56787.86424271574, 56879.0, 56944.715276424184, 56973.0, 57062.0, 15022.0, 15492.612684682974, 15495.690086198438, 15499.5350139496, 15503.302351394213, 10828.729281768019, 11120.332780033063, 11136.109111271078, 11776.293422394683, 12028.21816581937, 16600.08699521538, 16633.168341582874, 16673.83326166747, 16836.32654693823, 17037.40369087076, 6610.140681711443, 6645.435138013227, 6683.632400217937, 6707.228668703064, 6721.831954201184, 838.9119142489951, 926.2682480840195, 939.5912777941618, 957.818014577228, 1049.9107575856137, 23997.880010599834, 26070.34824129412, 27316.0, 28983.85508072446, 29636.851815741215, 986.7187851462298, 993.7068564773409, 1026.2816028779885, 1044.770150566874, 1062.0759938853248, 14142.292885355691, 14515.85484145166, 15179.848201517843, 15201.163935983406, 15502.767458488132, 512102.0, 592767.0, 595871.0, 600082.0, 603112.0, 55553.72223138859, 55858.44141558532, 55858.720706396205, 56036.0, 56295.155572666445, 1202.8015377462796, 1221.3038568016145, 1322.9536966206138, 1337.2043634037732, 1350.1696456679267, 24061.0, 25455.981760730105, 26381.736182638695, 30185.698143019166, 30993.225169370948, 47607.28589071098, 52654.0, 54163.18755218753, 54512.72743636256, 56760.0, 547756.0, 548529.0, 549032.0, 551984.0, 555112.0, 24895.0, 25127.623085654097, 25366.49267014686, 25602.359941001625, 25719.742802571735, 43886.34170487509, 44359.609471171134, 44662.77668611636, 45071.32393014173, 45456.772716136205, 30129.548056779604, 32282.35435291328, 36532.81733591315, 36976.63023369732, 38256.61743382642, 36697.63302366942, 37428.0, 37664.44511714027, 38215.0, 38457.42313865238, 35834.28331433409, 37070.8146459266, 37453.4381984265, 37499.625003749614, 37536.624633753316, 24565.50868982646, 30166.84916575403, 31855.20361990876, 33146.66853331532, 33251.667483324854, 24476.69870501266, 24493.020279189346, 24937.750622493542, 24948.750512494644, 25023.87488062548], "value": 19295.077457561118, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.1852465231358, 365.9798711070891, 370.8776103885716, 378.57599488572794, 397.60438363827996, 14257.215853128087, 14989.775153372708, 19312.613747725038, 20124.0, 20212.090455929465, 11409.201355905068, 11509.654710358682, 11633.534658613666, 11783.113137281356, 11848.0, 5105.259737338084, 5312.867178320535, 5325.3077099976945, 5369.033573956686, 5369.382521010075, 4968.155413579682, 5292.788288468457, 5323.973380133094, 5332.413434522199, 5333.599980001496, 5213.0, 5219.478052194788, 5320.973395133019, 5339.305890234284, 5347.010803001457, 5314.415414304423, 5749.511291540203, 5794.565407594448, 5805.448482394187, 5823.505002074829, 4917.262410638397, 5163.7676304566385, 5164.974175129138, 5167.844964651066, 5170.922436163461, 12958.352082395937, 13245.403956821967, 13258.933705331508, 13261.204327740366, 13274.004449666218, 2072.295419557358, 2088.0, 2092.780258072911, 2117.8411619128474, 2134.285014520122, 9835.0, 10316.948415257952, 10352.689419317358, 10446.744959271682, 12053.0960177987, 1606.8152162501344, 1682.1337011438995, 1826.0, 1861.525311045688, 1899.6675581773272, 109080.0, 121393.0, 126830.99999999908, 127948.0, 128237.0, 11117.277376970633, 11181.385023823605, 11435.371054592077, 11478.713032174262, 11516.251443656136, 12870.16343937641, 13201.53794617203, 13365.799513007312, 13461.990350723734, 13993.720125597634, 7869.134395216522, 7884.566348850868, 7972.3622110231045, 8173.18268173178, 8386.622601982925, 8070.636821342936, 8112.594370281462, 8136.430449868452, 8216.699324189118, 8295.336373090138, 4066.755994640331, 4238.724482908601, 4259.744415335028, 4265.445492086009, 4384.364267181241, 1785.5326322316291, 1873.1664409337986, 1882.2471011595471, 1885.5003424092627, 1924.6054558815408, 812.6911773526023, 836.2599099796602, 886.8448021596324, 920.9676618151084, 952.8142012307673, 15500.844991550166, 18548.0, 19186.944718040642, 20899.955002249826, 21013.05441255147, 904.7918978634951, 917.4403613795579, 926.2173463423396, 934.500042477285, 936.5598168860624, 10343.224258180666, 10519.737006574896, 10990.560377584807, 11051.281666691639, 11078.0, 486527.0, 494058.52970734914, 495515.0, 505353.47323263885, 511916.0, 116321.62301335455, 120367.0, 122465.38767306284, 122821.0, 126413.36793316159, 934.5700977550403, 981.4062492192263, 986.2800155886387, 999.2156157416393, 1000.8798944126752, 18799.154038068045, 19194.0, 19207.615847683246, 19212.135453904888, 19297.0, 37992.620073798906, 42294.731158065304, 53459.198112027574, 53669.0, 54235.18647220216, 77240.61379693066, 79409.20590794018, 79699.60150199212, 81448.0, 82574.17425825905, 7252.238514956065, 8025.03699556057, 8175.877361839696, 8259.297959673495, 8304.003519577689, 8114.959425202836, 9407.165602707406, 11661.475233614337, 12485.313307767796, 12954.611361659165, 10774.407407592658, 10817.405042722727, 11048.447577621248, 11090.112790976864, 11170.0, 7294.379977701955, 8075.192480751878, 8160.26557609818, 10878.728031799268, 11064.28082174656, 6833.829154271183, 7678.469702875331, 7865.4155549560455, 8131.9593402032615, 8173.836523269621, 10170.542325595217, 11012.724681883017, 11964.683884772494, 12021.699457513632, 12354.567590134302, 11382.601608943647, 11505.712357191138, 11652.88347116518, 12002.339871307162, 12035.338056406981], "value": 8829.71817497758, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1382.3572039001863, 1460.5837336359136, 1623.5778697538644, 1817.482017624977, 1848.1498510685076, 7794.298513133816, 8182.91817081829, 8188.590570471475, 8189.91810081899, 8195.959020204898, 7200.855982880339, 7457.925420745804, 7459.104907411118, 7790.688372465094, 7984.321332686729, 2253.312739614417, 2288.3592594073684, 2288.5079707862806, 2293.2317673579287, 2295.5638428698576, 2279.7036385269976, 2299.275728145629, 2311.90752369905, 2316.9805285674333, 2319.6868422762964, 1863.6272745450897, 2262.468319944812, 2287.1994801819396, 2298.436882963668, 2300.160441438871, 2191.3973657244305, 2225.833062520301, 2237.59723249815, 2238.798508134276, 2239.9664005039936, 2220.123051394706, 2275.5448910217856, 2276.829237807171, 2277.4078739527677, 2287.977120228793, 7957.482763620404, 8020.799480012988, 8087.878681819719, 8096.595170241464, 8104.189581041907, 4929.383827021622, 4960.206366981266, 4972.453030166679, 5019.071471777696, 5084.694918304914, 3048.84755762211, 3112.766542509321, 3326.8502917368533, 3336.0492259705866, 3338.96661033389, 960.9423434593947, 967.908048735369, 986.6645340584164, 1016.9440680762555, 1021.4994652620163, 10358.792824143475, 10381.325213861075, 10588.57645694179, 10592.841107383472, 10594.993475619804, 4262.381954616625, 4572.9314060289125, 4605.286180642006, 4610.749421657723, 4612.469565999953, 9077.409968352036, 9081.500517471603, 9083.545822708838, 9085.863712044325, 9091.227245684191, 4286.507051689034, 5071.340725705634, 5073.315102461121, 5074.112030394666, 5079.720615366116, 3889.4554762333296, 4101.048722415477, 4541.455025396974, 4674.6260299176665, 4675.111728771522, 3192.4732419151046, 3607.206414588786, 3654.8720794772057, 3747.793871337048, 3750.0812300985885, 1192.3680449361852, 1199.2744389644315, 1211.0614273937592, 1218.226426219357, 1221.8594861590852, 747.8242612986053, 840.260570697782, 893.2050475077186, 898.9190972812347, 918.8070505193984, 4957.0, 5525.11598144295, 5685.687287199161, 5756.856078597984, 5937.7921772737745, 941.3363578677016, 953.8903026151943, 976.4239098931664, 993.2252842782641, 1033.0547548992738, 2895.5946167536563, 3507.9649203508147, 3666.505021822073, 3787.772733635991, 3808.1241314497265, 9449.055094490495, 9860.30977831545, 9915.752106197402, 9920.603175872884, 9935.453550054672, 9834.409935403755, 9854.950725246328, 9876.308658393988, 9879.80240395188, 9906.55420506079, 7215.386692131123, 7481.21447248042, 7515.21090285523, 7528.623568821647, 7662.65518051689, 5222.634415591024, 5499.835004949858, 5530.198121272473, 5593.758396608542, 5600.0759874620235, 8769.298456123368, 8811.251043661361, 9018.143276388733, 9119.316051296311, 9156.932427636817, 7480.915267286105, 8903.643854246016, 8921.643134274556, 9079.228265597498, 9306.441613503212, 6956.860862782817, 7180.281971802987, 7190.856182876418, 7339.743108991373, 7569.545827250383, 7495.737649182252, 7713.537187768752, 7722.575258360844, 7830.334421574002, 7836.059672839296, 6911.930880691129, 6943.965280173769, 7024.824379390556, 7026.086608740831, 7152.535085219444, 6857.417119544894, 6868.450523957971, 6889.311068893271, 6941.93058069433, 6966.233714291323, 6264.780732674334, 6428.485721142204, 6517.413432790882, 6576.934230657632, 6578.473722102316, 4650.232711602548, 4659.743714095757, 4696.953030469652, 4747.074320507468, 4826.420829500483, 4369.431973843507, 4511.300748384006, 4638.93041604383, 4794.113089078532, 4827.275908613596], "value": 4293.5689487196705, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.93722318313155, 307.5095223119126, 307.59244001697755, 315.451115059796, 317.37002050928885, 4209.894752631182, 5285.973570132149, 5327.227552004957, 5344.385395679498, 5345.4120046794915, 5170.276161337416, 5190.494756520614, 5244.475552444754, 5251.816186433466, 5263.86840328992, 3765.9246815063616, 3806.6574008339244, 3900.7375722081265, 3927.5286965564173, 3997.7601343919314, 3956.4460975463458, 4007.83968641254, 4012.8394864205397, 4062.5531191568903, 4062.573429789874, 3302.570665813441, 3844.3656796628525, 3932.9016774580577, 3946.3228128045607, 3956.9802150989203, 3228.2736384313575, 3741.663250307485, 3966.246413181501, 3973.443717879499, 3999.7400168988925, 2692.636494073314, 3109.2693217093965, 3131.7942592101977, 3277.852751536967, 3417.3507033663773, 5048.899022019576, 5059.822906198266, 5067.721275329855, 5069.366329208849, 5069.493050694938, 3608.1881576645305, 3701.2782507411066, 4093.3217380874, 4503.752293623849, 4505.594496495331, 4419.756913369763, 4927.7536123193695, 5307.840764777063, 5415.593830462692, 5453.836384908459, 3719.925601487955, 3719.962800372016, 3724.5976345257427, 3728.850845966158, 3753.680937120348, 4826.734529600871, 5159.896802063975, 5685.658860468344, 5721.5708821838525, 5746.913796293059, 3618.3125206210734, 3647.28877868813, 3753.1609511339793, 3796.981015094907, 3809.4095415210686, 3850.9229815403537, 3861.6331448512346, 3869.3808990561374, 3884.7280690351404, 3889.86385476507, 4151.6886233532605, 4456.353828694886, 4459.0413061192, 4490.259107247268, 4492.595666389975, 4901.142300097468, 5305.389880163753, 5417.59368047398, 5420.268263784417, 5480.780768769284, 1007.8488226765897, 1142.3317359344876, 1164.4119719541577, 1230.3725100198963, 1255.1465003797505, 744.6723441685641, 787.6455594982281, 810.6291081628808, 847.9146692233951, 849.1720572441943, 4167.333226683716, 4348.956510434855, 4762.285657151455, 5175.663581867242, 5178.97410512945, 4914.57477331577, 5264.394359720322, 5595.328560572757, 5616.971915140398, 5621.269234999506, 3873.0, 4630.32860235264, 4849.908770526603, 5087.465816089331, 5169.302144210484, 2627.6861569215394, 2668.198965698146, 2736.781057515394, 2817.60553522507, 2819.0, 4322.675799315001, 4997.575206107522, 5138.790320162366, 5511.338639363302, 5569.0, 5392.0, 5492.340919089735, 5566.916496252559, 5588.552915766729, 5906.40935906406, 5291.0, 5841.94158058414, 5876.08920617305, 5916.615419997686, 5941.287045554474, 5224.320838290998, 5704.286964129484, 5710.2862142232225, 5730.856728581819, 5771.538276937918, 4571.748553829439, 5500.559955203494, 5635.88728225425, 5650.63270887391, 5650.830475085754, 5312.335958005249, 5404.972975135099, 5820.912686309624, 5861.296644402699, 5873.970630146993, 3104.286014216698, 3766.0396598867114, 3787.3750831112557, 3806.3529200035505, 3831.501904752364, 5227.268182454535, 5400.297961265011, 5687.090065589486, 5742.253507044057, 5791.247137872049, 5478.260434841245, 5508.0360936835095, 5511.807086751945, 5514.80698175562, 5517.089680202722, 5263.447338029605, 5479.917801232905, 5505.082306377626, 5541.362743284574, 5544.306961629796, 3987.624269626974, 5382.30030096085, 5432.876096244596, 5488.725563721718, 5503.614746967834, 4932.695094286908, 5264.578833693372, 5420.430854760193, 5429.864253393696, 5432.837014889559, 4180.011291926287, 4830.4444988826735, 5412.377576578587, 5423.430539793423, 5424.864378390414], "value": 3953.3866230790754, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.5207806613437, 707.8159678483593, 758.6586036283674, 760.5056713136457, 791.2285521616423, 13730.794038089423, 14397.352119154637, 14416.783748243784, 14424.639384015418, 14467.782983255247, 12808.615741527768, 12859.485620575166, 12867.29229892358, 12884.3557822109, 12898.613041608744, 666.2970566052812, 683.8256244657605, 690.6132565763163, 812.3704129299796, 835.9122292159327, 810.9675612975474, 834.8121672623641, 835.5863847395548, 853.4026181672854, 854.1373213054798, 892.5849479991803, 900.0144841398658, 900.5677274908048, 902.0122965352928, 902.8058967322024, 701.8280521272321, 887.9023307436177, 890.132121181849, 891.527490430073, 893.9106089391074, 535.456511640685, 633.8763941031501, 653.7156336993376, 656.4846595422571, 662.7647185249264, 12684.175528590613, 12973.935130324287, 13940.51208207718, 13949.372278247503, 14206.431742730278, 12531.0, 12774.48902043917, 13233.801492977613, 13253.337333133304, 13425.597232083053, 10062.849057264148, 10119.675202998125, 10499.895001049968, 10838.72903177419, 11063.0, 4191.266528357525, 4232.978835105805, 4246.320588705792, 4376.343548467724, 4378.6934914555995, 105669.47165264124, 106686.46656766666, 107527.0, 109569.45215273953, 110773.33839992326, 9286.0, 9327.860082098774, 9331.72004839856, 9411.43531388119, 9717.514124293757, 17621.0, 17622.0, 18428.0, 18697.439076827715, 18780.342688005854, 7267.672954717051, 7334.266573342729, 7355.668994895243, 7558.735444259424, 7574.280443357872, 4062.0339994035426, 4067.262427192215, 4069.2268468990796, 4126.360414135814, 4148.045949431647, 3192.521121831744, 3305.8512366943546, 3345.1469875181674, 3348.430766769655, 3354.480055591387, 624.4161708802285, 624.4848000399688, 625.627751487864, 638.779621030753, 642.858571114354, 533.3280067115462, 556.3851943602342, 571.3600767140829, 615.9784407545715, 621.9937800622026, 7895.535381171496, 8510.234078932926, 8552.871706924401, 8665.480071195749, 8685.826283474422, 575.1832397994857, 608.0848323273445, 614.532954954238, 626.3579830673596, 633.5153607490273, 3318.7468920934857, 4050.250703619781, 4234.915301694011, 4289.356596510486, 4313.698041137153, 88074.55962720273, 90557.09442905619, 93633.12733745424, 95889.0, 107129.92870071356, 83608.70390916259, 86451.13548864557, 89340.0, 91996.0, 92587.0, 72036.19909502304, 74284.62857685678, 75395.0, 76083.23916760762, 77658.0, 9444.724962130025, 9589.089036541518, 9625.229981601595, 9649.421034737938, 9742.415455072718, 48804.02391952212, 49827.75086124546, 50122.749386252835, 52020.479795201565, 53890.461095390114, 72878.27121728715, 74254.25745742474, 74440.0, 75324.62337688277, 76020.23979760132, 9850.458224797418, 12499.812502812283, 12520.749585008067, 12588.622341329774, 12677.556285529961, 12222.938885305517, 14024.509142179975, 14122.646933826325, 14682.0, 14976.925115374353, 12252.448639811051, 12930.547430839875, 13000.219986800823, 13024.413901374272, 13865.722685546434, 11222.438878055902, 13126.358150885168, 13603.251821149932, 13763.518276860263, 13913.721725565634, 13050.608481745563, 13233.801492977806, 13350.771020949887, 13513.864861351261, 13654.949695689977, 9128.634854605742, 10277.691669249934, 10704.8929510707, 10788.406637635006, 10857.728556786144, 10704.30422022566, 11109.11127109813, 11359.375234361858, 11376.976072153546, 11422.885771142182], "value": 7116.978976478699, "unit": "score"}], "name": "dromaeo_css", "value": 6972.441111646744, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 119.0, 167.0, 172.0, 114.0, 119.0, 164.0, 170.0], "value": 136.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 114.0, 110.0, 150.0, 120.0, 114.0, 118.0, 117.0, 136.0, 114.0], "value": 124.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 184.0, 184.0, 182.0, 183.0, 210.0, 242.0, 185.0, 183.0], "value": 192.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 59.0, 88.0, 62.0, 58.0, 60.0, 58.0, 73.0, 57.0], "value": 65.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 86.0, 70.0, 69.0, 69.0, 82.0, 67.0, 72.0, 108.0], "value": 78.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 87.0, 85.0, 88.0, 91.0, 135.0, 85.0, 88.0, 87.0], "value": 92.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 97.0, 94.0, 94.0, 97.0, 98.0, 93.0, 93.0, 92.0], "value": 94.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 88.0, 87.0, 85.0, 84.0, 85.0, 88.0, 87.0], "value": 85.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 54.0, 54.0, 56.0, 57.0, 57.0, 55.0, 55.0, 56.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 78.0, 76.0, 74.0, 71.0, 75.0, 74.0, 71.0, 72.0], "value": 72.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 89.0, 88.0, 89.0, 99.0, 108.0, 87.0, 92.0, 87.0], "value": 91.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 150.0, 145.0, 150.0, 144.0, 148.0, 151.0, 188.0, 148.0], "value": 152.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 178.0, 174.0, 174.0, 174.0, 173.0, 174.0, 174.0, 173.0, 172.0], "value": 174.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 71.0, 69.0, 68.0, 70.0, 67.0, 68.0, 69.0, 69.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1484.7, "alertThreshold": 2.0}]} 01:20:10 INFO - Return code: 0 01:20:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:20:10 INFO - # TBPL SUCCESS # 01:20:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:20:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:20:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:20:10 INFO - 2016-12-01 01:20:10.730 screenresolution[2186:25912] starting screenresolution argv=screenresolution get 01:20:10 INFO - 2016-12-01 01:20:10.734 screenresolution[2186:25912] Display 0: 1600x1200x32@60 01:20:10 INFO - 2016-12-01 01:20:10.741 screenresolution[2187:25915] starting screenresolution argv=screenresolution list 01:20:10 INFO - Available Modes on Display 0 01:20:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:20:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:20:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:20:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:20:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:20:10 INFO - Intel Iris: 01:20:10 INFO - Chipset Model: Intel Iris 01:20:10 INFO - Type: GPU 01:20:10 INFO - Bus: Built-In 01:20:10 INFO - VRAM (Dynamic, Max): 1536 MB 01:20:10 INFO - Vendor: Intel (0x8086) 01:20:10 INFO - Device ID: 0x0a2e 01:20:10 INFO - Revision ID: 0x0009 01:20:10 INFO - Displays: 01:20:10 INFO - Display: 01:20:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:20:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:20:10 INFO - Display Serial Number: 1600x1200 60 01:20:10 INFO - Main Display: Yes 01:20:10 INFO - Mirror: Off 01:20:10 INFO - Online: Yes 01:20:10 INFO - Rotation: Supported 01:20:10 INFO - Return code: 0 01:20:10 INFO - Running post-action listener: _resource_record_post_action 01:20:10 INFO - [mozharness: 2016-12-01 09:20:10.988193Z] Finished run-tests step (success) 01:20:10 INFO - Running post-run listener: _resource_record_post_run 01:20:11 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 253952; Write bytes: 694490112; Read time: 3; Write time: 2131 01:20:11 INFO - TinderboxPrint: CPU usage
53.5% 01:20:11 INFO - TinderboxPrint: I/O read bytes / time
253,952 / 3 01:20:11 INFO - TinderboxPrint: I/O write bytes / time
694,490,112 / 2,131 01:20:11 INFO - TinderboxPrint: CPU idle
2,259.6 (46.5%) 01:20:11 INFO - TinderboxPrint: CPU system
974.0 (20.0%) 01:20:11 INFO - TinderboxPrint: CPU user
1,628.1 (33.5%) 01:20:11 INFO - TinderboxPrint: Swap in / out
383,401,984 / 0 01:20:11 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 362961408; Write bytes: 357500928; Read time: 27653; Write time: 783 01:20:11 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 253952; Write bytes: 307743744; Read time: 3; Write time: 1282 01:20:11 INFO - Running post-run listener: _upload_blobber_files 01:20:11 INFO - Blob upload gear active. 01:20:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:20:11 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 01:20:11 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:20:11 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:20:11 INFO - (blobuploader) - INFO - Open directory for files ... 01:20:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:20:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:20:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:20:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:20:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:20:12 INFO - (blobuploader) - INFO - Done attempting. 01:20:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:20:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:20:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:20:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:20:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:20:13 INFO - (blobuploader) - INFO - Done attempting. 01:20:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:20:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:20:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:20:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:20:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:20:16 INFO - (blobuploader) - INFO - Done attempting. 01:20:16 INFO - (blobuploader) - INFO - Iteration through files over. 01:20:16 INFO - Return code: 0 01:20:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:20:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:20:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7d4bc6d79d2d94a0940d664cf6b51fa41318011a37d7562d71f5bb5a3ade6bde9458e6ac54b4841f3904d4279fe9a21f2436feaa4dde480a6ff303d69965ebdb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/168a9a13fe7878cd1cb659eb9f8cadb55ccc7a17aec0d4bfbe30973cff613830026a6e3f44c8c20d2f9ceec47ffe092c5767fab7410603f27bdd2523274b6137", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/61a0e859f7787de4bde8b2bdd930e6e1b6a7f783a27a781cf55be85372d2ae5779cbcfb81a2dfbac96ec956068648a4883b4558e132e4e126d12157e65b2057c"} 01:20:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:20:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:20:16 INFO - Contents: 01:20:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7d4bc6d79d2d94a0940d664cf6b51fa41318011a37d7562d71f5bb5a3ade6bde9458e6ac54b4841f3904d4279fe9a21f2436feaa4dde480a6ff303d69965ebdb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/168a9a13fe7878cd1cb659eb9f8cadb55ccc7a17aec0d4bfbe30973cff613830026a6e3f44c8c20d2f9ceec47ffe092c5767fab7410603f27bdd2523274b6137", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/61a0e859f7787de4bde8b2bdd930e6e1b6a7f783a27a781cf55be85372d2ae5779cbcfb81a2dfbac96ec956068648a4883b4558e132e4e126d12157e65b2057c"} 01:20:16 INFO - Running post-run listener: copy_logs_to_upload_dir 01:20:16 INFO - Copying logs to upload dir... 01:20:16 INFO - mkdir: /builds/slave/test/build/upload/logs 01:20:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.100369 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-12-01 01:20:16.153151) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-01 01:20:16.157131) ========= 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.w36iOoTGmQ/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.orks0XGmwa/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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/Graphics/sha512/7d4bc6d79d2d94a0940d664cf6b51fa41318011a37d7562d71f5bb5a3ade6bde9458e6ac54b4841f3904d4279fe9a21f2436feaa4dde480a6ff303d69965ebdb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/168a9a13fe7878cd1cb659eb9f8cadb55ccc7a17aec0d4bfbe30973cff613830026a6e3f44c8c20d2f9ceec47ffe092c5767fab7410603f27bdd2523274b6137", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/61a0e859f7787de4bde8b2bdd930e6e1b6a7f783a27a781cf55be85372d2ae5779cbcfb81a2dfbac96ec956068648a4883b4558e132e4e126d12157e65b2057c"} build_url:https://queue.taskcluster.net/v1/task/JdR8dXiZR42XAcH5GCQhNw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011250 build_url: 'https://queue.taskcluster.net/v1/task/JdR8dXiZR42XAcH5GCQhNw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7d4bc6d79d2d94a0940d664cf6b51fa41318011a37d7562d71f5bb5a3ade6bde9458e6ac54b4841f3904d4279fe9a21f2436feaa4dde480a6ff303d69965ebdb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/168a9a13fe7878cd1cb659eb9f8cadb55ccc7a17aec0d4bfbe30973cff613830026a6e3f44c8c20d2f9ceec47ffe092c5767fab7410603f27bdd2523274b6137", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/61a0e859f7787de4bde8b2bdd930e6e1b6a7f783a27a781cf55be85372d2ae5779cbcfb81a2dfbac96ec956068648a4883b4558e132e4e126d12157e65b2057c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-01 01:20:16.192641) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 01:20:16.192965) ========= 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.w36iOoTGmQ/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.orks0XGmwa/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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.005336 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 01:20:16.241633) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-01 01:20:16.241941) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-01 01:20:16.242267) ========= ========= Total master_lag: 0.18 =========