builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0310 starttime: 1476863509.92 results: success (0) buildid: 20161018210123 builduid: 457a5f5bf89e4c7c8f6768a31fa1ed94 revision: 60f9486949afe160682b09b9df7dd13e881e718b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 00:51:49.915657) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 00:51:49.916113) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 00:51:49.916394) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 00:51:50.117924) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 00:51:50.121526) ========= 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.KRSbX6MkK7/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.ivR6zk7ZFh/Listeners TMPDIR=/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-19 00:51:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.5M=0.001s 2016-10-19 00:51:50 (18.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.483269 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 00:51:50.631290) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 00:51:50.631608) ========= 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.KRSbX6MkK7/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.ivR6zk7ZFh/Listeners TMPDIR=/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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.024215 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 00:51:50.681778) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-19 00:51:50.685155) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 60f9486949afe160682b09b9df7dd13e881e718b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 60f9486949afe160682b09b9df7dd13e881e718b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KRSbX6MkK7/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.ivR6zk7ZFh/Listeners TMPDIR=/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-19 00:51:50,768 truncating revision to first 12 chars 2016-10-19 00:51:50,768 Setting DEBUG logging. 2016-10-19 00:51:50,768 attempt 1/10 2016-10-19 00:51:50,768 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/60f9486949af?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-19 00:51:52,022 unpacking tar archive at: autoland-60f9486949af/testing/mozharness/ program finished with exit code 0 elapsedTime=1.509979 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-19 00:51:52.218251) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 00:51:52.218590) ========= script_repo_revision: 60f9486949afe160682b09b9df7dd13e881e718b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 00:51:52.219027) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 00:51:52.219309) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 00:51:52.242267) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-19 00:51:52.242670) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KRSbX6MkK7/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.ivR6zk7ZFh/Listeners TMPDIR=/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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:51:52 INFO - MultiFileLogger online at 20161019 00:51:52 in /builds/slave/test 00:51:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 00:51:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:51:52 INFO - {'append_to_log': False, 00:51:52 INFO - 'base_work_dir': '/builds/slave/test', 00:51:52 INFO - 'blob_upload_branch': 'Autoland', 00:51:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:51:52 INFO - 'branch': 'Autoland', 00:51:52 INFO - 'buildbot_json_path': 'buildprops.json', 00:51:52 INFO - 'config_files': ('talos/mac_config.py',), 00:51:52 INFO - 'default_actions': ('clobber', 00:51:52 INFO - 'read-buildbot-config', 00:51:52 INFO - 'download-and-extract', 00:51:52 INFO - 'populate-webroot', 00:51:52 INFO - 'create-virtualenv', 00:51:52 INFO - 'install', 00:51:52 INFO - 'run-tests'), 00:51:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:51:52 INFO - 'download_minidump_stackwalk': True, 00:51:52 INFO - 'download_symbols': 'ondemand', 00:51:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:51:52 INFO - 'tooltool.py': '/tools/tooltool.py', 00:51:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:51:52 INFO - '/tools/misc-python/virtualenv.py')}, 00:51:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:51:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:51:52 INFO - 'installer_path': 'installer.exe', 00:51:52 INFO - 'log_level': 'info', 00:51:52 INFO - 'log_name': 'talos', 00:51:52 INFO - 'log_to_console': True, 00:51:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:51:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:51:52 INFO - 'opt_config_files': (), 00:51:52 INFO - 'pip_index': False, 00:51:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:51:52 INFO - 'cmd': ('bash', 00:51:52 INFO - '-c', 00:51:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:51:52 INFO - 'enabled': True, 00:51:52 INFO - 'halt_on_failure': False, 00:51:52 INFO - 'name': 'check_screen_resolution'},), 00:51:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:51:52 INFO - 'cmd': ('bash', 00:51:52 INFO - '-c', 00:51:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:51:52 INFO - 'enabled': True, 00:51:52 INFO - 'halt_on_failure': False, 00:51:52 INFO - 'name': 'check_screen_resolution'},), 00:51:52 INFO - 'run_cmd_checks_enabled': True, 00:51:52 INFO - 'sps_profile': False, 00:51:52 INFO - 'sps_profile_interval': 0, 00:51:52 INFO - 'suite': 'dromaeojs', 00:51:52 INFO - 'system_bits': '32', 00:51:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:51:52 INFO - 'title': 't-yosemite-r7-0310', 00:51:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:51:52 INFO - 'use_talos_json': True, 00:51:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:51:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:51:52 INFO - 'work_dir': 'build'} 00:51:52 INFO - [mozharness: 2016-10-19 07:51:52.444239Z] Running clobber step. 00:51:52 INFO - Running pre-action listener: _resource_record_pre_action 00:51:52 INFO - Running main action method: clobber 00:51:52 INFO - rmtree: /builds/slave/test/build 00:51:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:51:54 INFO - Running post-action listener: _resource_record_post_action 00:51:54 INFO - [mozharness: 2016-10-19 07:51:54.594497Z] Finished clobber step (success) 00:51:54 INFO - [mozharness: 2016-10-19 07:51:54.594655Z] Running read-buildbot-config step. 00:51:54 INFO - Running pre-action listener: _resource_record_pre_action 00:51:54 INFO - Running main action method: read_buildbot_config 00:51:54 INFO - Using buildbot properties: 00:51:54 INFO - { 00:51:54 INFO - "project": "", 00:51:54 INFO - "product": "firefox", 00:51:54 INFO - "script_repo_revision": "production", 00:51:54 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 00:51:54 INFO - "repository": "", 00:51:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 00:51:54 INFO - "buildid": "20161018210123", 00:51:54 INFO - "pgo_build": "False", 00:51:54 INFO - "basedir": "/builds/slave/test", 00:51:54 INFO - "buildnumber": 391, 00:51:54 INFO - "slavename": "t-yosemite-r7-0310", 00:51:54 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 00:51:54 INFO - "platform": "yosemite_r7", 00:51:54 INFO - "scheduler": "tests-autoland-macosx64-talos", 00:51:54 INFO - "branch": "autoland", 00:51:54 INFO - "repo_path": "integration/autoland", 00:51:54 INFO - "revision": "60f9486949afe160682b09b9df7dd13e881e718b", 00:51:54 INFO - "stage_platform": "macosx64", 00:51:54 INFO - "builduid": "457a5f5bf89e4c7c8f6768a31fa1ed94", 00:51:54 INFO - "slavebuilddir": "test" 00:51:54 INFO - } 00:51:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/JvFhNxb0TuOX5YjTjDcuAw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 00:51:54 INFO - Running post-action listener: _resource_record_post_action 00:51:54 INFO - [mozharness: 2016-10-19 07:51:54.597861Z] Finished read-buildbot-config step (success) 00:51:54 INFO - [mozharness: 2016-10-19 07:51:54.597991Z] Running download-and-extract step. 00:51:54 INFO - Running pre-action listener: _resource_record_pre_action 00:51:54 INFO - Running main action method: download_and_extract 00:51:54 INFO - mkdir: /builds/slave/test/build/tests 00:51: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:51:54 INFO - trying https://queue.taskcluster.net/v1/task/JvFhNxb0TuOX5YjTjDcuAw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 00:51:54 INFO - Downloading https://queue.taskcluster.net/v1/task/JvFhNxb0TuOX5YjTjDcuAw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 00:51:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JvFhNxb0TuOX5YjTjDcuAw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 00:51:56 INFO - Downloaded 1199 bytes. 00:51:56 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 00:51:56 INFO - Using the following test package requirements: 00:51:56 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 00:51:56 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:51:56 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 00:51:56 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:51:56 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 00:51:56 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:51:56 INFO - u'jsshell-mac.zip'], 00:51:56 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:51:56 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 00:51:56 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 00:51:56 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:51:56 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 00:51:56 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:51:56 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 00:51:56 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:51:56 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 00:51:56 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:51:56 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 00:51:56 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 00:51:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JvFhNxb0TuOX5YjTjDcuAw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 00:51:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JvFhNxb0TuOX5YjTjDcuAw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 00:51:56 INFO - Fetch https://queue.taskcluster.net/v1/task/JvFhNxb0TuOX5YjTjDcuAw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 00:51:56 INFO - Http code: 200 00:51:56 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 00:51:56 INFO - x-amz-cf-id: IqwNhnk_D5XFpXLU7XYShoQSmGgSLWGb_vEVQE1E4KfpkPQtZE9fqg== 00:51:56 INFO - x-amz-version-id: .SxrC7coYCrIMnIb5YP7ZFDfR6jtFR5d 00:51:56 INFO - Expected file size: 16499981 00:51:56 INFO - Obtained file size: 16499981 00:52:03 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 00:52:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JvFhNxb0TuOX5YjTjDcuAw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 00:52:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JvFhNxb0TuOX5YjTjDcuAw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 00:52:03 INFO - Fetch https://queue.taskcluster.net/v1/task/JvFhNxb0TuOX5YjTjDcuAw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 00:52:04 INFO - Http code: 200 00:52:04 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 00:52:04 INFO - x-amz-cf-id: C2iFqYZV8ch5ucugHo3jGjfqmYCkGD7krXIcLigmvn7IpIJLoqoY2g== 00:52:04 INFO - x-amz-version-id: .SxrC7coYCrIMnIb5YP7ZFDfR6jtFR5d 00:52:04 INFO - Expected file size: 16499981 00:52:04 INFO - Obtained file size: 16499981 00:52:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JvFhNxb0TuOX5YjTjDcuAw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 00:52:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JvFhNxb0TuOX5YjTjDcuAw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 00:52:11 INFO - Fetch https://queue.taskcluster.net/v1/task/JvFhNxb0TuOX5YjTjDcuAw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 00:52:12 INFO - Http code: 200 00:52:12 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 00:52:12 INFO - x-amz-cf-id: UABLqWraSD-gyHwk3I6wIdojKHGl5OHT7Bjo7Ao9Rs-NUeXbaVXV_Q== 00:52:12 INFO - x-amz-version-id: NJEwjr2H0V_A19vQfjXO3SxjZEJsZI1e 00:52:12 INFO - Expected file size: 14409028 00:52:12 INFO - Obtained file size: 14409028 00:52:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:52:12 INFO - trying https://queue.taskcluster.net/v1/task/JvFhNxb0TuOX5YjTjDcuAw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 00:52:12 INFO - Downloading https://queue.taskcluster.net/v1/task/JvFhNxb0TuOX5YjTjDcuAw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 00:52:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JvFhNxb0TuOX5YjTjDcuAw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 00:52:15 INFO - Downloaded 111658875 bytes. 00:52:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JvFhNxb0TuOX5YjTjDcuAw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 00:52:15 INFO - mkdir: /builds/slave/test/properties 00:52:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:52:15 INFO - Writing to file /builds/slave/test/properties/build_url 00:52:15 INFO - Contents: 00:52:15 INFO - build_url:https://queue.taskcluster.net/v1/task/JvFhNxb0TuOX5YjTjDcuAw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 00:52:16 INFO - Running post-action listener: _resource_record_post_action 00:52:16 INFO - Running post-action listener: set_extra_try_arguments 00:52:16 INFO - [mozharness: 2016-10-19 07:52:16.127300Z] Finished download-and-extract step (success) 00:52:16 INFO - [mozharness: 2016-10-19 07:52:16.127451Z] Running populate-webroot step. 00:52:16 INFO - Running pre-action listener: _resource_record_pre_action 00:52:16 INFO - Running main action method: populate_webroot 00:52:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:52:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:52:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:52:16 INFO - '--tppagecycles', 00:52:16 INFO - '7'], 00:52:16 INFO - 'tests': ['tsvgm']}}, 00:52:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:52:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:52:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:52:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:52:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:52:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:52:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:16 INFO - 'talos_options': ['--disable-e10s'], 00:52:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:52:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:52:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:16 INFO - 'talos_options': ['--disable-e10s'], 00:52:16 INFO - 'tests': ['damp', 'tps']}, 00:52:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:16 INFO - 'tests': ['damp', 'tps']}, 00:52:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:52:16 INFO - 'tests': ['dromaeo_dom']}, 00:52:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:52:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:52:16 INFO - 'tests': ['basic_compositor_video']}, 00:52:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:52:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:52:16 INFO - 'tests': ['a11yr', 00:52:16 INFO - 'ts_paint', 00:52:16 INFO - 'tpaint', 00:52:16 INFO - 'sessionrestore', 00:52:16 INFO - 'sessionrestore_no_auto_restore', 00:52:16 INFO - 'tabpaint']}, 00:52:16 INFO - 'other-e10s': {'tests': ['a11yr', 00:52:16 INFO - 'ts_paint', 00:52:16 INFO - 'tpaint', 00:52:16 INFO - 'sessionrestore', 00:52:16 INFO - 'sessionrestore_no_auto_restore', 00:52:16 INFO - 'tabpaint']}, 00:52:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:52:16 INFO - 'ts_paint', 00:52:16 INFO - 'tpaint', 00:52:16 INFO - 'sessionrestore', 00:52:16 INFO - 'sessionrestore_no_auto_restore', 00:52:16 INFO - 'tabpaint']}, 00:52:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:52:16 INFO - 'ts_paint', 00:52:16 INFO - 'tpaint', 00:52:16 INFO - 'sessionrestore', 00:52:16 INFO - 'sessionrestore_no_auto_restore', 00:52:16 INFO - 'tabpaint']}, 00:52:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:52:16 INFO - 'tests': ['a11yr', 00:52:16 INFO - 'ts_paint', 00:52:16 INFO - 'tpaint', 00:52:16 INFO - 'sessionrestore', 00:52:16 INFO - 'sessionrestore_no_auto_restore', 00:52:16 INFO - 'tabpaint']}, 00:52:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:52:16 INFO - 'tests': ['a11yr', 00:52:16 INFO - 'ts_paint', 00:52:16 INFO - 'tpaint', 00:52:16 INFO - 'sessionrestore', 00:52:16 INFO - 'sessionrestore_no_auto_restore', 00:52:16 INFO - 'tabpaint']}, 00:52:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:52:16 INFO - 'tests': ['tsvgx', 00:52:16 INFO - 'tsvgr_opacity', 00:52:16 INFO - 'tart', 00:52:16 INFO - 'tscrollx', 00:52:16 INFO - 'cart']}, 00:52:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:52:16 INFO - 'tsvgr_opacity', 00:52:16 INFO - 'tart', 00:52:16 INFO - 'tscrollx', 00:52:16 INFO - 'cart']}, 00:52:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:16 INFO - 'talos_options': ['--disable-e10s'], 00:52:16 INFO - 'tests': ['tp5o']}, 00:52:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:16 INFO - 'tests': ['tp5o']}, 00:52:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:16 INFO - 'talos_options': ['--disable-e10s', 00:52:16 INFO - '--xperf_path', 00:52:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:52:16 INFO - 'tests': ['tp5n']}, 00:52:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:16 INFO - 'talos_options': ['--xperf_path', 00:52:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:52:16 INFO - 'tests': ['tp5n']}}, 00:52:16 INFO - 'talos.zip': {'path': '', 00:52:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:52:16 INFO - Running post-action listener: _resource_record_post_action 00:52:16 INFO - [mozharness: 2016-10-19 07:52:16.146024Z] Finished populate-webroot step (success) 00:52:16 INFO - [mozharness: 2016-10-19 07:52:16.146110Z] Running create-virtualenv step. 00:52:16 INFO - Running pre-action listener: _resource_record_pre_action 00:52:16 INFO - Running main action method: create_virtualenv 00:52:16 INFO - Creating virtualenv /builds/slave/test/build/venv 00:52:16 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:52:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:52:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:52:16 INFO - Using real prefix '/tools/python27' 00:52:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:52:16 INFO - Installing distribute.............................................................................................................................................................................................done. 00:52:19 INFO - Installing pip.................done. 00:52:19 INFO - Return code: 0 00:52:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:52:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:52:20 INFO - Reading from file tmpfile_stdout 00:52:20 INFO - Output received: 00:52:20 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:52:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:52:20 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:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:52:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:20 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:52:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:52:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:20 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 0x106d08490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c7e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffadbdb0710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b1cd30>, '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 0x106942db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b14b20>, '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.KRSbX6MkK7/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.ivR6zk7ZFh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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:52:20 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:52:20 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:52:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRSbX6MkK7/Render', 00:52:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:52:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:52:20 INFO - 'HOME': '/Users/cltbld', 00:52:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:52:20 INFO - 'LOGNAME': 'cltbld', 00:52:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:52:20 INFO - 'MOZ_NO_REMOTE': '1', 00:52:20 INFO - 'NO_EM_RESTART': '1', 00:52:20 INFO - 'PAGER': '/bin/cat', 00:52:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:52:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:52:20 INFO - 'PWD': '/builds/slave/test', 00:52:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:52:20 INFO - 'SHELL': '/bin/bash', 00:52:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ivR6zk7ZFh/Listeners', 00:52:20 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 00:52:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:52:20 INFO - 'USER': 'cltbld', 00:52:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:52:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:52:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:52:20 INFO - 'XPC_FLAGS': '0x0', 00:52:20 INFO - 'XPC_SERVICE_NAME': '0', 00:52:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:52:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:52:20 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:52:20 INFO - Cleaning up... 00:52:20 INFO - Return code: 0 00:52:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:52:20 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:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:52:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:20 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:52:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:52:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:20 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 0x106d08490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c7e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffadbdb0710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b1cd30>, '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 0x106942db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b14b20>, '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.KRSbX6MkK7/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.ivR6zk7ZFh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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:52:20 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:52:20 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:52:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRSbX6MkK7/Render', 00:52:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:52:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:52:20 INFO - 'HOME': '/Users/cltbld', 00:52:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:52:20 INFO - 'LOGNAME': 'cltbld', 00:52:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:52:20 INFO - 'MOZ_NO_REMOTE': '1', 00:52:20 INFO - 'NO_EM_RESTART': '1', 00:52:20 INFO - 'PAGER': '/bin/cat', 00:52:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:52:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:52:20 INFO - 'PWD': '/builds/slave/test', 00:52:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:52:20 INFO - 'SHELL': '/bin/bash', 00:52:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ivR6zk7ZFh/Listeners', 00:52:20 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 00:52:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:52:20 INFO - 'USER': 'cltbld', 00:52:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:52:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:52:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:52:20 INFO - 'XPC_FLAGS': '0x0', 00:52:20 INFO - 'XPC_SERVICE_NAME': '0', 00:52:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:52:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:52:20 INFO - Downloading/unpacking psutil>=3.1.1 00:52:20 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:52:20 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:52:20 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:52:20 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:52:20 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:52:20 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:52:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:52:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:52:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:52:24 INFO - Installing collected packages: psutil 00:52:24 INFO - Running setup.py install for psutil 00:52:24 INFO - building 'psutil._psutil_osx' extension 00:52:24 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:52:25 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:52:25 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:52:25 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:52:25 INFO - building 'psutil._psutil_posix' extension 00:52:25 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:52:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:52:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:52:25 INFO - ^ 00:52:25 INFO - 1 warning generated. 00:52:25 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:52:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:52:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:52:25 INFO - Successfully installed psutil 00:52:25 INFO - Cleaning up... 00:52:25 INFO - Return code: 0 00:52:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:52:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:52:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:52:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:52:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106d08490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c7e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffadbdb0710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b1cd30>, '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 0x106942db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b14b20>, '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.KRSbX6MkK7/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.ivR6zk7ZFh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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:52:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:52:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:52:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRSbX6MkK7/Render', 00:52:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:52:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:52:25 INFO - 'HOME': '/Users/cltbld', 00:52:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:52:25 INFO - 'LOGNAME': 'cltbld', 00:52:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:52:25 INFO - 'MOZ_NO_REMOTE': '1', 00:52:25 INFO - 'NO_EM_RESTART': '1', 00:52:25 INFO - 'PAGER': '/bin/cat', 00:52:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:52:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:52:25 INFO - 'PWD': '/builds/slave/test', 00:52:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:52:25 INFO - 'SHELL': '/bin/bash', 00:52:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ivR6zk7ZFh/Listeners', 00:52:25 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 00:52:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:52:25 INFO - 'USER': 'cltbld', 00:52:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:52:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:52:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:52:25 INFO - 'XPC_FLAGS': '0x0', 00:52:25 INFO - 'XPC_SERVICE_NAME': '0', 00:52:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:52:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:52:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:52:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:52:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:52:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:52:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:52:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:52:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:52:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:52:28 INFO - Installing collected packages: mozsystemmonitor 00:52:28 INFO - Running setup.py install for mozsystemmonitor 00:52:28 INFO - Successfully installed mozsystemmonitor 00:52:28 INFO - Cleaning up... 00:52:28 INFO - Return code: 0 00:52:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:52: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')]} 00:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:52:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52: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')]} 00:52:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:52:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:28 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 0x106d08490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c7e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffadbdb0710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b1cd30>, '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 0x106942db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b14b20>, '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.KRSbX6MkK7/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.ivR6zk7ZFh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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:52:28 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:52:28 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:52:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRSbX6MkK7/Render', 00:52:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:52:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:52:28 INFO - 'HOME': '/Users/cltbld', 00:52:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:52:28 INFO - 'LOGNAME': 'cltbld', 00:52:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:52:28 INFO - 'MOZ_NO_REMOTE': '1', 00:52:28 INFO - 'NO_EM_RESTART': '1', 00:52:28 INFO - 'PAGER': '/bin/cat', 00:52:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:52:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:52:28 INFO - 'PWD': '/builds/slave/test', 00:52:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:52:28 INFO - 'SHELL': '/bin/bash', 00:52:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ivR6zk7ZFh/Listeners', 00:52:28 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 00:52:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:52:28 INFO - 'USER': 'cltbld', 00:52:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:52:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:52:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:52:28 INFO - 'XPC_FLAGS': '0x0', 00:52:28 INFO - 'XPC_SERVICE_NAME': '0', 00:52:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:52:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:52:28 INFO - Downloading/unpacking jsonschema==2.5.1 00:52:28 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:52:28 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:52:28 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:52:28 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:52:28 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:52:28 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:52:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:52:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:52: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:52: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:52: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:52: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:52: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:52: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:52:31 INFO - Downloading functools32-3.2.3-2.tar.gz 00:52:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:52:32 INFO - warning: no files found matching '*.txt' 00:52:32 INFO - no previously-included directories found matching 'build' 00:52:32 INFO - no previously-included directories found matching 'dist' 00:52:32 INFO - no previously-included directories found matching '.git*' 00:52:32 INFO - Installing collected packages: jsonschema, functools32 00:52:32 INFO - Running setup.py install for functools32 00:52:32 INFO - warning: no files found matching '*.txt' 00:52:32 INFO - no previously-included directories found matching 'build' 00:52:32 INFO - no previously-included directories found matching 'dist' 00:52:32 INFO - no previously-included directories found matching '.git*' 00:52:32 INFO - Successfully installed jsonschema functools32 00:52:32 INFO - Cleaning up... 00:52:32 INFO - Return code: 0 00:52:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:52:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:52:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:52:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106d08490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c7e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffadbdb0710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b1cd30>, '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 0x106942db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b14b20>, '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.KRSbX6MkK7/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.ivR6zk7ZFh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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:52:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 00:52:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 00:52:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRSbX6MkK7/Render', 00:52:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:52:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:52:32 INFO - 'HOME': '/Users/cltbld', 00:52:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:52:32 INFO - 'LOGNAME': 'cltbld', 00:52:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:52:32 INFO - 'MOZ_NO_REMOTE': '1', 00:52:32 INFO - 'NO_EM_RESTART': '1', 00:52:32 INFO - 'PAGER': '/bin/cat', 00:52:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:52:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:52:32 INFO - 'PWD': '/builds/slave/test', 00:52:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:52:32 INFO - 'SHELL': '/bin/bash', 00:52:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ivR6zk7ZFh/Listeners', 00:52:32 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 00:52:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:52:32 INFO - 'USER': 'cltbld', 00:52:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:52:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:52:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:52:32 INFO - 'XPC_FLAGS': '0x0', 00:52:32 INFO - 'XPC_SERVICE_NAME': '0', 00:52:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:52:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:52:32 INFO - Cleaning up... 00:52:32 INFO - Return code: 0 00:52:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:52:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:52:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:52:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106d08490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c7e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffadbdb0710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b1cd30>, '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 0x106942db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b14b20>, '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.KRSbX6MkK7/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.ivR6zk7ZFh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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:52:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:52:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:52:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRSbX6MkK7/Render', 00:52:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:52:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:52:32 INFO - 'HOME': '/Users/cltbld', 00:52:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:52:32 INFO - 'LOGNAME': 'cltbld', 00:52:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:52:32 INFO - 'MOZ_NO_REMOTE': '1', 00:52:32 INFO - 'NO_EM_RESTART': '1', 00:52:32 INFO - 'PAGER': '/bin/cat', 00:52:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:52:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:52:32 INFO - 'PWD': '/builds/slave/test', 00:52:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:52:32 INFO - 'SHELL': '/bin/bash', 00:52:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ivR6zk7ZFh/Listeners', 00:52:32 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 00:52:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:52:32 INFO - 'USER': 'cltbld', 00:52:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:52:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:52:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:52:32 INFO - 'XPC_FLAGS': '0x0', 00:52:32 INFO - 'XPC_SERVICE_NAME': '0', 00:52:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:52:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:52:32 INFO - Downloading/unpacking blobuploader==1.2.4 00:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:52:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:52:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:52:35 INFO - Downloading blobuploader-1.2.4.tar.gz 00:52:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:52:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:52: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:52: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:52: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:52: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:52: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:52: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:52:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:52:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:52:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:52:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:52:36 INFO - Downloading docopt-0.6.1.tar.gz 00:52:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:52:36 INFO - Installing collected packages: blobuploader, requests, docopt 00:52:36 INFO - Running setup.py install for blobuploader 00:52:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:52:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:52:36 INFO - Running setup.py install for requests 00:52:37 INFO - Running setup.py install for docopt 00:52:37 INFO - Successfully installed blobuploader requests docopt 00:52:37 INFO - Cleaning up... 00:52:37 INFO - Return code: 0 00:52:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:52:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:52:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:52:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:52:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:37 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 0x106d08490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c7e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffadbdb0710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b1cd30>, '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 0x106942db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b14b20>, '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.KRSbX6MkK7/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.ivR6zk7ZFh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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:52:37 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:52:37 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:52:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRSbX6MkK7/Render', 00:52:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:52:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:52:37 INFO - 'HOME': '/Users/cltbld', 00:52:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:52:37 INFO - 'LOGNAME': 'cltbld', 00:52:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:52:37 INFO - 'MOZ_NO_REMOTE': '1', 00:52:37 INFO - 'NO_EM_RESTART': '1', 00:52:37 INFO - 'PAGER': '/bin/cat', 00:52:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:52:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:52:37 INFO - 'PWD': '/builds/slave/test', 00:52:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:52:37 INFO - 'SHELL': '/bin/bash', 00:52:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ivR6zk7ZFh/Listeners', 00:52:37 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 00:52:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:52:37 INFO - 'USER': 'cltbld', 00:52:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:52:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:52:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:52:37 INFO - 'XPC_FLAGS': '0x0', 00:52:37 INFO - 'XPC_SERVICE_NAME': '0', 00:52:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:52:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:52:37 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-8XgfRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:52:37 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-Wad6FB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:52:38 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-VfD1OE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:52:38 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-OrfDIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:52:38 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-Q73jG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:52:38 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-yRz4n_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:52:38 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-tyOPyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:52:38 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-t9MfSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:52:38 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-9KZSLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:52:38 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-RAMCD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:52:38 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-nFwWuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:52:38 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-Jgtv0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:52:39 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-Ax3v7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:52:39 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-jBoJDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:52:39 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-B5H5zy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:52:39 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-y1aMJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:52:39 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-O6HJAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:52:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:52:39 INFO - Running setup.py install for manifestparser 00:52:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:52:39 INFO - Running setup.py install for mozcrash 00:52:39 INFO - Running setup.py install for mozdebug 00:52:40 INFO - Running setup.py install for mozdevice 00:52:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:52:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:52:40 INFO - Running setup.py install for mozfile 00:52:40 INFO - Running setup.py install for mozhttpd 00:52:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:52:40 INFO - Running setup.py install for mozinfo 00:52:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:52:40 INFO - Running setup.py install for mozInstall 00:52:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:52:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:52:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:52:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:52:40 INFO - Running setup.py install for mozleak 00:52:40 INFO - Running setup.py install for mozlog 00:52:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:52:41 INFO - Running setup.py install for moznetwork 00:52:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:52:41 INFO - Running setup.py install for mozprocess 00:52:41 INFO - Running setup.py install for mozprofile 00:52:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:52:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:52:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:52:41 INFO - Running setup.py install for mozrunner 00:52:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:52:41 INFO - Running setup.py install for mozscreenshot 00:52:41 INFO - Running setup.py install for moztest 00:52:41 INFO - Running setup.py install for mozversion 00:52:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:52:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:52:42 INFO - Cleaning up... 00:52:42 INFO - Return code: 0 00:52:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:52:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:52:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:52:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:42 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 0x106d08490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c7e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffadbdb0710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b1cd30>, '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 0x106942db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b14b20>, '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.KRSbX6MkK7/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.ivR6zk7ZFh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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:52:42 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:52:42 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:52:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRSbX6MkK7/Render', 00:52:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:52:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:52:42 INFO - 'HOME': '/Users/cltbld', 00:52:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:52:42 INFO - 'LOGNAME': 'cltbld', 00:52:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:52:42 INFO - 'MOZ_NO_REMOTE': '1', 00:52:42 INFO - 'NO_EM_RESTART': '1', 00:52:42 INFO - 'PAGER': '/bin/cat', 00:52:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:52:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:52:42 INFO - 'PWD': '/builds/slave/test', 00:52:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:52:42 INFO - 'SHELL': '/bin/bash', 00:52:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ivR6zk7ZFh/Listeners', 00:52:42 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 00:52:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:52:42 INFO - 'USER': 'cltbld', 00:52:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:52:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:52:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:52:42 INFO - 'XPC_FLAGS': '0x0', 00:52:42 INFO - 'XPC_SERVICE_NAME': '0', 00:52:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:52:42 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-yOVH20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:52:42 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:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:52:42 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-e9NIHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:52:42 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-SUOEEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:52:42 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:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:52:42 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-qoXAet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:52:42 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-SBvht4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:52:42 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:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:52:42 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-oiGawK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:52:43 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:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:52:43 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-FLKR4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:52:43 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:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:52:43 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-KGCKY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:52:43 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:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:52:43 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-wedFhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:52:43 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:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:52:43 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-tSTSLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:52:43 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:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:52:43 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-eHz8ak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:52:43 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:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:52:43 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-vPPQyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:52:43 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:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:52:43 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-wgVQeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:52:43 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:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:52:43 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-NiMHcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:52:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 00:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:52:43 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-Ls0hUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:52:44 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:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:52:44 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-qPH7jk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:52:44 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:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:52:44 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-AyFnIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:52:44 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:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:52:44 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:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:52:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:52:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:52:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:52:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:52:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:52:46 INFO - Downloading blessings-1.6.tar.gz 00:52:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:52:46 INFO - Installing collected packages: blessings 00:52:46 INFO - Running setup.py install for blessings 00:52:47 INFO - Successfully installed blessings 00:52:47 INFO - Cleaning up... 00:52:47 INFO - Return code: 0 00:52:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:52:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:52:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:52:47 INFO - Reading from file tmpfile_stdout 00:52:47 INFO - Current package versions: 00:52:47 INFO - blessings == 1.6 00:52:47 INFO - blobuploader == 1.2.4 00:52:47 INFO - docopt == 0.6.1 00:52:47 INFO - functools32 == 3.2.3-2 00:52:47 INFO - jsonschema == 2.5.1 00:52:47 INFO - manifestparser == 1.1 00:52:47 INFO - mozInstall == 1.12 00:52:47 INFO - mozcrash == 0.17 00:52:47 INFO - mozdebug == 0.1 00:52:47 INFO - mozdevice == 0.48 00:52:47 INFO - mozfile == 1.2 00:52:47 INFO - mozhttpd == 0.7 00:52:47 INFO - mozinfo == 0.9 00:52:47 INFO - mozleak == 0.1 00:52:47 INFO - mozlog == 3.4 00:52:47 INFO - moznetwork == 0.27 00:52:47 INFO - mozprocess == 0.23 00:52:47 INFO - mozprofile == 0.28 00:52:47 INFO - mozrunner == 6.12 00:52:47 INFO - mozscreenshot == 0.1 00:52:47 INFO - mozsystemmonitor == 0.3 00:52:47 INFO - moztest == 0.7 00:52:47 INFO - mozversion == 1.4 00:52:47 INFO - psutil == 3.1.1 00:52:47 INFO - requests == 1.2.3 00:52:47 INFO - wsgiref == 0.1.2 00:52:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:52:47 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:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:52:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:47 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:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:52:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:47 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 0x106d08490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c7e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffadbdb0710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b1cd30>, '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 0x106942db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b14b20>, '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.KRSbX6MkK7/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.ivR6zk7ZFh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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:52:47 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:52:47 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:52:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRSbX6MkK7/Render', 00:52:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:52:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:52:47 INFO - 'HOME': '/Users/cltbld', 00:52:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:52:47 INFO - 'LOGNAME': 'cltbld', 00:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:52:47 INFO - 'MOZ_NO_REMOTE': '1', 00:52:47 INFO - 'NO_EM_RESTART': '1', 00:52:47 INFO - 'PAGER': '/bin/cat', 00:52:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:52:47 INFO - 'PWD': '/builds/slave/test', 00:52:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:52:47 INFO - 'SHELL': '/bin/bash', 00:52:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ivR6zk7ZFh/Listeners', 00:52:47 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 00:52:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:52:47 INFO - 'USER': 'cltbld', 00:52:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:52:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:52:47 INFO - 'XPC_FLAGS': '0x0', 00:52:47 INFO - 'XPC_SERVICE_NAME': '0', 00:52:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:52:47 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:52:47 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:52:47 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:52:47 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:52:47 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:52:47 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:52:47 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:52:47 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:52:47 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:52:47 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:52:47 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:52:47 INFO - Cleaning up... 00:52:47 INFO - Return code: 0 00:52:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:52:47 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:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:52:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:47 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:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:52:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:47 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 0x106d08490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c7e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffadbdb0710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b1cd30>, '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 0x106942db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b14b20>, '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.KRSbX6MkK7/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.ivR6zk7ZFh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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:52:47 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:52:47 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:52:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRSbX6MkK7/Render', 00:52:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:52:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:52:47 INFO - 'HOME': '/Users/cltbld', 00:52:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:52:47 INFO - 'LOGNAME': 'cltbld', 00:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:52:47 INFO - 'MOZ_NO_REMOTE': '1', 00:52:47 INFO - 'NO_EM_RESTART': '1', 00:52:47 INFO - 'PAGER': '/bin/cat', 00:52:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:52:47 INFO - 'PWD': '/builds/slave/test', 00:52:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:52:47 INFO - 'SHELL': '/bin/bash', 00:52:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ivR6zk7ZFh/Listeners', 00:52:47 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 00:52:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:52:47 INFO - 'USER': 'cltbld', 00:52:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:52:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:52:47 INFO - 'XPC_FLAGS': '0x0', 00:52:47 INFO - 'XPC_SERVICE_NAME': '0', 00:52:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:52:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:52:47 INFO - Cleaning up... 00:52:47 INFO - Return code: 0 00:52:47 INFO - Running post-action listener: _resource_record_post_action 00:52:47 INFO - Running post-action listener: _start_resource_monitoring 00:52:47 INFO - Starting resource monitoring. 00:52:47 INFO - [mozharness: 2016-10-19 07:52:47.963068Z] Finished create-virtualenv step (success) 00:52:47 INFO - [mozharness: 2016-10-19 07:52:47.964067Z] Running install step. 00:52:47 INFO - Running pre-action listener: _resource_record_pre_action 00:52:47 INFO - Running main action method: install 00:52:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:52:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:52:48 INFO - Reading from file tmpfile_stdout 00:52:48 INFO - Detecting whether we're running mozinstall >=1.0... 00:52:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:52:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:52:48 INFO - Reading from file tmpfile_stdout 00:52:48 INFO - Output received: 00:52:48 INFO - Usage: mozinstall [options] installer 00:52:48 INFO - Options: 00:52:48 INFO - -h, --help show this help message and exit 00:52:48 INFO - -d DEST, --destination=DEST 00:52:48 INFO - Directory to install application into. [default: 00:52:48 INFO - "/builds/slave/test"] 00:52:48 INFO - --app=APP Application being installed. [default: firefox] 00:52:48 INFO - mkdir: /builds/slave/test/build/application 00:52:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 00:52:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 00:53:23 INFO - Reading from file tmpfile_stdout 00:53:23 INFO - Output received: 00:53:23 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 00:53:23 INFO - Running post-action listener: _resource_record_post_action 00:53:23 INFO - [mozharness: 2016-10-19 07:53:23.121118Z] Finished install step (success) 00:53:23 INFO - [mozharness: 2016-10-19 07:53:23.121250Z] Running run-tests step. 00:53:23 INFO - Running pre-action listener: _resource_record_pre_action 00:53:23 INFO - Running main action method: run_tests 00:53:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:53:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:53:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:53:23 INFO - 2016-10-19 00:53:23.134 screenresolution[1644:8408] starting screenresolution argv=screenresolution get 00:53:23 INFO - 2016-10-19 00:53:23.137 screenresolution[1644:8408] Display 0: 1600x1200x32@60 00:53:23 INFO - 2016-10-19 00:53:23.142 screenresolution[1645:8410] starting screenresolution argv=screenresolution list 00:53:23 INFO - Available Modes on Display 0 00:53:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:53:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:53:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:53:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:53:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:53:23 INFO - Intel Iris: 00:53:23 INFO - Chipset Model: Intel Iris 00:53:23 INFO - Type: GPU 00:53:23 INFO - Bus: Built-In 00:53:23 INFO - VRAM (Dynamic, Max): 1536 MB 00:53:23 INFO - Vendor: Intel (0x8086) 00:53:23 INFO - Device ID: 0x0a2e 00:53:23 INFO - Revision ID: 0x0009 00:53:23 INFO - Displays: 00:53:23 INFO - Display: 00:53:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:53:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:53:23 INFO - Display Serial Number: 1600x1200 60 00:53:23 INFO - Main Display: Yes 00:53:23 INFO - Mirror: Off 00:53:23 INFO - Online: Yes 00:53:23 INFO - Rotation: Supported 00:53:23 INFO - Return code: 0 00:53:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:53:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:53:23 INFO - Python 2.7.3 00:53:23 INFO - Return code: 0 00:53:23 INFO - grabbing minidump binary from tooltool 00:53:23 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:53:23 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 0x106b1cd30>, '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 0x106942db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b14b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:53:23 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 00:53:23 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 00:53:23 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 00:53:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:53:23 INFO - Return code: 0 00:53:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:53:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:53:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:53:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:53:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:53:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JvFhNxb0TuOX5YjTjDcuAw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0310', '--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 00:53:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JvFhNxb0TuOX5YjTjDcuAw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0310 --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 00:53:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRSbX6MkK7/Render', 00:53:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:53:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:53:23 INFO - 'HOME': '/Users/cltbld', 00:53:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:53:23 INFO - 'LOGNAME': 'cltbld', 00:53:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:53:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:53:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:23 INFO - 'MOZ_NO_REMOTE': '1', 00:53:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:53:23 INFO - 'NO_EM_RESTART': '1', 00:53:23 INFO - 'PAGER': '/bin/cat', 00:53:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:53:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:53:23 INFO - 'PWD': '/builds/slave/test', 00:53:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:53:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:53:23 INFO - 'SHELL': '/bin/bash', 00:53:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ivR6zk7ZFh/Listeners', 00:53:23 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 00:53:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:53:23 INFO - 'USER': 'cltbld', 00:53:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:53:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:53:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:23 INFO - 'XPC_FLAGS': '0x0', 00:53:23 INFO - 'XPC_SERVICE_NAME': '0', 00:53:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:53:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JvFhNxb0TuOX5YjTjDcuAw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0310', '--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 00:53:23 INFO - mozversion application_buildid: 20161018210123 00:53:23 INFO - mozversion application_changeset: 60f9486949afe160682b09b9df7dd13e881e718b 00:53:23 INFO - mozversion application_display_name: Nightly 00:53:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:53:23 INFO - mozversion application_name: Firefox 00:53:23 INFO - mozversion application_remotingname: firefox 00:53:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 00:53:23 INFO - mozversion application_vendor: Mozilla 00:53:23 INFO - mozversion application_version: 52.0a1 00:53:23 INFO - mozversion platform_buildid: 20161018210123 00:53:23 INFO - mozversion platform_changeset: 60f9486949afe160682b09b9df7dd13e881e718b 00:53:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 00:53:23 INFO - mozversion platform_version: 52.0a1 00:53:23 INFO - using testdate: 1476863603 00:53:23 INFO - actual date: 1476863603 00:53:23 INFO - starting webserver on 'localhost:49278' 00:53:23 INFO - SUITE-START | Running 2 tests 00:53:23 INFO - TEST-START | dromaeo_css 00:53:23 INFO - operating with platform_type : mac_ 00:53:23 INFO - Initialising browser for dromaeo_css test... 00:53:23 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/tmpLDLzr8/profile http://localhost:49278/getInfo.html) 00:53:26 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 00:53:26 INFO - PROCESS | 1655 | colorDepth:24 00:53:26 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 00:53:26 INFO - PROCESS | 1655 | __metrics 00:53:26 INFO - PROCESS | 1655 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:53:26 INFO - PROCESS | 1655 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:53:27 INFO - TEST-INFO | 1655: exit 0 00:53:27 INFO - Browser initialized. 00:53:27 INFO - Running cycle 1/1 for dromaeo_css test... 00:53:27 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/tmpLDLzr8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:53:39 INFO - PROCESS | 1658 | RSS: Main: 238956544 00:53:39 INFO - PROCESS | 1658 | 00:54:30 INFO - PROCESS | 1658 | 1476863670283 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] 00:56:43 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 00:56:46 INFO - PROCESS | 1658 | RSS: Main: 491999232 00:56:46 INFO - PROCESS | 1658 | 00:59:49 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 00:59:50 INFO - PROCESS | 1658 | RSS: Main: 368119808 00:59:50 INFO - PROCESS | 1658 | 01:02:52 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 01:02:53 INFO - PROCESS | 1658 | RSS: Main: 344031232 01:02:53 INFO - PROCESS | 1658 | 01:05:55 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 01:05:56 INFO - PROCESS | 1658 | RSS: Main: 348065792 01:05:56 INFO - PROCESS | 1658 | 01:08:59 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 01:09:00 INFO - PROCESS | 1658 | RSS: Main: 338780160 01:09:00 INFO - PROCESS | 1658 | 01:12:03 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 01:12:03 INFO - PROCESS | 1658 | RSS: Main: 449773568 01:12:03 INFO - PROCESS | 1658 | 01:12:03 INFO - PROCESS | 1658 | __start_tp_report 01:12:03 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 01:12:03 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 01:12:03 INFO - PROCESS | 1658 | |i|pagename|runs| 01:12:03 INFO - PROCESS | 1658 | |0;dojo.html;3363.5795525559306;3375.9662403375964;3381.6618338166186;3407.335569563933;3435.2442462658223;5592.5805564582715;5711.457411545907;5722.856928576788;5739.368669446358;5807.941920580798;5668.546516278698;5709.8287051388525;5720.313562372521;5805.651660900349;5825.5048320892665;5152.278680984665;5183.352080989876;5209.895802083956;5216.113260745663;5247.475252474741;5159;5263.842084737464;5278.788848446057;5287.2862163608;5333.546648534879;4909.533594308535;4942.135126352892;5276.92084618731;5309.654872433299;5310.097283461801;5155.226715992593;5159.613029022838;5182.896342073175;5185.196294574347;5212.113940630102;5179;5188.325517682715;5200.089984252741;5248.711320877388;5265.289185959885;5687.658740475585;5719.399463056402;5719.828405147852;5733.283339582552;5740.741666625012;6127.938720612826;6171.382861713838;6222.5644204905675;6234.283057448406;6253.187085678833;6216.347283535254;6218.595791273598;6231.906521402183;6263.467605253559;6316.210473690789;5768.192453056576;5818.069108942549;5827.94172058274;5839.678817665069;5867.677277749722;6182.381761823872;6240.625562466266;6243.531735119794;6262.968685156637;6276.874462510724;5999.730012149464;6061.818145455643;6064.211652485149;6090.147379366892;6116.366205733216;6211.627302361872;6245.125682404467;6246;6255.374462553708;6276.403741644536;6153.784617538365;6216.160818289563;6218.968905155445;6228.501719862491;6231.096491008869;6116;6128.964670903581;6142.836439233798;6180.165677633552;6205.6586887721605;4877.317175595419;4914.0908931847725;4915.90168196634;4920.21276595743;4930.7288099154175;4360.345948107809;4445.133199026159;4474.888127796831;4486.327050942385;4489.753063581469;4853.4418541867435;4900.215965445583;5783.161441590946;5796.536277097822;5801.100829371454;6223.346548612421;6223.657698826518;6225.875482490324;6226.782062627786;6232.158658581124;5776.768929242783;5815.767369305265;5817.534597232211;5821.18503409523;5823.82528524145;5346.064438723208;5355.839324820262;5356.3572371315695;5388.245645609618;5391.406945236021;6283.057541368831;6289.8742025159245;6298.496120310456;6310.716017779119;6319.05214217871;6095.0151978696995;6187.319394866651;6283.214598175228;6294.5593808434805;6295.653739044396;6205.6586887721605;6217.689115544295;6251.156093927261;6254.906176407267;6297.52768542352;6076.969615151896;6208.689565521796;6221;6234.812955611339;6258.812235632939;6272;6274.623522588659;6284.528660350584;6290.119383286252;6292.2134733158355;6005.939940600538;6036.8188954331445;6036.9698151508965;6100.23747031621;6109.572329937039;4477.947682294724;5765.336986246468;6068.393160683896;6069.635821850703;6096.237970253718;5882.029465138205;5882.705864706833;5896.439838215363;5911.290645122613;5914.349421563538;6095.024796032613;6103.450689437972;6112.633242005494;6114.357992410911;6115.541334399849;5844.707764611838;5864.120381942743;5910.024845900378;5910.822675319747;5927.199828023162 01:12:03 INFO - PROCESS | 1658 | |1;ext.html;508.9287499750034;522.8170140450842;530.3450238954892;531.7102179312275;557.5957430862625;39471;40597.78206653801;40758.38862417062;40770.38844417336;42952.35571466431;42249.36625950613;42406.36390454145;42486.15027699452;42596.787016064955;42777;8433.831323373528;8641.783955401103;9370.344075914672;9543.188828949513;9550;8495.023072346667;8581.270591999657;8589.055203927563;11241.66275011751;11477.483513241883;11353;11364.147688923322;11386.60146894859;11398.829017564743;11402.600908968188;11350.943245283763;11403.3728144952;11413.714657133554;11419.942900285445;11448.484818183202;8392.076871544125;8608.31133509324;8611.913880861173;8670.696525621635;11254.0996720263;31745.888893888605;38854.640087596796;39385;39477.81566553008;40771.38842917359;3379.3410284994434;3529.2588556403184;3611.295797319524;3932.3708206686792;4007.358822588401;24169.912353944113;27468.313292167655;29277.8288868445;29649.70350296491;31271.530927036114;2803.3272014716526;3127.7654175936896;3241.33552621712;3246.659100794406;3271.983640081808;453947;454602;455024;457837.4216257861;466417;59266.40733592609;59483.40516594865;59581;59581.404185958454;59727.70136149292;62893;63060.68469657714;63164.68417657974;63342;63487;15529.223538823013;15765.763513547307;15776.368945242062;15796;15835.366585336687;12155.027597792332;12191.756164876653;12192.963598094262;12205.267683938815;12217.572384966483;14693;15057.623559411102;15092.094474331576;17805.44138507982;20219.696704549442;8288.21261980111;8414.873776893352;8422.957885210535;8477.448965817202;8513.95743021281;868.3183700794972;918.2516249256835;976.2970661123979;1018.3787889387468;1047.4710271312938;22049.779502204772;27171;28197.71802281992;28767.42465150685;30592;1015.8069966706303;1041.8853926068127;1059.5073290919759;1103.624767579027;1123.5730422439585;15499.92250038765;15573.454929077428;15617.219139043002;15712;15926.339562703246;536149;536442;537650;538268;538992;57276.42723572794;57559.712201439565;57667.42332576704;57838.71080644654;57871.13193302104;1285.9742805143844;1346.1250187378282;1396.3018490754623;1410.379433049496;1411.5976946570179;29082.418351632426;29401.558976615797;29470.115896523137;29597.26006849846;30234.54648180235;51524;51914.74042629763;51943.961120776614;51947.48052519427;52245.477545224065;585747;588429;588535;589952;590018;33616.663833362334;41550.584494154675;42704.57295427006;43036.35445468383;43044.78477607592;36475.63524364722;42956.570434296504;46758.53241467542;49680.25479617736;50117.24824127714;37928.431073533364;38648.80675596604;39231;40203.3918643251;40317;38196.85409437721;38514.614853851104;38633.42049869311;39646.008849778984;40017.59982400139;37789.244215116094;38594.8421547354;38649.22701545897;38702.80648596739;38828.02929926774;31890.68109318877;33998;34403.82798085993;34646.30707385889;34776.65223347734;25424.745752542978;25491.49966758465;25495.49009019772;26160.34599135037;26321 01:12:03 INFO - PROCESS | 1658 | |2;jquery.html;313.6972821227515;316.4256873774101;369.9112213068863;379.12611430652333;395.6577560410246;18936.62126757464;19449.805501944993;19674;20190.99045047749;20345.59308813823;19221.942793146372;19740.60518789623;19861.70207446886;19945.900270498627;20148.093335799887;4365.6507479401735;5569.303837020382;5758.596898217126;5798.768049278045;5803.129530570406;4024.45669834573;4245.426867372896;5631.4087020862835;5697.287839020122;5761.971190144043;4251.213525497793;5979.1330257112695;6257.624542527463;6260;6331.081993110996;5407.324084489419;5672.5178359839465;5737.168110623936;6317.526185536103;6355.618662880219;5592.5246354059955;5610.382857885629;5611.719414029282;5612.69130197839;5624.437556244384;12720.74558508834;12755.234685918875;13013.34933253343;13092;13224.6693832654;1954.4429837496386;2127.127877570189;2209.4365936686204;2341.1922886604093;2420.2376251480728;9869.851952220723;10124.64563740273;10257.692269231935;10802.351858888493;15444.922775386163;1546.9458568950033;1838.6874231380698;1851.6389304085708;1865.0892280161086;1936.9225230990744;108737.45631271793;115286.84713152846;115382.84617153888;115490;115637.42181289123;10933.781324373467;11060.723481912855;11268.887311126948;11284.830727539094;11300.660980170607;14178.432862685377;14211;14213.502527411698;14214.21821799811;14218.85781142196;8008.039035315799;8177.182281771775;8207.220314070153;8338.541380224025;8349.958250208832;7888.7633370998965;8065.798355041171;8066.435349525595;8081.838363232702;8258.25675689191;4329.848455304049;4444.599986001275;4451.399061126771;4526.479454862667;4541.6593755468475;1548.4657793061376;1646.5307387394535;1842.894263441924;1909.217220939436;1910.7898131205557;743.2678811370796;756.7237958145347;820.8686610142348;875.3041332140835;892.5938697892443;20245.797542024393;20445.977701114884;20474;20554.58890822175;20701.27545535899;900.6712549919232;918.9172974432333;932.6269492203173;949.5821838391086;955.8375076237056;10261;10624.893751062546;10627.89372106269;10682.03861652455;10712.625058122929;539795;553205;555964;556845;557339;117446.41276793562;124506.13240801395;132903;133452;135717;943.9575219115156;969.1471505075489;985.8521221816642;986.6546708651914;987.4519641598838;13755.79366309486;18228.81771182271;18650;18975.620487590448;19106.14022368969;48391.2355410884;50493.74753126211;51463.742681286356;52637.918334030815;52729;72201;73268.63365683137;73947;74002.62998684972;75862.48275034358;6737.764178253738;7854.408045345137;7887.369010479262;8263.586820658822;11117.888821111685;12377.504899804268;12820;13323.13399629021;13465.461381544628;13510.729785404434;9788.412695238309;11364.886351136383;11371.317720936438;11650.941745291218;11793.52825886955;10507.369557826554;11474.827877582009;11503.137264705349;11812.468438920097;11934;11248.325100493996;11896.702582435508;11939.582114625946;11953.103517236415;11987.64037078889;11735.647930562096;11857.881421185677;12141.271523708605;12225.266484010988;12286.569970051005;9562.61749530011;11465;11918.821217681914;11921.225120367148;12000.75998480043 01:12:04 INFO - PROCESS | 1658 | |3;mootools.html;1398.5524632117724;1540.1144342003347;1760.5862622283762;1934.4196740977702;1970.5960278142982;8450.366222533312;8944.865827012583;8945.284377249813;8955.86566201506;8959.910400895997;7783.727569535067;8106.189381061906;8118.634661440235;8424.283935865458;8684.956575217131;2190.211523851412;2343.1096183450263;2376.346504711201;2378.2389635316704;2381.583222935988;2248.5278091600785;2348.248560460653;2385.355953892448;2388.2118900762794;2392.6889504364494;2363.2201373546773;2372.9288121356385;2373.6202207646693;2375.560521303564;2383.5947888858936;2340.695709557747;2348.812095032402;2362.621980483123;2365.751596082404;2368.0409434179187;2327.5577640248466;2333.9883300583388;2336.240721765416;2339.1345202275097;2339.801116905065;8756.168164024408;8814.86777698335;8879;8885.866711999326;8892.377533572653;5112.488751124895;5215.58275337972;5355.919661205085;5356.250124982505;5362.490563396471;3437.7077948374417;3640.1081734974837;3660.2862441823854;3661.688756455678;3679.6136405677285;1034.141662420197;1069.5614797932888;1072.126217133034;1088.7931293054373;1092.2136062035322;11558.653240402802;11658.708532286675;11663.533458661643;11666.358350290731;11711.238769480042;4496.595306422438;4573.131105090089;4794.113089078532;4825.806967721252;4835.44392394872;9897.752556186153;9915.851262231072;9929.007099290013;9935.751606209902;9943.005699430143;5379.193121031798;5387.138057910715;5389.487998640123;5391.78432862689;5392.973035134799;4408.58118478744;4508.436445444319;4586.977065114653;4843.782029808667;4901.3383193268455;3861.0733423978045;3883.2815929053218;3993.6405723485027;3999.9400008999887;4018.749500279853;1259.6158171757518;1268.7589358021946;1271.6884363330857;1285.845698516184;1287.9613611591667;841.3689732700475;864.8400045991386;878.5387671472528;930.4928813796497;970.8253013853175;5579.442055794388;5661.66030038199;5877.500412464989;5892.351841297454;5960.910586341209;921.2629896083241;933.9206167475841;954.9904500954901;955.6702937486556;993.279872092727;3476.80877551732;3888.1251718363706;3931.9213615727526;3992.441058251847;4075.3886916962692;10367.844482332772;10712.303700259457;10741.78516429667;10746.301490403099;10781.083607893417;10653.467326633638;10673;10677.78644427107;10687.358758474516;10688.465576721288;7748.922510774933;7996.520208787491;8126.593670316461;8137.471064380797;8196.385271104571;5806.6516009037905;5950.315713692808;5987.520998320037;6080.69596520181;6153.66154861469;9796.069373409515;10080.193584513074;10104.393736375841;10107.090361867467;10108;9849.212063034796;9851.605935762776;10034.69895903124;10273.126784223425;10300.175985920958;6927.203371612329;7162.570245785269;7358.264173582599;7555.9244407555225;7637.465377423527;8284.171582841667;8400.243978042006;8415.8737618937;8419.536925469158;8425.2838508725;7372.299631534996;7533.886991695019;7535.208803075818;7619.161892191743;7629.2752188542;7199.532030418006;7306.050213472215;7370.852582948418;7390.482666213314;7505.437092218214;5920.3783602722815;7042.612656303748;7044.366007059184;7045.612491312822;7050.717971281091;4485.304777759453;4902.558769710743;4921.680090794087;5021.874453138555;5118.795248190031;4988.152014157529;5040.9918016397605;5128.1794912813775;5177.715225662625;5203.19350500673 01:12:04 INFO - PROCESS | 1658 | |4;prototype.html;262.2682715224524;291.40989496270066;301.90791808498415;304.27734131437836;307.95996520452337;4450.221211288028;5180.689158650474;5414.648047876885;5449.264349312842;5449.972750136254;4437.955620443795;4979.626528010395;5267.52592266696;5345.652532585389;5352.80534980657;4081.3877918312196;4112.450280825892;4117.3618089196225;4126.236646220444;4137.482814648169;3951.38753493209;4114.218298523271;4124.175164967003;4142.772147531885;4150.709450338478;3418.965810341902;4059.8376064957365;4068.084680946778;4093.8771836844794;4102.118044620406;3368.983155084221;4051.650042975067;4058.964963934178;4071;4115.835366585333;3552.3073000764603;3556.3065202285566;3565.6612621800887;3571.4107172316535;3577.4454959481322;4948.480409556981;5039.546440820307;5159.819406320798;5163.561097306733;5340.599455040849;4028.5568587455355;4621.0295837873755;4640.955784948394;4660.6970546914345;4667.369905062807;4623;5464.9453505464835;5527.834164975057;5572.777088916479;5595.692236926968;3714.3685573452576;3844.442555829389;3892.649661530476;3904.9219015619815;3909.276783795007;5650.434956504317;5839.240898683186;5843.53251739864;5860.278723010919;5886.970565147147;3967.504061992251;3971.543272523639;3985.44567618629;3990.4014397840556;4014.558398576154;3515.8066306352885;3874.9225015499533;4045.615666511677;4059.127287633114;4060.6954478414236;3911.4523966644692;4582.304547317513;4617.8598552984295;4652.720836749806;4721.386219791474;5192.24712416705;5452.482014208644;5629.2681951346885;5660.8867822643315;5728.226689396962;1237.678203667035;1288.5361269942814;1307.8692130786844;1340.6380277325068;1358.6277859361917;757.4243574883018;826.446280991737;839.8494063133546;842.9283510901643;849.8640217565284;3824.920938644362;4369.519352871182;4377.474703035592;4457.353683715843;4463.62059224963;4273.465816772903;4708.293755936568;4757.977859409737;4792.664513484093;4804.375431193923;4327.978360108243;5438.8912221755345;5470.64440811346;5487.890242195133;5489.792245706019;2565.409446143403;3008.9548656770166;3061.4336347775734;3061.586685797389;3064.2645765016237;5441.401445840955;5989.256714553404;6010.158577799111;6020.819375418744;6057.273127224673;5272.393674727378;5413.621046526705;5899.852503687356;5922.851928701817;5927.703614819242;5012.666576726436;5106.727506259679;5859.853503662443;5951.5833891628035;5995.46040856325;4614.923284522046;5447.945520544744;5812.193013576114;5817.854553636023;5827.5337972961215;5008.248762685626;5696;5710.973184212374;5711.714414279352;5728.742206600797;5586.16207568868;5935.495482884004;5979.638042973088;5999;6096.451319381277;3293.5672982252795;3869.9032524185995;3884.9417258740577;3885.9417108743955;3899.5515515716056;5843.620164689281;5879.7060146993335;5882.558808089325;5906.464319276933;5933.465988061095;4307.504636966789;5452.291202143854;5653.886922261614;5733.283339582552;5757.971210143923;5703.63112852904;5704.68624225655;5717.171010203414;5721.885562288648;5739.282589676291;4714.434267887876;5245.164192532583;5414.404415514212;5628.395907166438;5672.886542269049;4086.2509889058647;4971.726555039508;5364.678119312854;5644.081012455785;5660.490555849993;4593.954060459353;5003.699778013331;5152.484751524968;5239.869003274948;5534.869075405917 01:12:04 INFO - PROCESS | 1658 | |5;yui.html;726.9672864721084;762.1273641680276;763.5723994563045;766.0386215299798;814.8329592433552;15145.394184232631;15529.22353882307;15570.299336529855;15582.376704931818;15876.682466350667;14201.92899035506;14324.785128223059;14327.426902923871;14335.283235838193;14365.066270692398;688.9586624802503;714.5391222661407;715.3132992327372;858.0475672004102;869.9434536755107;883.0727735877335;883.33308352194;894.8299823033602;896.0591379052001;899.3075331994361;951.296040929714;954.0268925695786;954.6324665003954;955.5461155950902;955.6655170690273;947.9763005924838;948.5921053946801;948.7390967483929;948.8956214816365;949.9620015199383;538.6498775795725;558.2380051230082;560.5011539729644;560.6243816642818;560.7000254863628;14117.223552704598;14626.634334141625;14688.412463501447;14970.47603333878;15011.474598389004;14048.789268160986;14530.854691453056;14629.049111807699;14746.336414861356;14751.672349488597;11440.942795286053;11627.244229125079;11701.53193872244;11738.178327517076;12156.939215303955;3652.8904132876055;3672.926541469156;3674.8713795017047;3699.315626609059;3804.6766024887916;83239;86271.70592441119;107415.46292268489;108376.45811770891;109436;11039.668809935714;11111.72220694489;11154.944225278821;11165.16261280391;11204.103671706243;21880.23419180321;21921;21946;21979.450513737283;22064.227752028924;7865.724699635485;7925.128235894047;7955;8045.758627241192;8053;4168.6039826216465;4244.257254980428;4266.296061149876;4301.440812694393;4454.554544545585;3614.584322802859;3760.8683696071053;3763.454299126611;3763.8494460221286;3765.755225910307;671.9584643802087;674.4402146218627;685.4584877946467;691.0808624529363;692.9896051559231;622.8380621038472;654.6399480285824;686.4623243933553;689.6069240532948;692.8060143159923;8407.411481196257;8884.955575222082;9443.811123777623;9642.325037247325;9644.807103857884;524.404800551377;551.1402212548437;577.3995045152993;599.2808629644444;608.6044071353656;4003.959960400417;4611;4678.95321046792;4712.670113092051;4743.383360163226;123560.38219808844;131078;133412;135395;160142.39857601275;107928;108822;109411;110030;110397.68806935805;98136.99999999857;98240.01759982308;99160.00839991508;101537.96924061478;103274.96725032803;8968.641254349754;9509.61961521559;9710.514474276399;9789.706308810748;9887.604495820087;58113.709431452575;58850.58390657474;60389.69805150946;60399.69800151147;62756.686216568625;83842;89352;90632;90865;93170.06829931615;12134.434315497303;12619.87380126187;12649.557265495663;13086.607401777961;13309.334533273492;13745.656358591115;13880.791788122984;14855;15103.32035058447;15214.847851521343;13264.270465124126;13521.72956540844;13543.79684304756;13627.16033335487;13929.303534823015;13351.866481335062;13356;13486.740171332991;13615.115017523829;14169.787453188004;13456.596302110953;13583.252921089435;13759.312034398039;13914.930425348213;14268;9349.766255843659;11032.613858514913;11389.544418223179;11474.4262786862;11595.884041159481;10946.343219406543;11258.493367798632;11318.4906679198;11416.429178541206;11509.251898626562 01:12:04 INFO - PROCESS | 1658 | __end_tp_report 01:12:04 INFO - PROCESS | 1658 | __start_cc_report 01:12:04 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,3501 01:12:04 INFO - PROCESS | 1658 | __end_cc_report 01:12:04 INFO - PROCESS | 1658 | __startTimestamp1476864723989__endTimestamp 01:12:04 INFO - PROCESS | 1658 | 01:12:04 INFO - PROCESS | 1658 | ------- Summary: start ------- 01:12:04 INFO - PROCESS | 1658 | Number of tests: 6 01:12:04 INFO - PROCESS | 1658 | 01:12:04 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5723.77 Median:5910.02 stddev:642.36 (10.9%) stddev-sans-first:617.07 01:12:04 INFO - PROCESS | 1658 | Values: 3363.6 3376.0 3381.7 3407.3 3435.2 5592.6 5711.5 5722.9 5739.4 5807.9 5668.5 5709.8 5720.3 5805.7 5825.5 5152.3 5183.4 5209.9 5216.1 5247.5 5159.0 5263.8 5278.8 5287.3 5333.5 4909.5 4942.1 5276.9 5309.7 5310.1 5155.2 5159.6 5182.9 5185.2 5212.1 5179.0 5188.3 5200.1 5248.7 5265.3 5687.7 5719.4 5719.8 5733.3 5740.7 6127.9 6171.4 6222.6 6234.3 6253.2 6216.3 6218.6 6231.9 6263.5 6316.2 5768.2 5818.1 5827.9 5839.7 5867.7 6182.4 6240.6 6243.5 6263.0 6276.9 5999.7 6061.8 6064.2 6090.1 6116.4 6211.6 6245.1 6246.0 6255.4 6276.4 6153.8 6216.2 6219.0 6228.5 6231.1 6116.0 6129.0 6142.8 6180.2 6205.7 4877.3 4914.1 4915.9 4920.2 4930.7 4360.3 4445.1 4474.9 4486.3 4489.8 4853.4 4900.2 5783.2 5796.5 5801.1 6223.3 6223.7 6225.9 6226.8 6232.2 5776.8 5815.8 5817.5 5821.2 5823.8 5346.1 5355.8 5356.4 5388.2 5391.4 6283.1 6289.9 6298.5 6310.7 6319.1 6095.0 6187.3 6283.2 6294.6 6295.7 6205.7 6217.7 6251.2 6254.9 6297.5 6077.0 6208.7 6221.0 6234.8 6258.8 6272.0 6274.6 6284.5 6290.1 6292.2 6005.9 6036.8 6037.0 6100.2 6109.6 4477.9 5765.3 6068.4 6069.6 6096.2 5882.0 5882.7 5896.4 5911.3 5914.3 6095.0 6103.5 6112.6 6114.4 6115.5 5844.7 5864.1 5910.0 5910.8 5927.2 01:12:04 INFO - PROCESS | 1658 | 01:12:04 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:67087.48 Median:38841.33 stddev:141345.72 (363.9%) stddev-sans-first:141653.84 01:12:04 INFO - PROCESS | 1658 | Values: 508.9 522.8 530.3 531.7 557.6 39471.0 40597.8 40758.4 40770.4 42952.4 42249.4 42406.4 42486.2 42596.8 42777.0 8433.8 8641.8 9370.3 9543.2 9550.0 8495.0 8581.3 8589.1 11241.7 11477.5 11353.0 11364.1 11386.6 11398.8 11402.6 11350.9 11403.4 11413.7 11419.9 11448.5 8392.1 8608.3 8611.9 8670.7 11254.1 31745.9 38854.6 39385.0 39477.8 40771.4 3379.3 3529.3 3611.3 3932.4 4007.4 24169.9 27468.3 29277.8 29649.7 31271.5 2803.3 3127.8 3241.3 3246.7 3272.0 453947.0 454602.0 455024.0 457837.4 466417.0 59266.4 59483.4 59581.0 59581.4 59727.7 62893.0 63060.7 63164.7 63342.0 63487.0 15529.2 15765.8 15776.4 15796.0 15835.4 12155.0 12191.8 12193.0 12205.3 12217.6 14693.0 15057.6 15092.1 17805.4 20219.7 8288.2 8414.9 8423.0 8477.4 8514.0 868.3 918.3 976.3 1018.4 1047.5 22049.8 27171.0 28197.7 28767.4 30592.0 1015.8 1041.9 1059.5 1103.6 1123.6 15499.9 15573.5 15617.2 15712.0 15926.3 536149.0 536442.0 537650.0 538268.0 538992.0 57276.4 57559.7 57667.4 57838.7 57871.1 1286.0 1346.1 1396.3 1410.4 1411.6 29082.4 29401.6 29470.1 29597.3 30234.5 51524.0 51914.7 51944.0 51947.5 52245.5 585747.0 588429.0 588535.0 589952.0 590018.0 33616.7 41550.6 42704.6 43036.4 43044.8 36475.6 42956.6 46758.5 49680.3 50117.2 37928.4 38648.8 39231.0 40203.4 40317.0 38196.9 38514.6 38633.4 39646.0 40017.6 37789.2 38594.8 38649.2 38702.8 38828.0 31890.7 33998.0 34403.8 34646.3 34776.7 25424.7 25491.5 25495.5 26160.3 26321.0 01:12:04 INFO - PROCESS | 1658 | 01:12:04 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:33202.85 Median:20459.99 stddev:92602.41 (452.6%) stddev-sans-first:92829.25 01:12:04 INFO - PROCESS | 1658 | Values: 313.7 316.4 369.9 379.1 395.7 18936.6 19449.8 19674.0 20191.0 20345.6 19221.9 19740.6 19861.7 19945.9 20148.1 4365.7 5569.3 5758.6 5798.8 5803.1 4024.5 4245.4 5631.4 5697.3 5762.0 4251.2 5979.1 6257.6 6260.0 6331.1 5407.3 5672.5 5737.2 6317.5 6355.6 5592.5 5610.4 5611.7 5612.7 5624.4 12720.7 12755.2 13013.3 13092.0 13224.7 1954.4 2127.1 2209.4 2341.2 2420.2 9869.9 10124.6 10257.7 10802.4 15444.9 1546.9 1838.7 1851.6 1865.1 1936.9 108737.5 115286.8 115382.8 115490.0 115637.4 10933.8 11060.7 11268.9 11284.8 11300.7 14178.4 14211.0 14213.5 14214.2 14218.9 8008.0 8177.2 8207.2 8338.5 8350.0 7888.8 8065.8 8066.4 8081.8 8258.3 4329.8 4444.6 4451.4 4526.5 4541.7 1548.5 1646.5 1842.9 1909.2 1910.8 743.3 756.7 820.9 875.3 892.6 20245.8 20446.0 20474.0 20554.6 20701.3 900.7 918.9 932.6 949.6 955.8 10261.0 10624.9 10627.9 10682.0 10712.6 539795.0 553205.0 555964.0 556845.0 557339.0 117446.4 124506.1 132903.0 133452.0 135717.0 944.0 969.1 985.9 986.7 987.5 13755.8 18228.8 18650.0 18975.6 19106.1 48391.2 50493.7 51463.7 52637.9 52729.0 72201.0 73268.6 73947.0 74002.6 75862.5 6737.8 7854.4 7887.4 8263.6 11117.9 12377.5 12820.0 13323.1 13465.5 13510.7 9788.4 11364.9 11371.3 11650.9 11793.5 10507.4 11474.8 11503.1 11812.5 11934.0 11248.3 11896.7 11939.6 11953.1 11987.6 11735.6 11857.9 12141.3 12225.3 12286.6 9562.6 11465.0 11918.8 11921.2 12000.8 01:12:04 INFO - PROCESS | 1658 | 01:12:04 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:5703.76 Median:5005.01 stddev:3184.60 (63.6%) stddev-sans-first:3177.09 01:12:04 INFO - PROCESS | 1658 | Values: 1398.6 1540.1 1760.6 1934.4 1970.6 8450.4 8944.9 8945.3 8955.9 8959.9 7783.7 8106.2 8118.6 8424.3 8685.0 2190.2 2343.1 2376.3 2378.2 2381.6 2248.5 2348.2 2385.4 2388.2 2392.7 2363.2 2372.9 2373.6 2375.6 2383.6 2340.7 2348.8 2362.6 2365.8 2368.0 2327.6 2334.0 2336.2 2339.1 2339.8 8756.2 8814.9 8879.0 8885.9 8892.4 5112.5 5215.6 5355.9 5356.3 5362.5 3437.7 3640.1 3660.3 3661.7 3679.6 1034.1 1069.6 1072.1 1088.8 1092.2 11558.7 11658.7 11663.5 11666.4 11711.2 4496.6 4573.1 4794.1 4825.8 4835.4 9897.8 9915.9 9929.0 9935.8 9943.0 5379.2 5387.1 5389.5 5391.8 5393.0 4408.6 4508.4 4587.0 4843.8 4901.3 3861.1 3883.3 3993.6 3999.9 4018.7 1259.6 1268.8 1271.7 1285.8 1288.0 841.4 864.8 878.5 930.5 970.8 5579.4 5661.7 5877.5 5892.4 5960.9 921.3 933.9 955.0 955.7 993.3 3476.8 3888.1 3931.9 3992.4 4075.4 10367.8 10712.3 10741.8 10746.3 10781.1 10653.5 10673.0 10677.8 10687.4 10688.5 7748.9 7996.5 8126.6 8137.5 8196.4 5806.7 5950.3 5987.5 6080.7 6153.7 9796.1 10080.2 10104.4 10107.1 10108.0 9849.2 9851.6 10034.7 10273.1 10300.2 6927.2 7162.6 7358.3 7555.9 7637.5 8284.2 8400.2 8415.9 8419.5 8425.3 7372.3 7533.9 7535.2 7619.2 7629.3 7199.5 7306.1 7370.9 7390.5 7505.4 5920.4 7042.6 7044.4 7045.6 7050.7 4485.3 4902.6 4921.7 5021.9 5118.8 4988.2 5041.0 5128.2 5177.7 5203.2 01:12:04 INFO - PROCESS | 1658 | 01:12:04 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:4517.40 Median:4975.68 stddev:1394.93 (28.0%) stddev-sans-first:1361.79 01:12:04 INFO - PROCESS | 1658 | Values: 262.3 291.4 301.9 304.3 308.0 4450.2 5180.7 5414.6 5449.3 5450.0 4438.0 4979.6 5267.5 5345.7 5352.8 4081.4 4112.5 4117.4 4126.2 4137.5 3951.4 4114.2 4124.2 4142.8 4150.7 3419.0 4059.8 4068.1 4093.9 4102.1 3369.0 4051.7 4059.0 4071.0 4115.8 3552.3 3556.3 3565.7 3571.4 3577.4 4948.5 5039.5 5159.8 5163.6 5340.6 4028.6 4621.0 4641.0 4660.7 4667.4 4623.0 5464.9 5527.8 5572.8 5595.7 3714.4 3844.4 3892.6 3904.9 3909.3 5650.4 5839.2 5843.5 5860.3 5887.0 3967.5 3971.5 3985.4 3990.4 4014.6 3515.8 3874.9 4045.6 4059.1 4060.7 3911.5 4582.3 4617.9 4652.7 4721.4 5192.2 5452.5 5629.3 5660.9 5728.2 1237.7 1288.5 1307.9 1340.6 1358.6 757.4 826.4 839.8 842.9 849.9 3824.9 4369.5 4377.5 4457.4 4463.6 4273.5 4708.3 4758.0 4792.7 4804.4 4328.0 5438.9 5470.6 5487.9 5489.8 2565.4 3009.0 3061.4 3061.6 3064.3 5441.4 5989.3 6010.2 6020.8 6057.3 5272.4 5413.6 5899.9 5922.9 5927.7 5012.7 5106.7 5859.9 5951.6 5995.5 4614.9 5447.9 5812.2 5817.9 5827.5 5008.2 5696.0 5711.0 5711.7 5728.7 5586.2 5935.5 5979.6 5999.0 6096.5 3293.6 3869.9 3884.9 3885.9 3899.6 5843.6 5879.7 5882.6 5906.5 5933.5 4307.5 5452.3 5653.9 5733.3 5758.0 5703.6 5704.7 5717.2 5721.9 5739.3 4714.4 5245.2 5414.4 5628.4 5672.9 4086.3 4971.7 5364.7 5644.1 5660.5 4594.0 5003.7 5152.5 5239.9 5534.9 01:12:04 INFO - PROCESS | 1658 | 01:12:04 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:23305.73 Median:3763.65 stddev:35825.43 (951.9%) stddev-sans-first:35885.82 01:12:04 INFO - PROCESS | 1658 | Values: 727.0 762.1 763.6 766.0 814.8 15145.4 15529.2 15570.3 15582.4 15876.7 14201.9 14324.8 14327.4 14335.3 14365.1 689.0 714.5 715.3 858.0 869.9 883.1 883.3 894.8 896.1 899.3 951.3 954.0 954.6 955.5 955.7 948.0 948.6 948.7 948.9 950.0 538.6 558.2 560.5 560.6 560.7 14117.2 14626.6 14688.4 14970.5 15011.5 14048.8 14530.9 14629.0 14746.3 14751.7 11440.9 11627.2 11701.5 11738.2 12156.9 3652.9 3672.9 3674.9 3699.3 3804.7 83239.0 86271.7 107415.5 108376.5 109436.0 11039.7 11111.7 11154.9 11165.2 11204.1 21880.2 21921.0 21946.0 21979.5 22064.2 7865.7 7925.1 7955.0 8045.8 8053.0 4168.6 4244.3 4266.3 4301.4 4454.6 3614.6 3760.9 3763.5 3763.8 3765.8 672.0 674.4 685.5 691.1 693.0 622.8 654.6 686.5 689.6 692.8 8407.4 8885.0 9443.8 9642.3 9644.8 524.4 551.1 577.4 599.3 608.6 4004.0 4611.0 4679.0 4712.7 4743.4 123560.4 131078.0 133412.0 135395.0 160142.4 107928.0 108822.0 109411.0 110030.0 110397.7 98137.0 98240.0 99160.0 101538.0 103275.0 8968.6 9509.6 9710.5 9789.7 9887.6 58113.7 58850.6 60389.7 60399.7 62756.7 83842.0 89352.0 90632.0 90865.0 93170.1 12134.4 12619.9 12649.6 13086.6 13309.3 13745.7 13880.8 14855.0 15103.3 15214.8 13264.3 13521.7 13543.8 13627.2 13929.3 13351.9 13356.0 13486.7 13615.1 14169.8 13456.6 13583.3 13759.3 13914.9 14268.0 9349.8 11032.6 11389.5 11474.4 11595.9 10946.3 11258.5 11318.5 11416.4 11509.3 01:12:04 INFO - PROCESS | 1658 | -------- Summary: end -------- 01:12:04 INFO - PROCESS | 1658 | 01:12:04 INFO - TEST-INFO | 1658: exit 0 01:12:04 INFO - TEST-OK | dromaeo_css | took 1120861ms 01:12:04 INFO - TEST-START | kraken 01:12:04 INFO - operating with platform_type : mac_ 01:12:04 INFO - Initialising browser for kraken test... 01:12:04 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/tmpes6FMR/profile http://localhost:49278/getInfo.html) 01:12:06 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 01:12:06 INFO - PROCESS | 1664 | colorDepth:24 01:12:06 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 01:12:06 INFO - PROCESS | 1664 | __metrics 01:12:07 INFO - PROCESS | 1664 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:12:07 INFO - PROCESS | 1664 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:12:07 INFO - TEST-INFO | 1664: exit 0 01:12:07 INFO - Browser initialized. 01:12:07 INFO - Running cycle 1/1 for kraken test... 01:12:07 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/tmpes6FMR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:12:19 INFO - PROCESS | 1665 | RSS: Main: 231952384 01:12:19 INFO - PROCESS | 1665 | 01:12:22 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 01:12:23 INFO - PROCESS | 1665 | RSS: Main: 290258944 01:12:23 INFO - PROCESS | 1665 | 01:12:26 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 01:12:26 INFO - PROCESS | 1665 | RSS: Main: 291536896 01:12:26 INFO - PROCESS | 1665 | 01:12:30 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 01:12:30 INFO - PROCESS | 1665 | RSS: Main: 385097728 01:12:30 INFO - PROCESS | 1665 | 01:12:32 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 01:12:33 INFO - PROCESS | 1665 | RSS: Main: 286101504 01:12:33 INFO - PROCESS | 1665 | 01:12:35 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:12:35 INFO - PROCESS | 1665 | RSS: Main: 290603008 01:12:35 INFO - PROCESS | 1665 | 01:12:38 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 01:12:39 INFO - PROCESS | 1665 | RSS: Main: 328978432 01:12:39 INFO - PROCESS | 1665 | 01:12:42 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 01:12:42 INFO - PROCESS | 1665 | RSS: Main: 330539008 01:12:42 INFO - PROCESS | 1665 | 01:12:45 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 01:12:45 INFO - PROCESS | 1665 | RSS: Main: 327008256 01:12:45 INFO - PROCESS | 1665 | 01:12:47 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:12:48 INFO - PROCESS | 1665 | RSS: Main: 302710784 01:12:48 INFO - PROCESS | 1665 | 01:12:50 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:12:50 INFO - PROCESS | 1665 | RSS: Main: 305344512 01:12:50 INFO - PROCESS | 1665 | 01:12:53 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:12:53 INFO - PROCESS | 1665 | RSS: Main: 310575104 01:12:53 INFO - PROCESS | 1665 | 01:12:56 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:12:57 INFO - PROCESS | 1665 | RSS: Main: 324055040 01:12:57 INFO - PROCESS | 1665 | 01:13:00 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:13:00 INFO - PROCESS | 1665 | RSS: Main: 316981248 01:13:00 INFO - PROCESS | 1665 | 01:13:02 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 01:13:02 INFO - PROCESS | 1665 | RSS: Main: 361078784 01:13:02 INFO - PROCESS | 1665 | 01:13:02 INFO - PROCESS | 1665 | __start_tp_report 01:13:02 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 01:13:02 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 01:13:02 INFO - PROCESS | 1665 | |i|pagename|runs| 01:13:02 INFO - PROCESS | 1665 | |0;ai-astar;103;114;114;113;114;115;113;113;114;114 01:13:02 INFO - PROCESS | 1665 | |1;audio-beat-detection;149;116;113;166;141;140;115;113;156;136 01:13:02 INFO - PROCESS | 1665 | |2;audio-dft;184;183;181;184;183;184;181;181;182;182 01:13:02 INFO - PROCESS | 1665 | |3;audio-fft;80;58;59;87;62;67;53;55;78;58 01:13:02 INFO - PROCESS | 1665 | |4;audio-oscillator;87;70;91;68;66;69;92;66;67;89 01:13:02 INFO - PROCESS | 1665 | |5;imaging-gaussian-blur;90;87;90;87;90;86;90;87;90;86 01:13:02 INFO - PROCESS | 1665 | |6;imaging-darkroom;96;95;95;96;96;95;95;95;96;94 01:13:02 INFO - PROCESS | 1665 | |7;imaging-desaturate;81;88;82;78;82;84;82;82;79;73 01:13:02 INFO - PROCESS | 1665 | |8;json-parse-financial;57;55;53;55;77;77;56;54;53;76 01:13:02 INFO - PROCESS | 1665 | |9;json-stringify-tinderbox;65;73;79;75;70;69;69;70;74;73 01:13:02 INFO - PROCESS | 1665 | |10;stanford-crypto-aes;90;88;85;101;105;106;81;89;87;90 01:13:02 INFO - PROCESS | 1665 | |11;stanford-crypto-ccm;147;146;146;144;142;144;144;138;178;147 01:13:02 INFO - PROCESS | 1665 | |12;stanford-crypto-pbkdf2;172;173;175;171;172;172;170;170;172;172 01:13:02 INFO - PROCESS | 1665 | |13;stanford-crypto-sha256-iterative;68;69;69;68;68;68;67;67;68;68 01:13:02 INFO - PROCESS | 1665 | __end_tp_report 01:13:02 INFO - PROCESS | 1665 | __start_cc_report 01:13:02 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,2082 01:13:02 INFO - PROCESS | 1665 | __end_cc_report 01:13:02 INFO - PROCESS | 1665 | __startTimestamp1476864782879__endTimestamp 01:13:02 INFO - PROCESS | 1665 | 01:13:02 INFO - PROCESS | 1665 | ------- Summary: start ------- 01:13:02 INFO - PROCESS | 1665 | Number of tests: 14 01:13:02 INFO - PROCESS | 1665 | 01:13:02 INFO - PROCESS | 1665 | [#0] ai-astar Cycles:10 Average:112.70 Median:114.00 stddev:3.47 (3.0%) stddev-sans-first:0.67 01:13:02 INFO - PROCESS | 1665 | Values: 103.0 114.0 114.0 113.0 114.0 115.0 113.0 113.0 114.0 114.0 01:13:02 INFO - PROCESS | 1665 | 01:13:02 INFO - PROCESS | 1665 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:140.50 stddev:19.40 (13.8%) stddev-sans-first:19.85 01:13:02 INFO - PROCESS | 1665 | Values: 149.0 116.0 113.0 166.0 141.0 140.0 115.0 113.0 156.0 136.0 01:13:02 INFO - PROCESS | 1665 | 01:13:02 INFO - PROCESS | 1665 | [#2] audio-dft Cycles:10 Average:182.50 Median:183.00 stddev:1.27 (0.7%) stddev-sans-first:1.22 01:13:02 INFO - PROCESS | 1665 | Values: 184.0 183.0 181.0 184.0 183.0 184.0 181.0 181.0 182.0 182.0 01:13:02 INFO - PROCESS | 1665 | 01:13:02 INFO - PROCESS | 1665 | [#3] audio-fft Cycles:10 Average:65.70 Median:64.50 stddev:11.85 (18.4%) stddev-sans-first:11.38 01:13:02 INFO - PROCESS | 1665 | Values: 80.0 58.0 59.0 87.0 62.0 67.0 53.0 55.0 78.0 58.0 01:13:02 INFO - PROCESS | 1665 | 01:13:02 INFO - PROCESS | 1665 | [#4] audio-oscillator Cycles:10 Average:76.50 Median:78.50 stddev:11.54 (14.7%) stddev-sans-first:11.60 01:13:02 INFO - PROCESS | 1665 | Values: 87.0 70.0 91.0 68.0 66.0 69.0 92.0 66.0 67.0 89.0 01:13:02 INFO - PROCESS | 1665 | 01:13:02 INFO - PROCESS | 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:88.30 Median:90.00 stddev:1.83 (2.0%) stddev-sans-first:1.83 01:13:02 INFO - PROCESS | 1665 | Values: 90.0 87.0 90.0 87.0 90.0 86.0 90.0 87.0 90.0 86.0 01:13:02 INFO - PROCESS | 1665 | 01:13:02 INFO - PROCESS | 1665 | [#6] imaging-darkroom Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 01:13:02 INFO - PROCESS | 1665 | Values: 96.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 96.0 94.0 01:13:02 INFO - PROCESS | 1665 | 01:13:02 INFO - PROCESS | 1665 | [#7] imaging-desaturate Cycles:10 Average:81.10 Median:82.00 stddev:3.93 (4.8%) stddev-sans-first:4.17 01:13:02 INFO - PROCESS | 1665 | Values: 81.0 88.0 82.0 78.0 82.0 84.0 82.0 82.0 79.0 73.0 01:13:02 INFO - PROCESS | 1665 | 01:13:02 INFO - PROCESS | 1665 | [#8] json-parse-financial Cycles:10 Average:61.30 Median:56.50 stddev:10.68 (18.9%) stddev-sans-first:11.21 01:13:02 INFO - PROCESS | 1665 | Values: 57.0 55.0 53.0 55.0 77.0 77.0 56.0 54.0 53.0 76.0 01:13:02 INFO - PROCESS | 1665 | 01:13:02 INFO - PROCESS | 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:73.00 stddev:3.92 (5.4%) stddev-sans-first:3.32 01:13:02 INFO - PROCESS | 1665 | Values: 65.0 73.0 79.0 75.0 70.0 69.0 69.0 70.0 74.0 73.0 01:13:02 INFO - PROCESS | 1665 | 01:13:02 INFO - PROCESS | 1665 | [#10] stanford-crypto-aes Cycles:10 Average:92.20 Median:87.50 stddev:8.65 (9.9%) stddev-sans-first:9.14 01:13:02 INFO - PROCESS | 1665 | Values: 90.0 88.0 85.0 101.0 105.0 106.0 81.0 89.0 87.0 90.0 01:13:02 INFO - PROCESS | 1665 | 01:13:02 INFO - PROCESS | 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:147.60 Median:146.00 stddev:11.02 (7.5%) stddev-sans-first:11.68 01:13:02 INFO - PROCESS | 1665 | Values: 147.0 146.0 146.0 144.0 142.0 144.0 144.0 138.0 178.0 147.0 01:13:02 INFO - PROCESS | 1665 | 01:13:02 INFO - PROCESS | 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.90 Median:172.00 stddev:1.45 (0.8%) stddev-sans-first:1.54 01:13:02 INFO - PROCESS | 1665 | Values: 172.0 173.0 175.0 171.0 172.0 172.0 170.0 170.0 172.0 172.0 01:13:02 INFO - PROCESS | 1665 | 01:13:02 INFO - PROCESS | 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 01:13:02 INFO - PROCESS | 1665 | Values: 68.0 69.0 69.0 68.0 68.0 68.0 67.0 67.0 68.0 68.0 01:13:02 INFO - PROCESS | 1665 | -------- Summary: end -------- 01:13:02 INFO - PROCESS | 1665 | 01:13:03 INFO - TEST-INFO | 1665: exit 0 01:13:03 INFO - TEST-OK | kraken | took 59188ms 01:13:03 INFO - SUITE-END | took 1180s 01:13:04 INFO - Completed test suite (00:19:40) 01:13:04 INFO - javascript benchmark 01:13:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3363.5795525559306, 3375.9662403375964, 3381.6618338166186, 3407.335569563933, 3435.2442462658223, 5592.5805564582715, 5711.457411545907, 5722.856928576788, 5739.368669446358, 5807.941920580798, 5668.546516278698, 5709.8287051388525, 5720.313562372521, 5805.651660900349, 5825.5048320892665, 5152.278680984665, 5183.352080989876, 5209.895802083956, 5216.113260745663, 5247.475252474741, 5159.0, 5263.842084737464, 5278.788848446057, 5287.2862163608, 5333.546648534879, 4909.533594308535, 4942.135126352892, 5276.92084618731, 5309.654872433299, 5310.097283461801, 5155.226715992593, 5159.613029022838, 5182.896342073175, 5185.196294574347, 5212.113940630102, 5179.0, 5188.325517682715, 5200.089984252741, 5248.711320877388, 5265.289185959885, 5687.658740475585, 5719.399463056402, 5719.828405147852, 5733.283339582552, 5740.741666625012, 6127.938720612826, 6171.382861713838, 6222.5644204905675, 6234.283057448406, 6253.187085678833, 6216.347283535254, 6218.595791273598, 6231.906521402183, 6263.467605253559, 6316.210473690789, 5768.192453056576, 5818.069108942549, 5827.94172058274, 5839.678817665069, 5867.677277749722, 6182.381761823872, 6240.625562466266, 6243.531735119794, 6262.968685156637, 6276.874462510724, 5999.730012149464, 6061.818145455643, 6064.211652485149, 6090.147379366892, 6116.366205733216, 6211.627302361872, 6245.125682404467, 6246.0, 6255.374462553708, 6276.403741644536, 6153.784617538365, 6216.160818289563, 6218.968905155445, 6228.501719862491, 6231.096491008869, 6116.0, 6128.964670903581, 6142.836439233798, 6180.165677633552, 6205.6586887721605, 4877.317175595419, 4914.0908931847725, 4915.90168196634, 4920.21276595743, 4930.7288099154175, 4360.345948107809, 4445.133199026159, 4474.888127796831, 4486.327050942385, 4489.753063581469, 4853.4418541867435, 4900.215965445583, 5783.161441590946, 5796.536277097822, 5801.100829371454, 6223.346548612421, 6223.657698826518, 6225.875482490324, 6226.782062627786, 6232.158658581124, 5776.768929242783, 5815.767369305265, 5817.534597232211, 5821.18503409523, 5823.82528524145, 5346.064438723208, 5355.839324820262, 5356.3572371315695, 5388.245645609618, 5391.406945236021, 6283.057541368831, 6289.8742025159245, 6298.496120310456, 6310.716017779119, 6319.05214217871, 6095.0151978696995, 6187.319394866651, 6283.214598175228, 6294.5593808434805, 6295.653739044396, 6205.6586887721605, 6217.689115544295, 6251.156093927261, 6254.906176407267, 6297.52768542352, 6076.969615151896, 6208.689565521796, 6221.0, 6234.812955611339, 6258.812235632939, 6272.0, 6274.623522588659, 6284.528660350584, 6290.119383286252, 6292.2134733158355, 6005.939940600538, 6036.8188954331445, 6036.9698151508965, 6100.23747031621, 6109.572329937039, 4477.947682294724, 5765.336986246468, 6068.393160683896, 6069.635821850703, 6096.237970253718, 5882.029465138205, 5882.705864706833, 5896.439838215363, 5911.290645122613, 5914.349421563538, 6095.024796032613, 6103.450689437972, 6112.633242005494, 6114.357992410911, 6115.541334399849, 5844.707764611838, 5864.120381942743, 5910.024845900378, 5910.822675319747, 5927.199828023162], "value": 5683.45202148236, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [508.9287499750034, 522.8170140450842, 530.3450238954892, 531.7102179312275, 557.5957430862625, 39471.0, 40597.78206653801, 40758.38862417062, 40770.38844417336, 42952.35571466431, 42249.36625950613, 42406.36390454145, 42486.15027699452, 42596.787016064955, 42777.0, 8433.831323373528, 8641.783955401103, 9370.344075914672, 9543.188828949513, 9550.0, 8495.023072346667, 8581.270591999657, 8589.055203927563, 11241.66275011751, 11477.483513241883, 11353.0, 11364.147688923322, 11386.60146894859, 11398.829017564743, 11402.600908968188, 11350.943245283763, 11403.3728144952, 11413.714657133554, 11419.942900285445, 11448.484818183202, 8392.076871544125, 8608.31133509324, 8611.913880861173, 8670.696525621635, 11254.0996720263, 31745.888893888605, 38854.640087596796, 39385.0, 39477.81566553008, 40771.38842917359, 3379.3410284994434, 3529.2588556403184, 3611.295797319524, 3932.3708206686792, 4007.358822588401, 24169.912353944113, 27468.313292167655, 29277.8288868445, 29649.70350296491, 31271.530927036114, 2803.3272014716526, 3127.7654175936896, 3241.33552621712, 3246.659100794406, 3271.983640081808, 453947.0, 454602.0, 455024.0, 457837.4216257861, 466417.0, 59266.40733592609, 59483.40516594865, 59581.0, 59581.404185958454, 59727.70136149292, 62893.0, 63060.68469657714, 63164.68417657974, 63342.0, 63487.0, 15529.223538823013, 15765.763513547307, 15776.368945242062, 15796.0, 15835.366585336687, 12155.027597792332, 12191.756164876653, 12192.963598094262, 12205.267683938815, 12217.572384966483, 14693.0, 15057.623559411102, 15092.094474331576, 17805.44138507982, 20219.696704549442, 8288.21261980111, 8414.873776893352, 8422.957885210535, 8477.448965817202, 8513.95743021281, 868.3183700794972, 918.2516249256835, 976.2970661123979, 1018.3787889387468, 1047.4710271312938, 22049.779502204772, 27171.0, 28197.71802281992, 28767.42465150685, 30592.0, 1015.8069966706303, 1041.8853926068127, 1059.5073290919759, 1103.624767579027, 1123.5730422439585, 15499.92250038765, 15573.454929077428, 15617.219139043002, 15712.0, 15926.339562703246, 536149.0, 536442.0, 537650.0, 538268.0, 538992.0, 57276.42723572794, 57559.712201439565, 57667.42332576704, 57838.71080644654, 57871.13193302104, 1285.9742805143844, 1346.1250187378282, 1396.3018490754623, 1410.379433049496, 1411.5976946570179, 29082.418351632426, 29401.558976615797, 29470.115896523137, 29597.26006849846, 30234.54648180235, 51524.0, 51914.74042629763, 51943.961120776614, 51947.48052519427, 52245.477545224065, 585747.0, 588429.0, 588535.0, 589952.0, 590018.0, 33616.663833362334, 41550.584494154675, 42704.57295427006, 43036.35445468383, 43044.78477607592, 36475.63524364722, 42956.570434296504, 46758.53241467542, 49680.25479617736, 50117.24824127714, 37928.431073533364, 38648.80675596604, 39231.0, 40203.3918643251, 40317.0, 38196.85409437721, 38514.614853851104, 38633.42049869311, 39646.008849778984, 40017.59982400139, 37789.244215116094, 38594.8421547354, 38649.22701545897, 38702.80648596739, 38828.02929926774, 31890.68109318877, 33998.0, 34403.82798085993, 34646.30707385889, 34776.65223347734, 25424.745752542978, 25491.49966758465, 25495.49009019772, 26160.34599135037, 26321.0], "value": 20149.36298661148, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.6972821227515, 316.4256873774101, 369.9112213068863, 379.12611430652333, 395.6577560410246, 18936.62126757464, 19449.805501944993, 19674.0, 20190.99045047749, 20345.59308813823, 19221.942793146372, 19740.60518789623, 19861.70207446886, 19945.900270498627, 20148.093335799887, 4365.6507479401735, 5569.303837020382, 5758.596898217126, 5798.768049278045, 5803.129530570406, 4024.45669834573, 4245.426867372896, 5631.4087020862835, 5697.287839020122, 5761.971190144043, 4251.213525497793, 5979.1330257112695, 6257.624542527463, 6260.0, 6331.081993110996, 5407.324084489419, 5672.5178359839465, 5737.168110623936, 6317.526185536103, 6355.618662880219, 5592.5246354059955, 5610.382857885629, 5611.719414029282, 5612.69130197839, 5624.437556244384, 12720.74558508834, 12755.234685918875, 13013.34933253343, 13092.0, 13224.6693832654, 1954.4429837496386, 2127.127877570189, 2209.4365936686204, 2341.1922886604093, 2420.2376251480728, 9869.851952220723, 10124.64563740273, 10257.692269231935, 10802.351858888493, 15444.922775386163, 1546.9458568950033, 1838.6874231380698, 1851.6389304085708, 1865.0892280161086, 1936.9225230990744, 108737.45631271793, 115286.84713152846, 115382.84617153888, 115490.0, 115637.42181289123, 10933.781324373467, 11060.723481912855, 11268.887311126948, 11284.830727539094, 11300.660980170607, 14178.432862685377, 14211.0, 14213.502527411698, 14214.21821799811, 14218.85781142196, 8008.039035315799, 8177.182281771775, 8207.220314070153, 8338.541380224025, 8349.958250208832, 7888.7633370998965, 8065.798355041171, 8066.435349525595, 8081.838363232702, 8258.25675689191, 4329.848455304049, 4444.599986001275, 4451.399061126771, 4526.479454862667, 4541.6593755468475, 1548.4657793061376, 1646.5307387394535, 1842.894263441924, 1909.217220939436, 1910.7898131205557, 743.2678811370796, 756.7237958145347, 820.8686610142348, 875.3041332140835, 892.5938697892443, 20245.797542024393, 20445.977701114884, 20474.0, 20554.58890822175, 20701.27545535899, 900.6712549919232, 918.9172974432333, 932.6269492203173, 949.5821838391086, 955.8375076237056, 10261.0, 10624.893751062546, 10627.89372106269, 10682.03861652455, 10712.625058122929, 539795.0, 553205.0, 555964.0, 556845.0, 557339.0, 117446.41276793562, 124506.13240801395, 132903.0, 133452.0, 135717.0, 943.9575219115156, 969.1471505075489, 985.8521221816642, 986.6546708651914, 987.4519641598838, 13755.79366309486, 18228.81771182271, 18650.0, 18975.620487590448, 19106.14022368969, 48391.2355410884, 50493.74753126211, 51463.742681286356, 52637.918334030815, 52729.0, 72201.0, 73268.63365683137, 73947.0, 74002.62998684972, 75862.48275034358, 6737.764178253738, 7854.408045345137, 7887.369010479262, 8263.586820658822, 11117.888821111685, 12377.504899804268, 12820.0, 13323.13399629021, 13465.461381544628, 13510.729785404434, 9788.412695238309, 11364.886351136383, 11371.317720936438, 11650.941745291218, 11793.52825886955, 10507.369557826554, 11474.827877582009, 11503.137264705349, 11812.468438920097, 11934.0, 11248.325100493996, 11896.702582435508, 11939.582114625946, 11953.103517236415, 11987.64037078889, 11735.647930562096, 11857.881421185677, 12141.271523708605, 12225.266484010988, 12286.569970051005, 9562.61749530011, 11465.0, 11918.821217681914, 11921.225120367148, 12000.75998480043], "value": 9295.116239350884, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1398.5524632117724, 1540.1144342003347, 1760.5862622283762, 1934.4196740977702, 1970.5960278142982, 8450.366222533312, 8944.865827012583, 8945.284377249813, 8955.86566201506, 8959.910400895997, 7783.727569535067, 8106.189381061906, 8118.634661440235, 8424.283935865458, 8684.956575217131, 2190.211523851412, 2343.1096183450263, 2376.346504711201, 2378.2389635316704, 2381.583222935988, 2248.5278091600785, 2348.248560460653, 2385.355953892448, 2388.2118900762794, 2392.6889504364494, 2363.2201373546773, 2372.9288121356385, 2373.6202207646693, 2375.560521303564, 2383.5947888858936, 2340.695709557747, 2348.812095032402, 2362.621980483123, 2365.751596082404, 2368.0409434179187, 2327.5577640248466, 2333.9883300583388, 2336.240721765416, 2339.1345202275097, 2339.801116905065, 8756.168164024408, 8814.86777698335, 8879.0, 8885.866711999326, 8892.377533572653, 5112.488751124895, 5215.58275337972, 5355.919661205085, 5356.250124982505, 5362.490563396471, 3437.7077948374417, 3640.1081734974837, 3660.2862441823854, 3661.688756455678, 3679.6136405677285, 1034.141662420197, 1069.5614797932888, 1072.126217133034, 1088.7931293054373, 1092.2136062035322, 11558.653240402802, 11658.708532286675, 11663.533458661643, 11666.358350290731, 11711.238769480042, 4496.595306422438, 4573.131105090089, 4794.113089078532, 4825.806967721252, 4835.44392394872, 9897.752556186153, 9915.851262231072, 9929.007099290013, 9935.751606209902, 9943.005699430143, 5379.193121031798, 5387.138057910715, 5389.487998640123, 5391.78432862689, 5392.973035134799, 4408.58118478744, 4508.436445444319, 4586.977065114653, 4843.782029808667, 4901.3383193268455, 3861.0733423978045, 3883.2815929053218, 3993.6405723485027, 3999.9400008999887, 4018.749500279853, 1259.6158171757518, 1268.7589358021946, 1271.6884363330857, 1285.845698516184, 1287.9613611591667, 841.3689732700475, 864.8400045991386, 878.5387671472528, 930.4928813796497, 970.8253013853175, 5579.442055794388, 5661.66030038199, 5877.500412464989, 5892.351841297454, 5960.910586341209, 921.2629896083241, 933.9206167475841, 954.9904500954901, 955.6702937486556, 993.279872092727, 3476.80877551732, 3888.1251718363706, 3931.9213615727526, 3992.441058251847, 4075.3886916962692, 10367.844482332772, 10712.303700259457, 10741.78516429667, 10746.301490403099, 10781.083607893417, 10653.467326633638, 10673.0, 10677.78644427107, 10687.358758474516, 10688.465576721288, 7748.922510774933, 7996.520208787491, 8126.593670316461, 8137.471064380797, 8196.385271104571, 5806.6516009037905, 5950.315713692808, 5987.520998320037, 6080.69596520181, 6153.66154861469, 9796.069373409515, 10080.193584513074, 10104.393736375841, 10107.090361867467, 10108.0, 9849.212063034796, 9851.605935762776, 10034.69895903124, 10273.126784223425, 10300.175985920958, 6927.203371612329, 7162.570245785269, 7358.264173582599, 7555.9244407555225, 7637.465377423527, 8284.171582841667, 8400.243978042006, 8415.8737618937, 8419.536925469158, 8425.2838508725, 7372.299631534996, 7533.886991695019, 7535.208803075818, 7619.161892191743, 7629.2752188542, 7199.532030418006, 7306.050213472215, 7370.852582948418, 7390.482666213314, 7505.437092218214, 5920.3783602722815, 7042.612656303748, 7044.366007059184, 7045.612491312822, 7050.717971281091, 4485.304777759453, 4902.558769710743, 4921.680090794087, 5021.874453138555, 5118.795248190031, 4988.152014157529, 5040.9918016397605, 5128.1794912813775, 5177.715225662625, 5203.19350500673], "value": 4594.209974024858, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [262.2682715224524, 291.40989496270066, 301.90791808498415, 304.27734131437836, 307.95996520452337, 4450.221211288028, 5180.689158650474, 5414.648047876885, 5449.264349312842, 5449.972750136254, 4437.955620443795, 4979.626528010395, 5267.52592266696, 5345.652532585389, 5352.80534980657, 4081.3877918312196, 4112.450280825892, 4117.3618089196225, 4126.236646220444, 4137.482814648169, 3951.38753493209, 4114.218298523271, 4124.175164967003, 4142.772147531885, 4150.709450338478, 3418.965810341902, 4059.8376064957365, 4068.084680946778, 4093.8771836844794, 4102.118044620406, 3368.983155084221, 4051.650042975067, 4058.964963934178, 4071.0, 4115.835366585333, 3552.3073000764603, 3556.3065202285566, 3565.6612621800887, 3571.4107172316535, 3577.4454959481322, 4948.480409556981, 5039.546440820307, 5159.819406320798, 5163.561097306733, 5340.599455040849, 4028.5568587455355, 4621.0295837873755, 4640.955784948394, 4660.6970546914345, 4667.369905062807, 4623.0, 5464.9453505464835, 5527.834164975057, 5572.777088916479, 5595.692236926968, 3714.3685573452576, 3844.442555829389, 3892.649661530476, 3904.9219015619815, 3909.276783795007, 5650.434956504317, 5839.240898683186, 5843.53251739864, 5860.278723010919, 5886.970565147147, 3967.504061992251, 3971.543272523639, 3985.44567618629, 3990.4014397840556, 4014.558398576154, 3515.8066306352885, 3874.9225015499533, 4045.615666511677, 4059.127287633114, 4060.6954478414236, 3911.4523966644692, 4582.304547317513, 4617.8598552984295, 4652.720836749806, 4721.386219791474, 5192.24712416705, 5452.482014208644, 5629.2681951346885, 5660.8867822643315, 5728.226689396962, 1237.678203667035, 1288.5361269942814, 1307.8692130786844, 1340.6380277325068, 1358.6277859361917, 757.4243574883018, 826.446280991737, 839.8494063133546, 842.9283510901643, 849.8640217565284, 3824.920938644362, 4369.519352871182, 4377.474703035592, 4457.353683715843, 4463.62059224963, 4273.465816772903, 4708.293755936568, 4757.977859409737, 4792.664513484093, 4804.375431193923, 4327.978360108243, 5438.8912221755345, 5470.64440811346, 5487.890242195133, 5489.792245706019, 2565.409446143403, 3008.9548656770166, 3061.4336347775734, 3061.586685797389, 3064.2645765016237, 5441.401445840955, 5989.256714553404, 6010.158577799111, 6020.819375418744, 6057.273127224673, 5272.393674727378, 5413.621046526705, 5899.852503687356, 5922.851928701817, 5927.703614819242, 5012.666576726436, 5106.727506259679, 5859.853503662443, 5951.5833891628035, 5995.46040856325, 4614.923284522046, 5447.945520544744, 5812.193013576114, 5817.854553636023, 5827.5337972961215, 5008.248762685626, 5696.0, 5710.973184212374, 5711.714414279352, 5728.742206600797, 5586.16207568868, 5935.495482884004, 5979.638042973088, 5999.0, 6096.451319381277, 3293.5672982252795, 3869.9032524185995, 3884.9417258740577, 3885.9417108743955, 3899.5515515716056, 5843.620164689281, 5879.7060146993335, 5882.558808089325, 5906.464319276933, 5933.465988061095, 4307.504636966789, 5452.291202143854, 5653.886922261614, 5733.283339582552, 5757.971210143923, 5703.63112852904, 5704.68624225655, 5717.171010203414, 5721.885562288648, 5739.282589676291, 4714.434267887876, 5245.164192532583, 5414.404415514212, 5628.395907166438, 5672.886542269049, 4086.2509889058647, 4971.726555039508, 5364.678119312854, 5644.081012455785, 5660.490555849993, 4593.954060459353, 5003.699778013331, 5152.484751524968, 5239.869003274948, 5534.869075405917], "value": 4066.020843684296, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.9672864721084, 762.1273641680276, 763.5723994563045, 766.0386215299798, 814.8329592433552, 15145.394184232631, 15529.22353882307, 15570.299336529855, 15582.376704931818, 15876.682466350667, 14201.92899035506, 14324.785128223059, 14327.426902923871, 14335.283235838193, 14365.066270692398, 688.9586624802503, 714.5391222661407, 715.3132992327372, 858.0475672004102, 869.9434536755107, 883.0727735877335, 883.33308352194, 894.8299823033602, 896.0591379052001, 899.3075331994361, 951.296040929714, 954.0268925695786, 954.6324665003954, 955.5461155950902, 955.6655170690273, 947.9763005924838, 948.5921053946801, 948.7390967483929, 948.8956214816365, 949.9620015199383, 538.6498775795725, 558.2380051230082, 560.5011539729644, 560.6243816642818, 560.7000254863628, 14117.223552704598, 14626.634334141625, 14688.412463501447, 14970.47603333878, 15011.474598389004, 14048.789268160986, 14530.854691453056, 14629.049111807699, 14746.336414861356, 14751.672349488597, 11440.942795286053, 11627.244229125079, 11701.53193872244, 11738.178327517076, 12156.939215303955, 3652.8904132876055, 3672.926541469156, 3674.8713795017047, 3699.315626609059, 3804.6766024887916, 83239.0, 86271.70592441119, 107415.46292268489, 108376.45811770891, 109436.0, 11039.668809935714, 11111.72220694489, 11154.944225278821, 11165.16261280391, 11204.103671706243, 21880.23419180321, 21921.0, 21946.0, 21979.450513737283, 22064.227752028924, 7865.724699635485, 7925.128235894047, 7955.0, 8045.758627241192, 8053.0, 4168.6039826216465, 4244.257254980428, 4266.296061149876, 4301.440812694393, 4454.554544545585, 3614.584322802859, 3760.8683696071053, 3763.454299126611, 3763.8494460221286, 3765.755225910307, 671.9584643802087, 674.4402146218627, 685.4584877946467, 691.0808624529363, 692.9896051559231, 622.8380621038472, 654.6399480285824, 686.4623243933553, 689.6069240532948, 692.8060143159923, 8407.411481196257, 8884.955575222082, 9443.811123777623, 9642.325037247325, 9644.807103857884, 524.404800551377, 551.1402212548437, 577.3995045152993, 599.2808629644444, 608.6044071353656, 4003.959960400417, 4611.0, 4678.95321046792, 4712.670113092051, 4743.383360163226, 123560.38219808844, 131078.0, 133412.0, 135395.0, 160142.39857601275, 107928.0, 108822.0, 109411.0, 110030.0, 110397.68806935805, 98136.99999999857, 98240.01759982308, 99160.00839991508, 101537.96924061478, 103274.96725032803, 8968.641254349754, 9509.61961521559, 9710.514474276399, 9789.706308810748, 9887.604495820087, 58113.709431452575, 58850.58390657474, 60389.69805150946, 60399.69800151147, 62756.686216568625, 83842.0, 89352.0, 90632.0, 90865.0, 93170.06829931615, 12134.434315497303, 12619.87380126187, 12649.557265495663, 13086.607401777961, 13309.334533273492, 13745.656358591115, 13880.791788122984, 14855.0, 15103.32035058447, 15214.847851521343, 13264.270465124126, 13521.72956540844, 13543.79684304756, 13627.16033335487, 13929.303534823015, 13351.866481335062, 13356.0, 13486.740171332991, 13615.115017523829, 14169.787453188004, 13456.596302110953, 13583.252921089435, 13759.312034398039, 13914.930425348213, 14268.0, 9349.766255843659, 11032.613858514913, 11389.544418223179, 11474.4262786862, 11595.884041159481, 10946.343219406543, 11258.493367798632, 11318.4906679198, 11416.429178541206, 11509.251898626562], "value": 7705.586542148986, "unit": "score"}], "name": "dromaeo_css", "value": 7315.209627270578, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 114.0, 113.0, 114.0, 115.0, 113.0, 113.0, 114.0, 114.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 116.0, 113.0, 166.0, 141.0, 140.0, 115.0, 113.0, 156.0, 136.0], "value": 134.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 181.0, 184.0, 183.0, 184.0, 181.0, 181.0, 182.0, 182.0], "value": 182.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 59.0, 87.0, 62.0, 67.0, 53.0, 55.0, 78.0, 58.0], "value": 65.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 91.0, 68.0, 66.0, 69.0, 92.0, 66.0, 67.0, 89.0], "value": 76.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 90.0, 87.0, 90.0, 86.0, 90.0, 87.0, 90.0, 86.0], "value": 88.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 94.0], "value": 95.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 88.0, 82.0, 78.0, 82.0, 84.0, 82.0, 82.0, 79.0, 73.0], "value": 81.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 53.0, 55.0, 77.0, 77.0, 56.0, 54.0, 53.0, 76.0], "value": 61.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 79.0, 75.0, 70.0, 69.0, 69.0, 70.0, 74.0, 73.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 85.0, 101.0, 105.0, 106.0, 81.0, 89.0, 87.0, 90.0], "value": 92.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 144.0, 142.0, 144.0, 144.0, 138.0, 178.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 173.0, 175.0, 171.0, 172.0, 172.0, 170.0, 170.0, 172.0, 172.0], "value": 171.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 68.0, 68.0, 68.0, 67.0, 67.0, 68.0, 68.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1449.3, "alertThreshold": 2.0}]} 01:13:04 INFO - Return code: 0 01:13:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:13:04 INFO - # TBPL SUCCESS # 01:13:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:13:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:13:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:13:04 INFO - 2016-10-19 01:13:04.178 screenresolution[1669:10695] starting screenresolution argv=screenresolution get 01:13:04 INFO - 2016-10-19 01:13:04.180 screenresolution[1669:10695] Display 0: 1600x1200x32@60 01:13:04 INFO - 2016-10-19 01:13:04.186 screenresolution[1670:10698] starting screenresolution argv=screenresolution list 01:13:04 INFO - Available Modes on Display 0 01:13:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:13:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:13:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:13:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:13:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:13:04 INFO - Intel Iris: 01:13:04 INFO - Chipset Model: Intel Iris 01:13:04 INFO - Type: GPU 01:13:04 INFO - Bus: Built-In 01:13:04 INFO - VRAM (Dynamic, Max): 1536 MB 01:13:04 INFO - Vendor: Intel (0x8086) 01:13:04 INFO - Device ID: 0x0a2e 01:13:04 INFO - Revision ID: 0x0009 01:13:04 INFO - Displays: 01:13:04 INFO - Display: 01:13:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:13:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:13:04 INFO - Display Serial Number: 1600x1200 60 01:13:04 INFO - Main Display: Yes 01:13:04 INFO - Mirror: Off 01:13:04 INFO - Online: Yes 01:13:04 INFO - Rotation: Supported 01:13:04 INFO - Return code: 0 01:13:04 INFO - Running post-action listener: _resource_record_post_action 01:13:04 INFO - [mozharness: 2016-10-19 08:13:04.429741Z] Finished run-tests step (success) 01:13:04 INFO - Running post-run listener: _resource_record_post_run 01:13:04 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 32148480; Write bytes: 708646912; Read time: 199; Write time: 1969 01:13:04 INFO - TinderboxPrint: CPU usage
53.5% 01:13:04 INFO - TinderboxPrint: I/O read bytes / time
32,148,480 / 199 01:13:04 INFO - TinderboxPrint: I/O write bytes / time
708,646,912 / 1,969 01:13:04 INFO - TinderboxPrint: CPU idle
2,260.5 (46.5%) 01:13:04 INFO - TinderboxPrint: CPU system
966.9 (19.9%) 01:13:04 INFO - TinderboxPrint: CPU user
1,634.3 (33.6%) 01:13:04 INFO - TinderboxPrint: Swap in / out
435,052,544 / 0 01:13:04 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 407339520; Write bytes: 409841664; Read time: 31042; Write time: 846 01:13:04 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 29137920; Write bytes: 297330688; Read time: 177; Write time: 1116 01:13:04 INFO - Running post-run listener: _upload_blobber_files 01:13:04 INFO - Blob upload gear active. 01:13:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:13:04 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:13:04 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:13:04 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:13:05 INFO - (blobuploader) - INFO - Open directory for files ... 01:13:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:13:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:13:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:13:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:13:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:13:06 INFO - (blobuploader) - INFO - Done attempting. 01:13:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:13:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:13:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:13:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:13:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:13:07 INFO - (blobuploader) - INFO - Done attempting. 01:13:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:13:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:13:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:13:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:13:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:13:09 INFO - (blobuploader) - INFO - Done attempting. 01:13:09 INFO - (blobuploader) - INFO - Iteration through files over. 01:13:09 INFO - Return code: 0 01:13:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:13:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:13:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/db55d2b32f3ea61af31cb134ba78100d898d5be9bd11c5292fae9472d72f16686315d1c1619a4bcf26287ff8bf022c0cf172d687f1b645e243b9fc4f53f9d3d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/406b93e93b5a766704d7b4be244e9c7beadadccb61d8deb6597176bc35288d72fd3ead67d2e347707f64707f608d2d6ea3e174384ab332b00b5aec195a5c420d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4b5deddcc70b4d455865f3fa5e9f015e625660839780e743676592e00daf9cde76055066592a7ac276b4d4b5d1600bb700e661f5048f7f93490089cba93e5405"} 01:13:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:13:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:13:09 INFO - Contents: 01:13:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/db55d2b32f3ea61af31cb134ba78100d898d5be9bd11c5292fae9472d72f16686315d1c1619a4bcf26287ff8bf022c0cf172d687f1b645e243b9fc4f53f9d3d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/406b93e93b5a766704d7b4be244e9c7beadadccb61d8deb6597176bc35288d72fd3ead67d2e347707f64707f608d2d6ea3e174384ab332b00b5aec195a5c420d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4b5deddcc70b4d455865f3fa5e9f015e625660839780e743676592e00daf9cde76055066592a7ac276b4d4b5d1600bb700e661f5048f7f93490089cba93e5405"} 01:13:09 INFO - Running post-run listener: copy_logs_to_upload_dir 01:13:09 INFO - Copying logs to upload dir... 01:13:09 INFO - mkdir: /builds/slave/test/build/upload/logs 01:13:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.438359 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-19 01:13:09.732893) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 01:13:09.740422) ========= 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.KRSbX6MkK7/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.ivR6zk7ZFh/Listeners TMPDIR=/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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/Autoland/sha512/db55d2b32f3ea61af31cb134ba78100d898d5be9bd11c5292fae9472d72f16686315d1c1619a4bcf26287ff8bf022c0cf172d687f1b645e243b9fc4f53f9d3d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/406b93e93b5a766704d7b4be244e9c7beadadccb61d8deb6597176bc35288d72fd3ead67d2e347707f64707f608d2d6ea3e174384ab332b00b5aec195a5c420d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4b5deddcc70b4d455865f3fa5e9f015e625660839780e743676592e00daf9cde76055066592a7ac276b4d4b5d1600bb700e661f5048f7f93490089cba93e5405"} build_url:https://queue.taskcluster.net/v1/task/JvFhNxb0TuOX5YjTjDcuAw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011032 build_url: 'https://queue.taskcluster.net/v1/task/JvFhNxb0TuOX5YjTjDcuAw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/db55d2b32f3ea61af31cb134ba78100d898d5be9bd11c5292fae9472d72f16686315d1c1619a4bcf26287ff8bf022c0cf172d687f1b645e243b9fc4f53f9d3d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/406b93e93b5a766704d7b4be244e9c7beadadccb61d8deb6597176bc35288d72fd3ead67d2e347707f64707f608d2d6ea3e174384ab332b00b5aec195a5c420d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4b5deddcc70b4d455865f3fa5e9f015e625660839780e743676592e00daf9cde76055066592a7ac276b4d4b5d1600bb700e661f5048f7f93490089cba93e5405"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 01:13:09.772380) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 01:13:09.772700) ========= 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.KRSbX6MkK7/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.ivR6zk7ZFh/Listeners TMPDIR=/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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.005137 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 01:13:09.824866) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 01:13:09.825191) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 01:13:09.825507) ========= ========= Total master_lag: 0.20 =========