builder: larch_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0382 starttime: 1477356996.42 results: success (0) buildid: 20161024115824 builduid: 415c3862af854656a900284eee054a02 revision: e1d52389c70af17701017488f779c5ddd2ee8882 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 17:56:36.423905) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 17:56:36.424488) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 17:56:36.424809) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 17:56:36.448408) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 17:56:36.448963) ========= 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.suCx7kL9cC/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.hP2YQtOs2b/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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-24 17:56:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 157M=0s 2016-10-24 17:56:36 (157 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126500 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 17:56:36.599655) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 17:56:36.600163) ========= 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.suCx7kL9cC/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.hP2YQtOs2b/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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.020985 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 17:56:36.652786) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 17:56:36.653620) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev e1d52389c70af17701017488f779c5ddd2ee8882 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev e1d52389c70af17701017488f779c5ddd2ee8882 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.suCx7kL9cC/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.hP2YQtOs2b/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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-24 17:56:36,735 truncating revision to first 12 chars 2016-10-24 17:56:36,735 Setting DEBUG logging. 2016-10-24 17:56:36,735 attempt 1/10 2016-10-24 17:56:36,735 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/e1d52389c70a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-24 17:56:37,377 unpacking tar archive at: larch-e1d52389c70a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.900246 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 17:56:37.577397) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 17:56:37.577797) ========= script_repo_revision: e1d52389c70af17701017488f779c5ddd2ee8882 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 17:56:37.578385) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 17:56:37.578720) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 17:56:37.597085) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-10-24 17:56:37.597438) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 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', 'Larch', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.suCx7kL9cC/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.hP2YQtOs2b/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 17:56:37 INFO - MultiFileLogger online at 20161024 17:56:37 in /builds/slave/test 17:56:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 17:56:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:56:37 INFO - {'append_to_log': False, 17:56:37 INFO - 'base_work_dir': '/builds/slave/test', 17:56:37 INFO - 'blob_upload_branch': 'Larch', 17:56:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:56:37 INFO - 'branch': 'Larch', 17:56:37 INFO - 'buildbot_json_path': 'buildprops.json', 17:56:37 INFO - 'config_files': ('talos/mac_config.py',), 17:56:37 INFO - 'default_actions': ('clobber', 17:56:37 INFO - 'read-buildbot-config', 17:56:37 INFO - 'download-and-extract', 17:56:37 INFO - 'populate-webroot', 17:56:37 INFO - 'create-virtualenv', 17:56:37 INFO - 'install', 17:56:37 INFO - 'run-tests'), 17:56:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:56:37 INFO - 'download_minidump_stackwalk': True, 17:56:37 INFO - 'download_symbols': 'ondemand', 17:56:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:56:37 INFO - 'tooltool.py': '/tools/tooltool.py', 17:56:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:56:37 INFO - '/tools/misc-python/virtualenv.py')}, 17:56:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:56:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:56:37 INFO - 'installer_path': 'installer.exe', 17:56:37 INFO - 'log_level': 'info', 17:56:37 INFO - 'log_name': 'talos', 17:56:37 INFO - 'log_to_console': True, 17:56:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:56:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:56:37 INFO - 'opt_config_files': (), 17:56:37 INFO - 'pip_index': False, 17:56:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:56:37 INFO - 'cmd': ('bash', 17:56:37 INFO - '-c', 17:56:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:56:37 INFO - 'enabled': True, 17:56:37 INFO - 'halt_on_failure': False, 17:56:37 INFO - 'name': 'check_screen_resolution'},), 17:56:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:56:37 INFO - 'cmd': ('bash', 17:56:37 INFO - '-c', 17:56:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:56:37 INFO - 'enabled': True, 17:56:37 INFO - 'halt_on_failure': False, 17:56:37 INFO - 'name': 'check_screen_resolution'},), 17:56:37 INFO - 'run_cmd_checks_enabled': True, 17:56:37 INFO - 'sps_profile': False, 17:56:37 INFO - 'sps_profile_interval': 0, 17:56:37 INFO - 'suite': 'dromaeojs', 17:56:37 INFO - 'system_bits': '32', 17:56:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:56:37 INFO - 'title': 't-yosemite-r7-0382', 17:56:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:56:37 INFO - 'use_talos_json': True, 17:56:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:56:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:56:37 INFO - 'work_dir': 'build'} 17:56:37 INFO - [mozharness: 2016-10-25 00:56:37.793837Z] Running clobber step. 17:56:37 INFO - Running pre-action listener: _resource_record_pre_action 17:56:37 INFO - Running main action method: clobber 17:56:37 INFO - rmtree: /builds/slave/test/build 17:56:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:56:38 INFO - Running post-action listener: _resource_record_post_action 17:56:38 INFO - [mozharness: 2016-10-25 00:56:38.655915Z] Finished clobber step (success) 17:56:38 INFO - [mozharness: 2016-10-25 00:56:38.656098Z] Running read-buildbot-config step. 17:56:38 INFO - Running pre-action listener: _resource_record_pre_action 17:56:38 INFO - Running main action method: read_buildbot_config 17:56:38 INFO - Using buildbot properties: 17:56:38 INFO - { 17:56:38 INFO - "project": "", 17:56:38 INFO - "product": "firefox", 17:56:38 INFO - "script_repo_revision": "production", 17:56:38 INFO - "builddir": "larch_yosemite_r7_test-dromaeojs", 17:56:38 INFO - "repository": "", 17:56:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 larch talos dromaeojs", 17:56:38 INFO - "buildid": "20161024115824", 17:56:38 INFO - "pgo_build": "False", 17:56:38 INFO - "basedir": "/builds/slave/test", 17:56:38 INFO - "buildnumber": 0, 17:56:38 INFO - "slavename": "t-yosemite-r7-0382", 17:56:38 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 17:56:38 INFO - "platform": "yosemite_r7", 17:56:38 INFO - "scheduler": "tests-larch-macosx64-talos", 17:56:38 INFO - "branch": "larch", 17:56:38 INFO - "repo_path": "projects/larch", 17:56:38 INFO - "revision": "e1d52389c70af17701017488f779c5ddd2ee8882", 17:56:38 INFO - "stage_platform": "macosx64", 17:56:38 INFO - "builduid": "415c3862af854656a900284eee054a02", 17:56:38 INFO - "slavebuilddir": "test" 17:56:38 INFO - } 17:56:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/SXNuQEL4Qp24IXVJuariQw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 17:56:38 INFO - Running post-action listener: _resource_record_post_action 17:56:38 INFO - [mozharness: 2016-10-25 00:56:38.660268Z] Finished read-buildbot-config step (success) 17:56:38 INFO - [mozharness: 2016-10-25 00:56:38.660454Z] Running download-and-extract step. 17:56:38 INFO - Running pre-action listener: _resource_record_pre_action 17:56:38 INFO - Running main action method: download_and_extract 17:56:38 INFO - mkdir: /builds/slave/test/build/tests 17:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:38 INFO - trying https://queue.taskcluster.net/v1/task/SXNuQEL4Qp24IXVJuariQw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 17:56:38 INFO - Downloading https://queue.taskcluster.net/v1/task/SXNuQEL4Qp24IXVJuariQw/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 17:56:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SXNuQEL4Qp24IXVJuariQw/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 17:56:40 INFO - Downloaded 1199 bytes. 17:56:40 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 17:56:40 INFO - Using the following test package requirements: 17:56:40 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 17:56:40 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:56:40 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 17:56:40 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:56:40 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 17:56:40 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:56:40 INFO - u'jsshell-mac.zip'], 17:56:40 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:56:40 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 17:56:40 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 17:56:40 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:56:40 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 17:56:40 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:56:40 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 17:56:40 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:56:40 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 17:56:40 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:56:40 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 17:56:40 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:56:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SXNuQEL4Qp24IXVJuariQw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 17:56:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SXNuQEL4Qp24IXVJuariQw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:56:40 INFO - Fetch https://queue.taskcluster.net/v1/task/SXNuQEL4Qp24IXVJuariQw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 17:56:40 INFO - Http code: 200 17:56:40 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 17:56:40 INFO - x-amz-cf-id: zzPHQxjmMC1k2AmVpWZISJFUIsxKrORoo0yryzk_nXTk0H9jKBm5oA== 17:56:40 INFO - x-amz-version-id: lw.90Oy4T3KTOCp9DmDanuhglWvfWiBh 17:56:40 INFO - Expected file size: 16409314 17:56:40 INFO - Obtained file size: 16409314 17:56:47 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 17:56:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SXNuQEL4Qp24IXVJuariQw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 17:56:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SXNuQEL4Qp24IXVJuariQw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:56:47 INFO - Fetch https://queue.taskcluster.net/v1/task/SXNuQEL4Qp24IXVJuariQw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 17:56:47 INFO - Http code: 200 17:56:47 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 17:56:47 INFO - x-amz-cf-id: nyNJBkvo2obOMDErF2p0qF-lDsq5LjIVFMJ4jp6pNCp152WdFYFzkQ== 17:56:47 INFO - x-amz-version-id: lw.90Oy4T3KTOCp9DmDanuhglWvfWiBh 17:56:48 INFO - Expected file size: 16409314 17:56:48 INFO - Obtained file size: 16409314 17:56:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SXNuQEL4Qp24IXVJuariQw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 17:56:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SXNuQEL4Qp24IXVJuariQw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:56:54 INFO - Fetch https://queue.taskcluster.net/v1/task/SXNuQEL4Qp24IXVJuariQw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 17:56:55 INFO - Http code: 200 17:56:55 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 17:56:55 INFO - x-amz-cf-id: N4ityc581jVFE66Z864XLqdb3dGCKxVvxZr2Pk93qEtUadFyBdGkRg== 17:56:55 INFO - x-amz-version-id: TvjL59NPSxy.os1aDgdMZPQOhxMQQUsp 17:56:55 INFO - Expected file size: 14409028 17:56:55 INFO - Obtained file size: 14409028 17:56:55 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')]} 17:56:55 INFO - trying https://queue.taskcluster.net/v1/task/SXNuQEL4Qp24IXVJuariQw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 17:56:55 INFO - Downloading https://queue.taskcluster.net/v1/task/SXNuQEL4Qp24IXVJuariQw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 17:56:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SXNuQEL4Qp24IXVJuariQw/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 17:56:58 INFO - Downloaded 111298151 bytes. 17:56:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SXNuQEL4Qp24IXVJuariQw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 17:56:58 INFO - mkdir: /builds/slave/test/properties 17:56:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:56:58 INFO - Writing to file /builds/slave/test/properties/build_url 17:56:58 INFO - Contents: 17:56:58 INFO - build_url:https://queue.taskcluster.net/v1/task/SXNuQEL4Qp24IXVJuariQw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 17:56:59 INFO - Running post-action listener: _resource_record_post_action 17:56:59 INFO - Running post-action listener: set_extra_try_arguments 17:56:59 INFO - [mozharness: 2016-10-25 00:56:59.624383Z] Finished download-and-extract step (success) 17:56:59 INFO - [mozharness: 2016-10-25 00:56:59.624539Z] Running populate-webroot step. 17:56:59 INFO - Running pre-action listener: _resource_record_pre_action 17:56:59 INFO - Running main action method: populate_webroot 17:56:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:56:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:56:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:56:59 INFO - '--tppagecycles', 17:56:59 INFO - '7'], 17:56:59 INFO - 'tests': ['tsvgm']}}, 17:56:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:56:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:56:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:56:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:56:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:56:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:56:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:56:59 INFO - 'talos_options': ['--disable-e10s'], 17:56:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:56:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:56:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:56:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:56:59 INFO - 'talos_options': ['--disable-e10s'], 17:56:59 INFO - 'tests': ['damp', 'tps']}, 17:56:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:56:59 INFO - 'tests': ['damp', 'tps']}, 17:56:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:56:59 INFO - 'tests': ['dromaeo_dom']}, 17:56:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:56:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:56:59 INFO - 'tests': ['basic_compositor_video']}, 17:56:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:56:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:56:59 INFO - 'tests': ['a11yr', 17:56:59 INFO - 'ts_paint', 17:56:59 INFO - 'tpaint', 17:56:59 INFO - 'sessionrestore', 17:56:59 INFO - 'sessionrestore_no_auto_restore', 17:56:59 INFO - 'tabpaint']}, 17:56:59 INFO - 'other-e10s': {'tests': ['a11yr', 17:56:59 INFO - 'ts_paint', 17:56:59 INFO - 'tpaint', 17:56:59 INFO - 'sessionrestore', 17:56:59 INFO - 'sessionrestore_no_auto_restore', 17:56:59 INFO - 'tabpaint']}, 17:56:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:56:59 INFO - 'ts_paint', 17:56:59 INFO - 'tpaint', 17:56:59 INFO - 'sessionrestore', 17:56:59 INFO - 'sessionrestore_no_auto_restore', 17:56:59 INFO - 'tabpaint']}, 17:56:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:56:59 INFO - 'ts_paint', 17:56:59 INFO - 'tpaint', 17:56:59 INFO - 'sessionrestore', 17:56:59 INFO - 'sessionrestore_no_auto_restore', 17:56:59 INFO - 'tabpaint']}, 17:56:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:56:59 INFO - 'tests': ['a11yr', 17:56:59 INFO - 'ts_paint', 17:56:59 INFO - 'tpaint', 17:56:59 INFO - 'sessionrestore', 17:56:59 INFO - 'sessionrestore_no_auto_restore', 17:56:59 INFO - 'tabpaint']}, 17:56:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:56:59 INFO - 'tests': ['a11yr', 17:56:59 INFO - 'ts_paint', 17:56:59 INFO - 'tpaint', 17:56:59 INFO - 'sessionrestore', 17:56:59 INFO - 'sessionrestore_no_auto_restore', 17:56:59 INFO - 'tabpaint']}, 17:56:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:56:59 INFO - 'tests': ['tsvgx', 17:56:59 INFO - 'tsvgr_opacity', 17:56:59 INFO - 'tart', 17:56:59 INFO - 'tscrollx', 17:56:59 INFO - 'cart']}, 17:56:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:56:59 INFO - 'tsvgr_opacity', 17:56:59 INFO - 'tart', 17:56:59 INFO - 'tscrollx', 17:56:59 INFO - 'cart']}, 17:56:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:56:59 INFO - 'talos_options': ['--disable-e10s'], 17:56:59 INFO - 'tests': ['tp5o']}, 17:56:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:56:59 INFO - 'tests': ['tp5o']}, 17:56:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:56:59 INFO - 'talos_options': ['--disable-e10s', 17:56:59 INFO - '--xperf_path', 17:56:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:56:59 INFO - 'tests': ['tp5n']}, 17:56:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:56:59 INFO - 'talos_options': ['--xperf_path', 17:56:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:56:59 INFO - 'tests': ['tp5n']}}, 17:56:59 INFO - 'talos.zip': {'path': '', 17:56:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:56:59 INFO - Running post-action listener: _resource_record_post_action 17:56:59 INFO - [mozharness: 2016-10-25 00:56:59.643360Z] Finished populate-webroot step (success) 17:56:59 INFO - [mozharness: 2016-10-25 00:56:59.643497Z] Running create-virtualenv step. 17:56:59 INFO - Running pre-action listener: _resource_record_pre_action 17:56:59 INFO - Running main action method: create_virtualenv 17:56:59 INFO - Creating virtualenv /builds/slave/test/build/venv 17:56:59 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 17:56:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:56:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:56:59 INFO - Using real prefix '/tools/python27' 17:56:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:57:00 INFO - Installing distribute.............................................................................................................................................................................................done. 17:57:03 INFO - Installing pip.................done. 17:57:03 INFO - Return code: 0 17:57:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:57:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:57:03 INFO - Reading from file tmpfile_stdout 17:57:03 INFO - Output received: 17:57:03 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) 17:57:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:57:03 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')]} 17:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:03 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')]} 17:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:03 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 0x10718f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107105570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb10158f940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fa3d30>, '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 0x106dc9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f9bb20>, '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.suCx7kL9cC/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.hP2YQtOs2b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 17:57:03 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 17:57:03 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 17:57:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.suCx7kL9cC/Render', 17:57:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:57:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:57:03 INFO - 'HOME': '/Users/cltbld', 17:57:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:57:03 INFO - 'LOGNAME': 'cltbld', 17:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:03 INFO - 'MOZ_NO_REMOTE': '1', 17:57:03 INFO - 'NO_EM_RESTART': '1', 17:57:03 INFO - 'PAGER': '/bin/cat', 17:57:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:03 INFO - 'PWD': '/builds/slave/test', 17:57:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:57:03 INFO - 'SHELL': '/bin/bash', 17:57:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hP2YQtOs2b/Listeners', 17:57:03 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 17:57:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:57:03 INFO - 'USER': 'cltbld', 17:57:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:57:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:03 INFO - 'XPC_FLAGS': '0x0', 17:57:03 INFO - 'XPC_SERVICE_NAME': '0', 17:57:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:57:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:03 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 17:57:03 INFO - Cleaning up... 17:57:03 INFO - Return code: 0 17:57:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:57:03 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')]} 17:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:03 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')]} 17:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:03 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 0x10718f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107105570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb10158f940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fa3d30>, '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 0x106dc9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f9bb20>, '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.suCx7kL9cC/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.hP2YQtOs2b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 17:57:03 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 17:57:03 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 17:57:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.suCx7kL9cC/Render', 17:57:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:57:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:57:03 INFO - 'HOME': '/Users/cltbld', 17:57:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:57:03 INFO - 'LOGNAME': 'cltbld', 17:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:03 INFO - 'MOZ_NO_REMOTE': '1', 17:57:03 INFO - 'NO_EM_RESTART': '1', 17:57:03 INFO - 'PAGER': '/bin/cat', 17:57:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:03 INFO - 'PWD': '/builds/slave/test', 17:57:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:57:03 INFO - 'SHELL': '/bin/bash', 17:57:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hP2YQtOs2b/Listeners', 17:57:03 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 17:57:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:57:03 INFO - 'USER': 'cltbld', 17:57:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:57:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:03 INFO - 'XPC_FLAGS': '0x0', 17:57:03 INFO - 'XPC_SERVICE_NAME': '0', 17:57:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:04 INFO - Downloading/unpacking psutil>=3.1.1 17:57:04 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 17:57:04 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 17:57:04 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 17:57:04 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 17:57:04 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 17:57:04 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 17:57:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:57:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:57:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:57:07 INFO - Installing collected packages: psutil 17:57:07 INFO - Running setup.py install for psutil 17:57:07 INFO - building 'psutil._psutil_osx' extension 17:57:07 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 17:57:07 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 17:57:07 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 17:57:08 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 17:57:08 INFO - building 'psutil._psutil_posix' extension 17:57:08 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 17:57:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:57:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:57:08 INFO - ^ 17:57:08 INFO - 1 warning generated. 17:57:08 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 17:57:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:57:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:57:08 INFO - Successfully installed psutil 17:57:08 INFO - Cleaning up... 17:57:08 INFO - Return code: 0 17:57:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:57:08 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')]} 17:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:08 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')]} 17:57:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:08 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 0x10718f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107105570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb10158f940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fa3d30>, '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 0x106dc9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f9bb20>, '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.suCx7kL9cC/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.hP2YQtOs2b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 17:57:08 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 17:57:08 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 17:57:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.suCx7kL9cC/Render', 17:57:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:57:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:57:08 INFO - 'HOME': '/Users/cltbld', 17:57:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:57:08 INFO - 'LOGNAME': 'cltbld', 17:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:08 INFO - 'MOZ_NO_REMOTE': '1', 17:57:08 INFO - 'NO_EM_RESTART': '1', 17:57:08 INFO - 'PAGER': '/bin/cat', 17:57:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:08 INFO - 'PWD': '/builds/slave/test', 17:57:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:57:08 INFO - 'SHELL': '/bin/bash', 17:57:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hP2YQtOs2b/Listeners', 17:57:08 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 17:57:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:57:08 INFO - 'USER': 'cltbld', 17:57:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:57:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:08 INFO - 'XPC_FLAGS': '0x0', 17:57:08 INFO - 'XPC_SERVICE_NAME': '0', 17:57:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:57:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:57:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:57:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:57:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:57:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:57:11 INFO - Installing collected packages: mozsystemmonitor 17:57:11 INFO - Running setup.py install for mozsystemmonitor 17:57:11 INFO - Successfully installed mozsystemmonitor 17:57:11 INFO - Cleaning up... 17:57:11 INFO - Return code: 0 17:57:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:57:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10718f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107105570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb10158f940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fa3d30>, '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 0x106dc9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f9bb20>, '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.suCx7kL9cC/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.hP2YQtOs2b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 17:57:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:57:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:57:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.suCx7kL9cC/Render', 17:57:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:57:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:57:11 INFO - 'HOME': '/Users/cltbld', 17:57:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:57:11 INFO - 'LOGNAME': 'cltbld', 17:57:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:11 INFO - 'MOZ_NO_REMOTE': '1', 17:57:11 INFO - 'NO_EM_RESTART': '1', 17:57:11 INFO - 'PAGER': '/bin/cat', 17:57:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:57:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:11 INFO - 'PWD': '/builds/slave/test', 17:57:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:57:11 INFO - 'SHELL': '/bin/bash', 17:57:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hP2YQtOs2b/Listeners', 17:57:11 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 17:57:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:57:11 INFO - 'USER': 'cltbld', 17:57:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:57:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:57:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:11 INFO - 'XPC_FLAGS': '0x0', 17:57:11 INFO - 'XPC_SERVICE_NAME': '0', 17:57:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:57:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:11 INFO - Downloading/unpacking jsonschema==2.5.1 17:57:11 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 17:57:11 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 17:57:11 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 17:57:11 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 17:57:11 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 17:57:11 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 17:57:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:57:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:57:14 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 17:57:14 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 17:57:14 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 17:57:14 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 17:57:14 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 17:57:14 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 17:57:14 INFO - Downloading functools32-3.2.3-2.tar.gz 17:57:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:57:14 INFO - warning: no files found matching '*.txt' 17:57:14 INFO - no previously-included directories found matching 'build' 17:57:14 INFO - no previously-included directories found matching 'dist' 17:57:14 INFO - no previously-included directories found matching '.git*' 17:57:14 INFO - Installing collected packages: jsonschema, functools32 17:57:14 INFO - Running setup.py install for functools32 17:57:15 INFO - warning: no files found matching '*.txt' 17:57:15 INFO - no previously-included directories found matching 'build' 17:57:15 INFO - no previously-included directories found matching 'dist' 17:57:15 INFO - no previously-included directories found matching '.git*' 17:57:15 INFO - Successfully installed jsonschema functools32 17:57:15 INFO - Cleaning up... 17:57:15 INFO - Return code: 0 17:57:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:57:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10718f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107105570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb10158f940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fa3d30>, '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 0x106dc9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f9bb20>, '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.suCx7kL9cC/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.hP2YQtOs2b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 17:57:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:57:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:57:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.suCx7kL9cC/Render', 17:57:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:57:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:57:15 INFO - 'HOME': '/Users/cltbld', 17:57:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:57:15 INFO - 'LOGNAME': 'cltbld', 17:57:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:15 INFO - 'MOZ_NO_REMOTE': '1', 17:57:15 INFO - 'NO_EM_RESTART': '1', 17:57:15 INFO - 'PAGER': '/bin/cat', 17:57:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:57:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:15 INFO - 'PWD': '/builds/slave/test', 17:57:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:57:15 INFO - 'SHELL': '/bin/bash', 17:57:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hP2YQtOs2b/Listeners', 17:57:15 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 17:57:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:57:15 INFO - 'USER': 'cltbld', 17:57:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:57:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:57:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:15 INFO - 'XPC_FLAGS': '0x0', 17:57:15 INFO - 'XPC_SERVICE_NAME': '0', 17:57:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:57:15 INFO - Cleaning up... 17:57:15 INFO - Return code: 0 17:57:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:57:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10718f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107105570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb10158f940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fa3d30>, '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 0x106dc9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f9bb20>, '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.suCx7kL9cC/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.hP2YQtOs2b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 17:57:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:57:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:57:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.suCx7kL9cC/Render', 17:57:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:57:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:57:15 INFO - 'HOME': '/Users/cltbld', 17:57:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:57:15 INFO - 'LOGNAME': 'cltbld', 17:57:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:15 INFO - 'MOZ_NO_REMOTE': '1', 17:57:15 INFO - 'NO_EM_RESTART': '1', 17:57:15 INFO - 'PAGER': '/bin/cat', 17:57:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:57:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:15 INFO - 'PWD': '/builds/slave/test', 17:57:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:57:15 INFO - 'SHELL': '/bin/bash', 17:57:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hP2YQtOs2b/Listeners', 17:57:15 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 17:57:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:57:15 INFO - 'USER': 'cltbld', 17:57:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:57:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:57:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:15 INFO - 'XPC_FLAGS': '0x0', 17:57:15 INFO - 'XPC_SERVICE_NAME': '0', 17:57:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:15 INFO - Downloading/unpacking blobuploader==1.2.4 17:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:57:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:57:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:57:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:57:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:57:18 INFO - Downloading blobuploader-1.2.4.tar.gz 17:57:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:57:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:57:18 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 17:57:18 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 17:57:18 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 17:57:18 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 17:57:18 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 17:57:18 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 17:57:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:57:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:57:18 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 17:57:18 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 17:57:18 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 17:57:18 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 17:57:18 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 17:57:18 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 17:57:19 INFO - Downloading docopt-0.6.1.tar.gz 17:57:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:57:19 INFO - Installing collected packages: blobuploader, requests, docopt 17:57:19 INFO - Running setup.py install for blobuploader 17:57:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:57:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:57:19 INFO - Running setup.py install for requests 17:57:20 INFO - Running setup.py install for docopt 17:57:20 INFO - Successfully installed blobuploader requests docopt 17:57:20 INFO - Cleaning up... 17:57:20 INFO - Return code: 0 17:57:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:57: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')]} 17:57:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57: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')]} 17:57:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:20 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 0x10718f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107105570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb10158f940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fa3d30>, '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 0x106dc9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f9bb20>, '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.suCx7kL9cC/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.hP2YQtOs2b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 17:57:20 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 17:57:20 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 17:57:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.suCx7kL9cC/Render', 17:57:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:57:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:57:20 INFO - 'HOME': '/Users/cltbld', 17:57:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:57:20 INFO - 'LOGNAME': 'cltbld', 17:57:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:20 INFO - 'MOZ_NO_REMOTE': '1', 17:57:20 INFO - 'NO_EM_RESTART': '1', 17:57:20 INFO - 'PAGER': '/bin/cat', 17:57:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:57:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:20 INFO - 'PWD': '/builds/slave/test', 17:57:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:57:20 INFO - 'SHELL': '/bin/bash', 17:57:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hP2YQtOs2b/Listeners', 17:57:20 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 17:57:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:57:20 INFO - 'USER': 'cltbld', 17:57:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:57:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:57:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:20 INFO - 'XPC_FLAGS': '0x0', 17:57:20 INFO - 'XPC_SERVICE_NAME': '0', 17:57:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:57:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:57:20 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-OIT9Ws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:57:20 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-ZoOhc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:57:20 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-Y827x6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:57:20 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-p89KPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:57:21 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-P2R65t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:57:21 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-oRS9MN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:57:21 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-DgzvX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:57:21 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-YOWi7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:57:21 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-4tUnr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:57:21 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-sXCv1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:57:21 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-vC4pGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:57:21 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-aDL0Om-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:57:21 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-qj_GgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:57:21 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-nnKMCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:57:22 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-IV1boK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:57:22 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-y5Z_f4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:57:22 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-Zv6AEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:57:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:57:22 INFO - Running setup.py install for manifestparser 17:57:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:57:22 INFO - Running setup.py install for mozcrash 17:57:22 INFO - Running setup.py install for mozdebug 17:57:22 INFO - Running setup.py install for mozdevice 17:57:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:57:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:57:22 INFO - Running setup.py install for mozfile 17:57:23 INFO - Running setup.py install for mozhttpd 17:57:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:57:23 INFO - Running setup.py install for mozinfo 17:57:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:57:23 INFO - Running setup.py install for mozInstall 17:57:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:57:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:57:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:57:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:57:23 INFO - Running setup.py install for mozleak 17:57:23 INFO - Running setup.py install for mozlog 17:57:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:57:23 INFO - Running setup.py install for moznetwork 17:57:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:57:23 INFO - Running setup.py install for mozprocess 17:57:24 INFO - Running setup.py install for mozprofile 17:57:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:57:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:57:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:57:24 INFO - Running setup.py install for mozrunner 17:57:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:57:24 INFO - Running setup.py install for mozscreenshot 17:57:24 INFO - Running setup.py install for moztest 17:57:24 INFO - Running setup.py install for mozversion 17:57:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:57:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:57:24 INFO - Cleaning up... 17:57:24 INFO - Return code: 0 17:57:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:24 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 0x10718f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107105570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb10158f940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fa3d30>, '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 0x106dc9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f9bb20>, '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.suCx7kL9cC/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.hP2YQtOs2b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 17:57:24 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 17:57:24 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 17:57:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.suCx7kL9cC/Render', 17:57:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:57:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:57:24 INFO - 'HOME': '/Users/cltbld', 17:57:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:57:24 INFO - 'LOGNAME': 'cltbld', 17:57:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:24 INFO - 'MOZ_NO_REMOTE': '1', 17:57:24 INFO - 'NO_EM_RESTART': '1', 17:57:24 INFO - 'PAGER': '/bin/cat', 17:57:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:57:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:24 INFO - 'PWD': '/builds/slave/test', 17:57:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:57:24 INFO - 'SHELL': '/bin/bash', 17:57:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hP2YQtOs2b/Listeners', 17:57:24 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 17:57:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:57:24 INFO - 'USER': 'cltbld', 17:57:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:57:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:57:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:24 INFO - 'XPC_FLAGS': '0x0', 17:57:24 INFO - 'XPC_SERVICE_NAME': '0', 17:57:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:57:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:57:25 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-6Cp9cG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:57:25 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)) 17:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:57:25 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-QhRGyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:57:25 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)) 17:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:57:25 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-TD1hP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:57:25 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)) 17:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:57:25 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-WhKoO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:57:25 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)) 17:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:57:25 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-bcMH7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:57:25 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)) 17:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:57:25 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-FUB2Am-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:57:25 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)) 17:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:57:25 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-nt8BwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:57:25 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)) 17:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:57:25 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-diIMJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:57:26 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)) 17:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:57:26 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-EpD4wk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:57:26 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)) 17:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:57:26 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-mMaYge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:57:26 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)) 17:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:57:26 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-VEAi84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:57:26 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)) 17:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:57:26 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-RlvTH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:57:26 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)) 17:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:57:26 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-hdSoHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:57:26 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)) 17:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:57:26 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-G7oFdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:57:26 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)) 17:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:57:26 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-UxgLlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:57:26 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)) 17:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:57:26 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-N78STs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:57:26 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)) 17:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:57:26 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-xwmitv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:57:27 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)) 17:57:27 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)) 17:57:27 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)) 17:57:27 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)) 17:57:27 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)) 17:57:27 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)) 17:57:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:57:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:57:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:57:29 INFO - Downloading blessings-1.6.tar.gz 17:57:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:57:29 INFO - Installing collected packages: blessings 17:57:29 INFO - Running setup.py install for blessings 17:57:29 INFO - Successfully installed blessings 17:57:29 INFO - Cleaning up... 17:57:29 INFO - Return code: 0 17:57:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:57:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:57:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:57:30 INFO - Reading from file tmpfile_stdout 17:57:30 INFO - Current package versions: 17:57:30 INFO - blessings == 1.6 17:57:30 INFO - blobuploader == 1.2.4 17:57:30 INFO - docopt == 0.6.1 17:57:30 INFO - functools32 == 3.2.3-2 17:57:30 INFO - jsonschema == 2.5.1 17:57:30 INFO - manifestparser == 1.1 17:57:30 INFO - mozInstall == 1.12 17:57:30 INFO - mozcrash == 0.17 17:57:30 INFO - mozdebug == 0.1 17:57:30 INFO - mozdevice == 0.48 17:57:30 INFO - mozfile == 1.2 17:57:30 INFO - mozhttpd == 0.7 17:57:30 INFO - mozinfo == 0.9 17:57:30 INFO - mozleak == 0.1 17:57:30 INFO - mozlog == 3.4 17:57:30 INFO - moznetwork == 0.27 17:57:30 INFO - mozprocess == 0.23 17:57:30 INFO - mozprofile == 0.28 17:57:30 INFO - mozrunner == 6.12 17:57:30 INFO - mozscreenshot == 0.1 17:57:30 INFO - mozsystemmonitor == 0.3 17:57:30 INFO - moztest == 0.7 17:57:30 INFO - mozversion == 1.4 17:57:30 INFO - psutil == 3.1.1 17:57:30 INFO - requests == 1.2.3 17:57:30 INFO - wsgiref == 0.1.2 17:57:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:57:30 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')]} 17:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:30 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')]} 17:57:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:30 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 0x10718f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107105570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb10158f940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fa3d30>, '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 0x106dc9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f9bb20>, '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.suCx7kL9cC/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.hP2YQtOs2b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 17:57:30 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 17:57:30 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 17:57:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.suCx7kL9cC/Render', 17:57:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:57:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:57:30 INFO - 'HOME': '/Users/cltbld', 17:57:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:57:30 INFO - 'LOGNAME': 'cltbld', 17:57:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:30 INFO - 'MOZ_NO_REMOTE': '1', 17:57:30 INFO - 'NO_EM_RESTART': '1', 17:57:30 INFO - 'PAGER': '/bin/cat', 17:57:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:57:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:30 INFO - 'PWD': '/builds/slave/test', 17:57:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:57:30 INFO - 'SHELL': '/bin/bash', 17:57:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hP2YQtOs2b/Listeners', 17:57:30 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 17:57:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:57:30 INFO - 'USER': 'cltbld', 17:57:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:57:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:57:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:30 INFO - 'XPC_FLAGS': '0x0', 17:57:30 INFO - 'XPC_SERVICE_NAME': '0', 17:57:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:57:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:30 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)) 17:57:30 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)) 17:57:30 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)) 17:57:30 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)) 17:57:30 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)) 17:57:30 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)) 17:57:30 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)) 17:57:30 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)) 17:57:30 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)) 17:57:30 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)) 17:57:30 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)) 17:57:30 INFO - Cleaning up... 17:57:30 INFO - Return code: 0 17:57:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:57:30 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')]} 17:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:30 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')]} 17:57:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:30 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 0x10718f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107105570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb10158f940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fa3d30>, '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 0x106dc9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f9bb20>, '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.suCx7kL9cC/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.hP2YQtOs2b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 17:57:30 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 17:57:30 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 17:57:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.suCx7kL9cC/Render', 17:57:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:57:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:57:30 INFO - 'HOME': '/Users/cltbld', 17:57:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:57:30 INFO - 'LOGNAME': 'cltbld', 17:57:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:30 INFO - 'MOZ_NO_REMOTE': '1', 17:57:30 INFO - 'NO_EM_RESTART': '1', 17:57:30 INFO - 'PAGER': '/bin/cat', 17:57:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:57:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:30 INFO - 'PWD': '/builds/slave/test', 17:57:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:57:30 INFO - 'SHELL': '/bin/bash', 17:57:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hP2YQtOs2b/Listeners', 17:57:30 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 17:57:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:57:30 INFO - 'USER': 'cltbld', 17:57:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:57:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:57:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:30 INFO - 'XPC_FLAGS': '0x0', 17:57:30 INFO - 'XPC_SERVICE_NAME': '0', 17:57:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:57:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:57:30 INFO - Cleaning up... 17:57:30 INFO - Return code: 0 17:57:30 INFO - Running post-action listener: _resource_record_post_action 17:57:30 INFO - Running post-action listener: _start_resource_monitoring 17:57:30 INFO - Starting resource monitoring. 17:57:30 INFO - [mozharness: 2016-10-25 00:57:30.760947Z] Finished create-virtualenv step (success) 17:57:30 INFO - [mozharness: 2016-10-25 00:57:30.761952Z] Running install step. 17:57:30 INFO - Running pre-action listener: _resource_record_pre_action 17:57:30 INFO - Running main action method: install 17:57:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:57:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:57:31 INFO - Reading from file tmpfile_stdout 17:57:31 INFO - Detecting whether we're running mozinstall >=1.0... 17:57:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:57:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:57:31 INFO - Reading from file tmpfile_stdout 17:57:31 INFO - Output received: 17:57:31 INFO - Usage: mozinstall [options] installer 17:57:31 INFO - Options: 17:57:31 INFO - -h, --help show this help message and exit 17:57:31 INFO - -d DEST, --destination=DEST 17:57:31 INFO - Directory to install application into. [default: 17:57:31 INFO - "/builds/slave/test"] 17:57:31 INFO - --app=APP Application being installed. [default: firefox] 17:57:31 INFO - mkdir: /builds/slave/test/build/application 17:57:31 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'] 17:57:31 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 17:58:05 INFO - Reading from file tmpfile_stdout 17:58:05 INFO - Output received: 17:58:05 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:58:05 INFO - Running post-action listener: _resource_record_post_action 17:58:05 INFO - [mozharness: 2016-10-25 00:58:05.327161Z] Finished install step (success) 17:58:05 INFO - [mozharness: 2016-10-25 00:58:05.327305Z] Running run-tests step. 17:58:05 INFO - Running pre-action listener: _resource_record_pre_action 17:58:05 INFO - Running main action method: run_tests 17:58:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:58:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:58:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:58:05 INFO - 2016-10-24 17:58:05.342 screenresolution[1990:13361] starting screenresolution argv=screenresolution get 17:58:05 INFO - 2016-10-24 17:58:05.344 screenresolution[1990:13361] Display 0: 1600x1200x32@60 17:58:05 INFO - 2016-10-24 17:58:05.351 screenresolution[1991:13370] starting screenresolution argv=screenresolution list 17:58:05 INFO - Available Modes on Display 0 17:58:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:58:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:58:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:58:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:58:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:58:05 INFO - Intel Iris: 17:58:05 INFO - Chipset Model: Intel Iris 17:58:05 INFO - Type: GPU 17:58:05 INFO - Bus: Built-In 17:58:05 INFO - VRAM (Dynamic, Max): 1536 MB 17:58:05 INFO - Vendor: Intel (0x8086) 17:58:05 INFO - Device ID: 0x0a2e 17:58:05 INFO - Revision ID: 0x0009 17:58:05 INFO - Displays: 17:58:05 INFO - Display: 17:58:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:58:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:58:05 INFO - Display Serial Number: 1600x1200 60 17:58:05 INFO - Main Display: Yes 17:58:05 INFO - Mirror: Off 17:58:05 INFO - Online: Yes 17:58:05 INFO - Rotation: Supported 17:58:05 INFO - Return code: 0 17:58:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:58:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:58:05 INFO - Python 2.7.3 17:58:05 INFO - Return code: 0 17:58:05 INFO - grabbing minidump binary from tooltool 17:58:05 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')]} 17:58:05 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 0x106fa3d30>, '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 0x106dc9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f9bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:58:05 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 17:58:05 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 17:58:05 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 17:58:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:58:05 INFO - Return code: 0 17:58:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:58:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:58:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:58:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:58:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:58:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SXNuQEL4Qp24IXVJuariQw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0382', '--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 17:58:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SXNuQEL4Qp24IXVJuariQw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0382 --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 17:58:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.suCx7kL9cC/Render', 17:58:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:58:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:58:05 INFO - 'HOME': '/Users/cltbld', 17:58:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:58:05 INFO - 'LOGNAME': 'cltbld', 17:58:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:58:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:58:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:05 INFO - 'MOZ_NO_REMOTE': '1', 17:58:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:58:05 INFO - 'NO_EM_RESTART': '1', 17:58:05 INFO - 'PAGER': '/bin/cat', 17:58:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:58:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:05 INFO - 'PWD': '/builds/slave/test', 17:58:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:58:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:58:05 INFO - 'SHELL': '/bin/bash', 17:58:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hP2YQtOs2b/Listeners', 17:58:05 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 17:58:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:58:05 INFO - 'USER': 'cltbld', 17:58:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:58:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:58:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:05 INFO - 'XPC_FLAGS': '0x0', 17:58:05 INFO - 'XPC_SERVICE_NAME': '0', 17:58:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:58:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SXNuQEL4Qp24IXVJuariQw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0382', '--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 17:58:05 INFO - mozversion application_buildid: 20161024115824 17:58:05 INFO - mozversion application_changeset: e1d52389c70af17701017488f779c5ddd2ee8882 17:58:05 INFO - mozversion application_display_name: Nightly 17:58:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:58:05 INFO - mozversion application_name: Firefox 17:58:05 INFO - mozversion application_remotingname: firefox 17:58:05 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 17:58:05 INFO - mozversion application_vendor: Mozilla 17:58:05 INFO - mozversion application_version: 52.0a1 17:58:05 INFO - mozversion platform_buildid: 20161024115824 17:58:05 INFO - mozversion platform_changeset: e1d52389c70af17701017488f779c5ddd2ee8882 17:58:05 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 17:58:05 INFO - mozversion platform_version: 52.0a1 17:58:05 INFO - using testdate: 1477357085 17:58:05 INFO - actual date: 1477357085 17:58:05 INFO - starting webserver on 'localhost:51977' 17:58:05 INFO - SUITE-START | Running 2 tests 17:58:05 INFO - TEST-START | dromaeo_css 17:58:05 INFO - operating with platform_type : mac_ 17:58:05 INFO - Initialising browser for dromaeo_css test... 17:58:05 INFO - TEST-INFO | started process 2001 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/tmpnBr8UL/profile http://localhost:51977/getInfo.html) 17:58:08 INFO - PROCESS | 2001 | __metrics Screen width/height:1600/1200 17:58:08 INFO - PROCESS | 2001 | colorDepth:24 17:58:08 INFO - PROCESS | 2001 | Browser inner width/height: 1024/689 17:58:08 INFO - PROCESS | 2001 | __metrics 17:58:08 INFO - PROCESS | 2001 | 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" 17:58:08 INFO - PROCESS | 2001 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:58:09 INFO - TEST-INFO | 2001: exit 0 17:58:09 INFO - Browser initialized. 17:58:09 INFO - Running cycle 1/1 for dromaeo_css test... 17:58:09 INFO - TEST-INFO | started process 2003 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/tmpnBr8UL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:58:21 INFO - PROCESS | 2003 | RSS: Main: 234037248 17:58:21 INFO - PROCESS | 2003 | 17:59:12 INFO - PROCESS | 2003 | 1477357152633 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] 18:01:25 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:51977/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51977/tests/dromaeo/cssquery-ext.html) 18:01:27 INFO - PROCESS | 2003 | RSS: Main: 417472512 18:01:27 INFO - PROCESS | 2003 | 18:04:30 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:51977/tests/dromaeo/cssquery-ext.html (next: http://localhost:51977/tests/dromaeo/cssquery-jquery.html) 18:04:30 INFO - PROCESS | 2003 | RSS: Main: 376303616 18:04:30 INFO - PROCESS | 2003 | 18:07:33 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:51977/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51977/tests/dromaeo/cssquery-mootools.html) 18:07:33 INFO - PROCESS | 2003 | RSS: Main: 330481664 18:07:33 INFO - PROCESS | 2003 | 18:10:36 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:51977/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51977/tests/dromaeo/cssquery-prototype.html) 18:10:36 INFO - PROCESS | 2003 | RSS: Main: 337752064 18:10:36 INFO - PROCESS | 2003 | 18:13:40 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:51977/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51977/tests/dromaeo/cssquery-yui.html) 18:13:40 INFO - PROCESS | 2003 | RSS: Main: 327593984 18:13:40 INFO - PROCESS | 2003 | 18:16:44 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:51977/tests/dromaeo/cssquery-yui.html (next: http://localhost:51977/tests/dromaeo/cssquery-dojo.html) 18:16:44 INFO - PROCESS | 2003 | RSS: Main: 397504512 18:16:44 INFO - PROCESS | 2003 | 18:16:44 INFO - PROCESS | 2003 | __start_tp_report 18:16:44 INFO - PROCESS | 2003 | _x_x_mozilla_page_load 18:16:44 INFO - PROCESS | 2003 | _x_x_mozilla_page_load_details 18:16:44 INFO - PROCESS | 2003 | |i|pagename|runs| 18:16:44 INFO - PROCESS | 2003 | |0;dojo.html;2977.642682878055;3266.1181481000144;3297.0603378037263;3304.1244070321363;3323.435016047273;5586.469285417889;5636.718164091794;5678.5741069419755;5696.601237913348;5733.799317023905;5582.7766889324475;5734.913976290359;5748.568857335696;5769.884602307951;5773.220615216955;5044.218146187347;5157.123289040872;5169.276301317818;5190.92213616796;5248.947510524903;5310.654807437504;5316.149416093426;5316.654417462872;5319.069162896497;5386.218998245252;4545.909081818361;5087.872803179913;5294.894102117974;5305.310309659758;5355;5106.5659418949435;5180.740962951837;5189.896202075975;5245.580353571743;5270.7628156733035;5134.101532231882;5174.715390653512;5175.792968281265;5186.896262074775;5199.610029247784;5072.619553533463;5689.857753556153;5712.914306285409;5743.856403589902;5746.310442746855;6088.512918966517;6114.054067497291;6118.040554665182;6131.65193447331;6233.688315584248;6158.076288556707;6190.3190649028575;6273.749050037993;6294.055891616248;6296.464800491964;5825.417458254183;5845.1232315153065;5848.181254624356;5855.941440585625;5893.616914900561;6197.5351848610635;6203.193584834033;6258.217722784652;6281.591696539802;6282.874342513215;5123.359580052494;6096.512279017668;6150.907736383958;6182.783602573888;6208.317085120633;6275;6280.183576135165;6283.403076707706;6291.622502649856;6292.842678933063;6153.538484613672;6172.783952561639;6226.40849119333;6244.46922011625;6250.281217659936;6104.542159337979;6114.054067497291;6136.519078024374;6138.878900475427;6258.874822503524;4920.6555541111775;4921.286413470027;4936.407631084293;4966.577840883493;4967.627427942919;4375.124975005012;4449.132419178294;4457.509673935864;4460.085682435093;4495.190865644216;5648.51987581052;5714.485696287271;5779.537636989031;5816.941830581724;5827.825165245049;6167.074938759222;6193.659348735772;6229.781957631551;6242.750289988349;6292.811215663537;5884.32330282023;5890.175375447441;5890.587658863838;5893.499052580579;5918.556108291896;5439.945600544023;5441.374241962225;5441.428649991773;5444.863878403072;5444.891102178013;6099.37031394974;6142.6522545212965;6164.352742961924;6243.282022567463;6294.496440284858;5110.48895110486;5746.051901436216;6148.3236843948025;6285.151504546828;6285.811425657238;6280.685965701605;6306.432421082125;6306.810795676137;6309.558330916791;6321.620702757849;5464.770426653971;5734.856628584319;6114.510839132948;6208.658523781235;6230.844228894314;5991.101334799815;6139.4001448444;6174.629522228681;6265.342139075514;6270.2475702915945;6136.754529818757;6137.815865524041;6139.2325959255095;6152.200213972155;6158.846028849314;5887;6035.879282414415;6040.80902094145;6084.087386892002;6141;5814.622049566765;5827;5874.060150375919;5906.911396328973;5969.791057312973;6090.939090609215;6113.633182009094;6118.724657390517;6118.877622447437;6126.417990290915;5692.658440493418;5754.51086657622;5762.423757624204;5763.769449221984;5825.155352473783 18:16:44 INFO - PROCESS | 2003 | |1;ext.html;515.1731470989063;535.3762866260806;536.8308982670461;542.8724249801294;549.4725063938617;30638.08085757428;32054.839725801397;40557.39163912544;40642.390364144565;43196;41874.37188442176;42268.57731422685;42330.73007809763;42471.36292955608;42566.36150457746;9560.521973901294;9723.416595004286;9746.171575416063;9756.414615123116;9762.36544624597;9647.75880602987;9713.36863103896;9718.125368716814;9726.610935562605;9733.415995040285;9609.663661771805;9720.173785228264;9737.853932191023;9743.269254805882;9759.365641233333;9675.225981921429;9706.029397060272;9719.222462203077;9722.805543889153;9746.074122958307;9546.61813527458;9597.424154550748;9637.277204209713;9637.373570717951;9640.42157470547;40017.59982400168;40345.38618455258;40398.798006010074;40436.59563404358;40452.190956181;3389.9661003390142;3413.6927676508985;3436.055084851686;3440.088376580208;3503.4744788281705;30101.397972040435;30206;30462.39075218483;31141.37717245665;31144.37711245785;3007.6691563927952;3125.7030582094662;3171.1120886151916;3174.777765556412;3287.1289108386295;488576;491519.5424022857;491958;492435;502307;61050.38949610536;61553;61633.69183154145;61652.38347616556;61655.38344616586;33847;34502.65497344994;64856;64859;64884.67557662276;15652.608684782745;16252.83747162537;16262.75605865913;16282.918585407235;16314;11687.474063666985;11710.355930423908;11723.531058757555;11747.236429632047;11753.412329383496;15344;19079.32889395486;19110.61778764445;19165.712514312298;19179.90410047941;7219.350258476762;7545.981292525548;7929.207079292025;8027.5584842834205;8125.878111828328;719.5898337947424;765.4756491803132;936.840737074699;974.5224839828433;996.3722854601555;28143.296417589314;29266.414671706872;29473.411696762458;29489.410211795643;29752.702472974994;990.7176454710517;1013.7871047080048;1025.7230547752065;1038.2732087538752;1062.176812969939;12282.07259352888;14919.40322387114;15122.54632361031;15189.848101519065;15381.615459613375;644375;644721;645539;646693;647137;57742;58293;58303.8339233213;58317.41682583205;58417.707911461024;1339.6583871112998;1358.8505264420905;1359.6600849787553;1372.8901687864948;1373.3270697358423;27831;28623.713762862106;28904.586608298352;29262;29377.11868643944;48385;49154.75422622864;49175.770605735146;49194;49316.753416234125;498111;499528;500071.49964249943;500172;501213;25904;26148;26164.215073547824;26177.95288188451;26213.4757304849;44961.32558011698;46413.76793116013;47276.29085563788;47393.05213895772;47754;38604.42093368658;38630.6136938627;38848.02879928024;40064;40661.98345041398;33310.333793324484;38758.99235618483;39737.40393894152;39783.80108099441;40039.79980100081;36698.79807211576;36943.445848311756;37582;37904.86285411442;38275.23449531049;26091.547016081327;32787;33233.851737427685;34192.145196369296;34299.82850085734;24061.398465038514;24578.69839520665;24931.501369972862;25059.373515662253;25676.486470270862 18:16:44 INFO - PROCESS | 2003 | |2;jquery.html;352.80066762279324;369.1675272261053;377.9074126838924;385.18533302066123;404.5691338724258;14596.927015364934;14872.553823385302;15511.612209694764;20137.899310503428;20718;19015.098490150976;19494.220231190735;19976.70034949473;20231.59536809263;20361.389158325273;5569.610127291091;5658.493613272639;5870.647761134345;5873.383294754053;5891.145783861338;5068.34111565496;5557.722113894289;5845.824625261228;5854.560907931901;5860.912086318687;5489.862753431156;5657.8585535361535;5670.716464176795;5737.168110623957;5797.333306669724;5735.713214339287;5887.411258874121;5888.941110588925;5889.676067816268;5891.878923587548;5181.378234611833;5279.894402111975;5461.672299662033;5689.971550142264;5691.203231547586;12782.808257876139;13030.348482575928;13047.673808154777;13084.542041028519;23224.53550928989;2122.9256976005922;2188.7482939461847;2345.3784747041877;2844.8293102413922;2927.4730548501475;9239.353245272834;9481;10074.848877266846;10088.798224035478;10224.591016359336;1693.6782011417915;1718.5274049636325;1812.900290484023;1839.5768973136119;1892.7539419875327;112956;122799.38600306942;125479;130130;131685;9120.771980700403;10639.255252132276;10819;11102.44487775608;11542.769144617061;12026.518939242333;14051.016428849882;14190.503332383318;14202.431902723982;14213.715725685428;7649.04386951631;7762.7671169865;7974.282314591598;8426.988761348677;8578.699745508877;8259.917400826034;8278.503289802631;8278.8344233115;8455.02767181782;8476.49141051539;4452.131834292282;4476.776161191928;4477.507474177838;4497.550244975541;4526.275795872711;1747.6242607839376;1787.419243836362;1850.898200598953;1914.9329773457862;1954.951126221856;813.6623301330001;849.5921957460454;903.8599017152352;909.1817364371985;965.9758506037406;18833.623327533373;20437.795622043886;20484.69272960907;20588.485287867923;20786.1685532577;935.6491315756591;957.4925289596525;975.23444096384;989.9554520046615;990.782027953849;10067.395956242503;10632.574697012187;10744.462776861126;10744.785104298027;10759.525309178933;548721;574024;574282;585987;587854;79073;110253;134922;136206.3189684065;136775;982.7248370456284;992.270681049428;1004.7287232447198;1026.697124348319;1032.0762917189224;13592.592222233348;14341.641458963191;15005.924970375516;16757.40804623559;18759.6248075035;41051.97370065772;54646.726766365915;54942;55920.72039639776;56237.15644265257;73582;74598;76815;76856.61571692106;78254.608726956;6923.688434020381;7767.019201659414;7832.960835195788;8113.959430202811;8194.918050819415;11435.714107147054;12081.154319197572;12332.907240603863;12468.875311246771;12556.434960426985;10994.450277485934;11016;11018.559257629926;11052.778944421227;11108.000279974842;10313.74215644615;10362.378257304586;10935;10986.835197471884;11371.772564548497;10794.406307653155;10868.728281793019;11029.558817647205;11205.271657342246;11300.547978081113;6861.318976850704;7267.491275610657;7295.489315747846;7499.287567681062;8179.550124743197;9703.66037188695;11096.833547496633;11461.598844040418;11472.713182170513;11553.942230288794 18:16:44 INFO - PROCESS | 2003 | |3;mootools.html;1515.0833745583925;1553.8523840235177;1765.6468706258752;1898.8670793044491;1934.3713293179712;7453.329200371973;8236.09402965674;8738;8738.781530461742;8742.519161446135;6662.66686665666;7996.080450748165;8248.13394593568;8496.235338819504;8502.149785021495;1766.178726891995;2268.0247493577754;2292.2893902890114;2321.071571371448;2323.3494621506006;2220.311703371952;2312.2485192312483;2347.6243800991847;2350.083467447697;2350.670906073151;2317.397476656073;2332.9766702333013;2337.7545357737363;2342.7466305526546;2360.7521210272844;2321.1527792355837;2321.6517522371696;2325.174563030117;2338.4504641409253;2342.8945697443655;2335.497867958397;2338.088145623208;2341.215692742916;2345.29641107667;2348.635961425982;8540.274076703488;8720.607572659246;8721.520316382597;8738.300935925174;8762.342824288204;5060.468650791688;5227.137522308814;5228.973855130738;5230.34620672416;5232.136697444917;3370.561826962504;3437.3125374924866;3583.964160358415;3588.2644057968055;3597.892063238107;908.8136931928939;1015.9288849780519;1056.5932116135266;1074.9731256718567;1079.3685693869018;11097.3896435696;11239.943800281028;11241.269317494336;11248.775024499464;11330.206885518017;4458.621017213573;4482.305242687388;4691.507391723888;4700.835470758507;4707.435107787019;9673.806523869483;9674.903250967542;9677.564509597085;9690.418574885529;9691.466969316756;4508.864734057984;5240.3973543042275;5249.370075590953;5255.474452554714;5261.289725886956;4168.520620128664;4323.313907576048;4326.891827704332;4805.543473370024;4827.058723548945;3833;3853.1523064925673;3941.8029098544957;3947.190825880745;3995.2608767377546;1263.0779530942464;1263.3051821498323;1267.2903174222465;1272.1031672670745;1280.7950727883494;790.6442101054433;843;927.9514149011574;931.753085432361;932.7714709896119;5763.6541807491685;5908.497777688945;5995.890760209375;6044.117867287017;6308.369163083655;951.9666811661558;957.0955447102422;970.84466485362;971.145392054987;1000.5497526113278;3369.629340772513;3825.3305671507374;3936.7637941723588;4012.6388625023887;4111.97944010278;10111.544980475895;10500.474976251156;10564.418956957441;10567.365958042543;10827.729306767236;10517.9474102629;10519.631812886511;10519.737006574744;10520.526576304084;10553.525091370906;7566.886496702554;7913.841723165505;7931.484453510503;8044.959775201087;8046.396520260887;5037.017781532566;5800.912986305125;5845.09401042839;5978.491828194652;6097.512199024156;9402.15380615748;9787.608495660093;9788.951055244679;9893.55479003461;9935.65225217114;9442.291828113057;9857.211423085993;10041.447720375449;10074.54664540112;10107.69676909694;7110.786676399716;7377.704891804482;7396.9260307396235;7468.589227592534;7537.8115547111765;8279.213474719892;8367.665293388196;8370.204830541088;8370.581470926307;8388.328933685169;7195.784126476214;7250.9637451812405;7423.628818559158;7515.774526764206;7536.698532058656;7157.677904494414;7232.710691572489;7387.1874093848555;7390.224026477143;7427.294407031323;6823.249442561215;6965.094537710065;6969.54697944632;6976.860462790614;6979.40675042627;4306.375575541466;4942.92585611209;4949.727764972817;5001.749912504288;5064.772085256099;4617.215073437591;4723.976380118077;4875.536824001714;4891.413030436371;5018.723970181675 18:16:44 INFO - PROCESS | 2003 | |4;prototype.html;263.66777859896536;297.40370557033145;298.6207516454103;306.26801943355383;313.9968600313996;4329.848455304065;4966.528179822911;5160.587697518619;5188.37739471263;5216.347956505437;4963.766305162682;5078.822241221558;5133.230015497677;5149.81975630853;5198.116320225561;3526.4710293455933;4002.479677641917;4014.8193331300163;4032.3749818778138;4050.1899620075956;3565.823278318149;3849.788261645608;3956.4856220496818;3974.503187101612;4032.092779124688;3757.4176002719623;3973.5430425501004;4002.739821911581;4006.6794656427414;4020.477337946063;3457.4122399191947;3857.267119247334;3965.286248475273;3987.4710880870493;3994.6005399460114;3500.579930408367;3502.369573476773;3505.7020153287003;3510.350585141757;3515.402381595135;4346.087321662455;4676.638297659694;5046.21783623539;5079.847604571869;5084.923726144111;4510.684252102355;4514.774261286955;4518.864434066983;4541.523140070278;4545;4358.6730995175485;5442.12925931853;5459.454054594548;5483.314585676791;5524.309461317335;2932.692067332942;3100.3489267253904;3656.579493358271;3777.8866634001024;3795.221979494197;5680.971595142039;5720.456556627114;5724.627899186539;5768.423157684198;5825.242718446617;3279.901233086895;3298.901032969015;3796.3925771876366;3800.600936901641;3806.467094606757;3268.526063720795;3843.404272337792;3859.710521710883;3862.748921320105;3892.7664340139117;4273.305911225442;4432.623227025674;4459.554044595515;4491.8427855025575;4524.502304746476;4543.818607162161;4755.429348478205;5318.9202161967605;5462.9726851365485;5526.281583394213;1115.9107271418268;1222.7798996180595;1248.5630029489605;1273.6433798536425;1299.4996926183487;865.4374656473343;891.6745387933487;892.5314210039782;892.9508877011697;894.4302748676032;4567.269236922077;4800.567948884617;4851.902961940741;5125.7693403796175;5143.408508021551;4894.486078961658;5049.646524743306;5321.148616221386;5440.319960004999;5587.497125258747;5007.94833085049;5105.387353517602;5107.693538387709;5109.897802043938;5153.011253472977;1978.7229787829715;2243.6746671732835;2430.4774473488283;2439.634054891745;2446.47400808827;4240.915181696349;4244.87265382039;4327.502337231196;4658.790354434059;5388.784448622089;4934.629902757236;5296.947030529645;5710.200571919934;5886.793962211302;5896.351401345849;5649.954758369715;5821.708914554255;5870.236869206976;5900.616459930091;5933.940660593339;5208.5051920067535;5233.947660523346;5558.60979778699;5698.772049117989;5711.457411545896;4847.757612119451;4875.658703890836;5096.898062038665;5624.3250809903075;5711.457411545896;4978.551930326288;5251.658642188246;5774.595778295479;5777.3933736957015;5801.361850196559;3249.8050116993054;3264.9020529384156;3667.8716244931297;3870.206607645482;3895.571487136356;4626;5455.018096742466;5507.9449205507435;5619.409961954099;5646.825972000727;4477.798499067615;5409.29607173739;5428.321459817523;5438.9394068156325;5452.890942181213;5057.873553161053;5311.203319501951;5444.8366549003595;5450.5367043801725;5465.398806131243;5095.337606111182;5228.438065348028;5259.948620038264;5286.0441636594705;5405.86485337854;4790.760461976957;4833.371661684099;4845.2732090186755;5511.944880551304;5526.866992266495;4638.443386793607;4893.9021219576125;5305.840824775263;5369.48989845964;5382.946170538401 18:16:44 INFO - PROCESS | 2003 | |5;yui.html;685.5886468119126;689.6689588997278;726.8073960400494;762.8131107878571;867.2411639815161;15261;15713.13577753223;15906.284217210225;15924.601884952854;15926.920365398171;14277.143371397724;14350.995430319881;14501.854981450182;14515;14686.485972990948;868.0754995929346;893.5576889439704;894.6019021535419;895.9372843900929;896.9372143949926;702.1609177033447;720.1394333771145;722.5628494760673;871.6731225790329;896.8609865470862;929.1126973740062;947.0482165423739;947.1759569174793;947.5072962059725;950.7955789505289;937.8733870927406;939.1359948847077;939.229831538139;941.0260380506178;941.0307383395113;544.4827413956757;544.7820871651371;561.3011800308601;694.4791406445166;695.4123765418213;15010.324535395825;15542.844571554253;15547.378104875792;15552.766708499381;15606.063636181865;13711.314434278247;13877.167369957835;13922.651933701638;14010.509632162928;14173;10645.84031239532;12287.508499660004;12449.875501245053;12632.49470021198;12858.485660573566;4447.79984900677;4452.666050046259;4471.150481408522;4654.8091038918155;4670.743109128996;98564;98597;98761;99869;100324.99999999927;11042.227044106836;11049.28179668319;11067.169962252703;11160.107191424666;11295.830562541569;21960.717660056136;21991.450213744465;22011;22017;22028.88985555094;7128.643567821692;7441.218672039467;7468.066491688539;7503.062117235346;7553.73561925341;4213.641840443596;4226.619604235633;4255.787210639518;4300.591443812833;4370.650347972155;3446.9310613788084;3588.4796704477703;3613.060604242863;3613.313470440608;3620;666.8032930285577;669.3908543225739;674.2583158525582;683.0983102305009;691.7163962775238;600.4265926040621;606.4021303864262;630.5460068750492;643.6459947029209;650.4113777031794;6920.550164239308;9056.649039855296;9060.365774395728;9156.175944165057;9215.631374744935;460.7719179006346;617.1668247865435;618.8855061813579;621.083901245659;627.8242092214188;3852.5954774748807;4129.194807012604;4400.317950717644;4428.68999170055;4491.663125265618;106200;120921;126268.7373126257;127432;147508.0799452494;121450.57098857974;124161;125842.37078814548;128019.33086239705;130179;72090.63954680298;107835;112620.31069533963;112811.43594281976;113506.29740553898;9562.28282878773;9792.510374481106;9801.754956126153;9840.45877476717;9844.704658860246;46402;55114.346569602974;62032.68983655233;62127.44681382821;62650.06024909539;73741;98282.01717983015;98697;99466.5026674862;99672.54748061346;10373.481325933522;13054.738905222031;13232.603021909357;13281.800772988607;13417.329133543479;14809.629759256104;14813.851861481247;14912;15228.619284517976;15325.6168595786;13576.321183940567;13701.45194192221;13853.376598053314;13861.653458663613;14351.497697580535;12158.696032599255;12375.071869609996;13315.400806963517;13438.260895650443;13447.798283025959;13543.79684304756;13553.457861685421;13607.591772246848;13992.860071399156;14333.996620236483;9955.402675839472;11049.447527623748;11371.31772093677;11558.30650160993;11562.88437115618;10635.627753028606;11242.606508772154;11450.370229637118;11500.654980350602;11515.36665483373 18:16:44 INFO - PROCESS | 2003 | __end_tp_report 18:16:44 INFO - PROCESS | 2003 | __start_cc_report 18:16:44 INFO - PROCESS | 2003 | _x_x_mozilla_cycle_collect,2214 18:16:44 INFO - PROCESS | 2003 | __end_cc_report 18:16:44 INFO - PROCESS | 2003 | __startTimestamp1477358204559__endTimestamp 18:16:44 INFO - PROCESS | 2003 | 18:16:44 INFO - PROCESS | 2003 | ------- Summary: start ------- 18:16:44 INFO - PROCESS | 2003 | Number of tests: 6 18:16:44 INFO - PROCESS | 2003 | 18:16:44 INFO - PROCESS | 2003 | [#0] dojo.html Cycles:165 Average:5710.48 Median:5884.32 stddev:647.30 (11.0%) stddev-sans-first:612.75 18:16:44 INFO - PROCESS | 2003 | Values: 2977.6 3266.1 3297.1 3304.1 3323.4 5586.5 5636.7 5678.6 5696.6 5733.8 5582.8 5734.9 5748.6 5769.9 5773.2 5044.2 5157.1 5169.3 5190.9 5248.9 5310.7 5316.1 5316.7 5319.1 5386.2 4545.9 5087.9 5294.9 5305.3 5355.0 5106.6 5180.7 5189.9 5245.6 5270.8 5134.1 5174.7 5175.8 5186.9 5199.6 5072.6 5689.9 5712.9 5743.9 5746.3 6088.5 6114.1 6118.0 6131.7 6233.7 6158.1 6190.3 6273.7 6294.1 6296.5 5825.4 5845.1 5848.2 5855.9 5893.6 6197.5 6203.2 6258.2 6281.6 6282.9 5123.4 6096.5 6150.9 6182.8 6208.3 6275.0 6280.2 6283.4 6291.6 6292.8 6153.5 6172.8 6226.4 6244.5 6250.3 6104.5 6114.1 6136.5 6138.9 6258.9 4920.7 4921.3 4936.4 4966.6 4967.6 4375.1 4449.1 4457.5 4460.1 4495.2 5648.5 5714.5 5779.5 5816.9 5827.8 6167.1 6193.7 6229.8 6242.8 6292.8 5884.3 5890.2 5890.6 5893.5 5918.6 5439.9 5441.4 5441.4 5444.9 5444.9 6099.4 6142.7 6164.4 6243.3 6294.5 5110.5 5746.1 6148.3 6285.2 6285.8 6280.7 6306.4 6306.8 6309.6 6321.6 5464.8 5734.9 6114.5 6208.7 6230.8 5991.1 6139.4 6174.6 6265.3 6270.2 6136.8 6137.8 6139.2 6152.2 6158.8 5887.0 6035.9 6040.8 6084.1 6141.0 5814.6 5827.0 5874.1 5906.9 5969.8 6090.9 6113.6 6118.7 6118.9 6126.4 5692.7 5754.5 5762.4 5763.8 5825.2 18:16:44 INFO - PROCESS | 2003 | 18:16:44 INFO - PROCESS | 2003 | [#1] ext.html Cycles:180 Average:67816.65 Median:40444.39 stddev:147142.18 (363.8%) stddev-sans-first:147468.19 18:16:44 INFO - PROCESS | 2003 | Values: 515.2 535.4 536.8 542.9 549.5 30638.1 32054.8 40557.4 40642.4 43196.0 41874.4 42268.6 42330.7 42471.4 42566.4 9560.5 9723.4 9746.2 9756.4 9762.4 9647.8 9713.4 9718.1 9726.6 9733.4 9609.7 9720.2 9737.9 9743.3 9759.4 9675.2 9706.0 9719.2 9722.8 9746.1 9546.6 9597.4 9637.3 9637.4 9640.4 40017.6 40345.4 40398.8 40436.6 40452.2 3390.0 3413.7 3436.1 3440.1 3503.5 30101.4 30206.0 30462.4 31141.4 31144.4 3007.7 3125.7 3171.1 3174.8 3287.1 488576.0 491519.5 491958.0 492435.0 502307.0 61050.4 61553.0 61633.7 61652.4 61655.4 33847.0 34502.7 64856.0 64859.0 64884.7 15652.6 16252.8 16262.8 16282.9 16314.0 11687.5 11710.4 11723.5 11747.2 11753.4 15344.0 19079.3 19110.6 19165.7 19179.9 7219.4 7546.0 7929.2 8027.6 8125.9 719.6 765.5 936.8 974.5 996.4 28143.3 29266.4 29473.4 29489.4 29752.7 990.7 1013.8 1025.7 1038.3 1062.2 12282.1 14919.4 15122.5 15189.8 15381.6 644375.0 644721.0 645539.0 646693.0 647137.0 57742.0 58293.0 58303.8 58317.4 58417.7 1339.7 1358.9 1359.7 1372.9 1373.3 27831.0 28623.7 28904.6 29262.0 29377.1 48385.0 49154.8 49175.8 49194.0 49316.8 498111.0 499528.0 500071.5 500172.0 501213.0 25904.0 26148.0 26164.2 26178.0 26213.5 44961.3 46413.8 47276.3 47393.1 47754.0 38604.4 38630.6 38848.0 40064.0 40662.0 33310.3 38759.0 39737.4 39783.8 40039.8 36698.8 36943.4 37582.0 37904.9 38275.2 26091.5 32787.0 33233.9 34192.1 34299.8 24061.4 24578.7 24931.5 25059.4 25676.5 18:16:44 INFO - PROCESS | 2003 | 18:16:44 INFO - PROCESS | 2003 | [#2] jquery.html Cycles:180 Average:33597.68 Median:2595.10 stddev:96205.46 (3707.2%) stddev-sans-first:96442.96 18:16:44 INFO - PROCESS | 2003 | Values: 352.8 369.2 377.9 385.2 404.6 14596.9 14872.6 15511.6 20137.9 20718.0 19015.1 19494.2 19976.7 20231.6 20361.4 5569.6 5658.5 5870.6 5873.4 5891.1 5068.3 5557.7 5845.8 5854.6 5860.9 5489.9 5657.9 5670.7 5737.2 5797.3 5735.7 5887.4 5888.9 5889.7 5891.9 5181.4 5279.9 5461.7 5690.0 5691.2 12782.8 13030.3 13047.7 13084.5 23224.5 2122.9 2188.7 2345.4 2844.8 2927.5 9239.4 9481.0 10074.8 10088.8 10224.6 1693.7 1718.5 1812.9 1839.6 1892.8 112956.0 122799.4 125479.0 130130.0 131685.0 9120.8 10639.3 10819.0 11102.4 11542.8 12026.5 14051.0 14190.5 14202.4 14213.7 7649.0 7762.8 7974.3 8427.0 8578.7 8259.9 8278.5 8278.8 8455.0 8476.5 4452.1 4476.8 4477.5 4497.6 4526.3 1747.6 1787.4 1850.9 1914.9 1955.0 813.7 849.6 903.9 909.2 966.0 18833.6 20437.8 20484.7 20588.5 20786.2 935.6 957.5 975.2 990.0 990.8 10067.4 10632.6 10744.5 10744.8 10759.5 548721.0 574024.0 574282.0 585987.0 587854.0 79073.0 110253.0 134922.0 136206.3 136775.0 982.7 992.3 1004.7 1026.7 1032.1 13592.6 14341.6 15005.9 16757.4 18759.6 41052.0 54646.7 54942.0 55920.7 56237.2 73582.0 74598.0 76815.0 76856.6 78254.6 6923.7 7767.0 7833.0 8114.0 8194.9 11435.7 12081.2 12332.9 12468.9 12556.4 10994.5 11016.0 11018.6 11052.8 11108.0 10313.7 10362.4 10935.0 10986.8 11371.8 10794.4 10868.7 11029.6 11205.3 11300.5 6861.3 7267.5 7295.5 7499.3 8179.6 9703.7 11096.8 11461.6 11472.7 11553.9 18:16:44 INFO - PROCESS | 2003 | 18:16:44 INFO - PROCESS | 2003 | [#3] mootools.html Cycles:180 Average:5596.63 Median:4975.74 stddev:3117.96 (62.7%) stddev-sans-first:3111.62 18:16:44 INFO - PROCESS | 2003 | Values: 1515.1 1553.9 1765.6 1898.9 1934.4 7453.3 8236.1 8738.0 8738.8 8742.5 6662.7 7996.1 8248.1 8496.2 8502.1 1766.2 2268.0 2292.3 2321.1 2323.3 2220.3 2312.2 2347.6 2350.1 2350.7 2317.4 2333.0 2337.8 2342.7 2360.8 2321.2 2321.7 2325.2 2338.5 2342.9 2335.5 2338.1 2341.2 2345.3 2348.6 8540.3 8720.6 8721.5 8738.3 8762.3 5060.5 5227.1 5229.0 5230.3 5232.1 3370.6 3437.3 3584.0 3588.3 3597.9 908.8 1015.9 1056.6 1075.0 1079.4 11097.4 11239.9 11241.3 11248.8 11330.2 4458.6 4482.3 4691.5 4700.8 4707.4 9673.8 9674.9 9677.6 9690.4 9691.5 4508.9 5240.4 5249.4 5255.5 5261.3 4168.5 4323.3 4326.9 4805.5 4827.1 3833.0 3853.2 3941.8 3947.2 3995.3 1263.1 1263.3 1267.3 1272.1 1280.8 790.6 843.0 928.0 931.8 932.8 5763.7 5908.5 5995.9 6044.1 6308.4 952.0 957.1 970.8 971.1 1000.5 3369.6 3825.3 3936.8 4012.6 4112.0 10111.5 10500.5 10564.4 10567.4 10827.7 10517.9 10519.6 10519.7 10520.5 10553.5 7566.9 7913.8 7931.5 8045.0 8046.4 5037.0 5800.9 5845.1 5978.5 6097.5 9402.2 9787.6 9789.0 9893.6 9935.7 9442.3 9857.2 10041.4 10074.5 10107.7 7110.8 7377.7 7396.9 7468.6 7537.8 8279.2 8367.7 8370.2 8370.6 8388.3 7195.8 7251.0 7423.6 7515.8 7536.7 7157.7 7232.7 7387.2 7390.2 7427.3 6823.2 6965.1 6969.5 6976.9 6979.4 4306.4 4942.9 4949.7 5001.7 5064.8 4617.2 4724.0 4875.5 4891.4 5018.7 18:16:44 INFO - PROCESS | 2003 | 18:16:44 INFO - PROCESS | 2003 | [#4] prototype.html Cycles:180 Average:4363.73 Median:4884.78 stddev:1364.74 (27.9%) stddev-sans-first:1333.42 18:16:44 INFO - PROCESS | 2003 | Values: 263.7 297.4 298.6 306.3 314.0 4329.8 4966.5 5160.6 5188.4 5216.3 4963.8 5078.8 5133.2 5149.8 5198.1 3526.5 4002.5 4014.8 4032.4 4050.2 3565.8 3849.8 3956.5 3974.5 4032.1 3757.4 3973.5 4002.7 4006.7 4020.5 3457.4 3857.3 3965.3 3987.5 3994.6 3500.6 3502.4 3505.7 3510.4 3515.4 4346.1 4676.6 5046.2 5079.8 5084.9 4510.7 4514.8 4518.9 4541.5 4545.0 4358.7 5442.1 5459.5 5483.3 5524.3 2932.7 3100.3 3656.6 3777.9 3795.2 5681.0 5720.5 5724.6 5768.4 5825.2 3279.9 3298.9 3796.4 3800.6 3806.5 3268.5 3843.4 3859.7 3862.7 3892.8 4273.3 4432.6 4459.6 4491.8 4524.5 4543.8 4755.4 5318.9 5463.0 5526.3 1115.9 1222.8 1248.6 1273.6 1299.5 865.4 891.7 892.5 893.0 894.4 4567.3 4800.6 4851.9 5125.8 5143.4 4894.5 5049.6 5321.1 5440.3 5587.5 5007.9 5105.4 5107.7 5109.9 5153.0 1978.7 2243.7 2430.5 2439.6 2446.5 4240.9 4244.9 4327.5 4658.8 5388.8 4934.6 5296.9 5710.2 5886.8 5896.4 5650.0 5821.7 5870.2 5900.6 5933.9 5208.5 5233.9 5558.6 5698.8 5711.5 4847.8 4875.7 5096.9 5624.3 5711.5 4978.6 5251.7 5774.6 5777.4 5801.4 3249.8 3264.9 3667.9 3870.2 3895.6 4626.0 5455.0 5507.9 5619.4 5646.8 4477.8 5409.3 5428.3 5438.9 5452.9 5057.9 5311.2 5444.8 5450.5 5465.4 5095.3 5228.4 5259.9 5286.0 5405.9 4790.8 4833.4 4845.3 5511.9 5526.9 4638.4 4893.9 5305.8 5369.5 5382.9 18:16:44 INFO - PROCESS | 2003 | 18:16:44 INFO - PROCESS | 2003 | [#5] yui.html Cycles:180 Average:23642.65 Median:4171.42 stddev:36623.78 (878.0%) stddev-sans-first:36685.95 18:16:44 INFO - PROCESS | 2003 | Values: 685.6 689.7 726.8 762.8 867.2 15261.0 15713.1 15906.3 15924.6 15926.9 14277.1 14351.0 14501.9 14515.0 14686.5 868.1 893.6 894.6 895.9 896.9 702.2 720.1 722.6 871.7 896.9 929.1 947.0 947.2 947.5 950.8 937.9 939.1 939.2 941.0 941.0 544.5 544.8 561.3 694.5 695.4 15010.3 15542.8 15547.4 15552.8 15606.1 13711.3 13877.2 13922.7 14010.5 14173.0 10645.8 12287.5 12449.9 12632.5 12858.5 4447.8 4452.7 4471.2 4654.8 4670.7 98564.0 98597.0 98761.0 99869.0 100325.0 11042.2 11049.3 11067.2 11160.1 11295.8 21960.7 21991.5 22011.0 22017.0 22028.9 7128.6 7441.2 7468.1 7503.1 7553.7 4213.6 4226.6 4255.8 4300.6 4370.7 3446.9 3588.5 3613.1 3613.3 3620.0 666.8 669.4 674.3 683.1 691.7 600.4 606.4 630.5 643.6 650.4 6920.6 9056.6 9060.4 9156.2 9215.6 460.8 617.2 618.9 621.1 627.8 3852.6 4129.2 4400.3 4428.7 4491.7 106200.0 120921.0 126268.7 127432.0 147508.1 121450.6 124161.0 125842.4 128019.3 130179.0 72090.6 107835.0 112620.3 112811.4 113506.3 9562.3 9792.5 9801.8 9840.5 9844.7 46402.0 55114.3 62032.7 62127.4 62650.1 73741.0 98282.0 98697.0 99466.5 99672.5 10373.5 13054.7 13232.6 13281.8 13417.3 14809.6 14813.9 14912.0 15228.6 15325.6 13576.3 13701.5 13853.4 13861.7 14351.5 12158.7 12375.1 13315.4 13438.3 13447.8 13543.8 13553.5 13607.6 13992.9 14334.0 9955.4 11049.4 11371.3 11558.3 11562.9 10635.6 11242.6 11450.4 11500.7 11515.4 18:16:44 INFO - PROCESS | 2003 | -------- Summary: end -------- 18:16:44 INFO - PROCESS | 2003 | 18:16:45 INFO - TEST-INFO | 2003: exit 0 18:16:45 INFO - TEST-OK | dromaeo_css | took 1119296ms 18:16:45 INFO - TEST-START | kraken 18:16:45 INFO - operating with platform_type : mac_ 18:16:45 INFO - Initialising browser for kraken test... 18:16:45 INFO - TEST-INFO | started process 2008 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/tmpHLw1uf/profile http://localhost:51977/getInfo.html) 18:16:47 INFO - PROCESS | 2008 | __metrics Screen width/height:1600/1200 18:16:47 INFO - PROCESS | 2008 | colorDepth:24 18:16:47 INFO - PROCESS | 2008 | Browser inner width/height: 1024/689 18:16:47 INFO - PROCESS | 2008 | __metrics 18:16:47 INFO - PROCESS | 2008 | 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" 18:16:47 INFO - PROCESS | 2008 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:16:48 INFO - TEST-INFO | 2008: exit 0 18:16:48 INFO - Browser initialized. 18:16:48 INFO - Running cycle 1/1 for kraken test... 18:16:48 INFO - TEST-INFO | started process 2009 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/tmpHLw1uf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:17:00 INFO - PROCESS | 2009 | RSS: Main: 241885184 18:17:00 INFO - PROCESS | 2009 | 18:17:03 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51977/tests/kraken/driver.html?testName=audio-beat-detection) 18:17:04 INFO - PROCESS | 2009 | RSS: Main: 292220928 18:17:04 INFO - PROCESS | 2009 | 18:17:06 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51977/tests/kraken/driver.html?testName=audio-dft) 18:17:07 INFO - PROCESS | 2009 | RSS: Main: 293478400 18:17:07 INFO - PROCESS | 2009 | 18:17:10 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51977/tests/kraken/driver.html?testName=audio-fft) 18:17:11 INFO - PROCESS | 2009 | RSS: Main: 384544768 18:17:11 INFO - PROCESS | 2009 | 18:17:13 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51977/tests/kraken/driver.html?testName=audio-oscillator) 18:17:14 INFO - PROCESS | 2009 | RSS: Main: 287088640 18:17:14 INFO - PROCESS | 2009 | 18:17:16 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51977/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:17:16 INFO - PROCESS | 2009 | RSS: Main: 291246080 18:17:16 INFO - PROCESS | 2009 | 18:17:19 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51977/tests/kraken/driver.html?testName=imaging-darkroom) 18:17:20 INFO - PROCESS | 2009 | RSS: Main: 330575872 18:17:20 INFO - PROCESS | 2009 | 18:17:22 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51977/tests/kraken/driver.html?testName=imaging-desaturate) 18:17:23 INFO - PROCESS | 2009 | RSS: Main: 329375744 18:17:23 INFO - PROCESS | 2009 | 18:17:26 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51977/tests/kraken/driver.html?testName=json-parse-financial) 18:17:26 INFO - PROCESS | 2009 | RSS: Main: 328105984 18:17:26 INFO - PROCESS | 2009 | 18:17:28 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51977/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:17:29 INFO - PROCESS | 2009 | RSS: Main: 302661632 18:17:29 INFO - PROCESS | 2009 | 18:17:31 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51977/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:17:31 INFO - PROCESS | 2009 | RSS: Main: 308203520 18:17:31 INFO - PROCESS | 2009 | 18:17:34 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51977/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:17:34 INFO - PROCESS | 2009 | RSS: Main: 309854208 18:17:34 INFO - PROCESS | 2009 | 18:17:37 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51977/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:17:38 INFO - PROCESS | 2009 | RSS: Main: 320425984 18:17:38 INFO - PROCESS | 2009 | 18:17:41 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51977/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:17:42 INFO - PROCESS | 2009 | RSS: Main: 320139264 18:17:42 INFO - PROCESS | 2009 | 18:17:44 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51977/tests/kraken/driver.html?testName=ai-astar) 18:17:44 INFO - PROCESS | 2009 | RSS: Main: 364056576 18:17:44 INFO - PROCESS | 2009 | 18:17:44 INFO - PROCESS | 2009 | __start_tp_report 18:17:44 INFO - PROCESS | 2009 | _x_x_mozilla_page_load 18:17:44 INFO - PROCESS | 2009 | _x_x_mozilla_page_load_details 18:17:44 INFO - PROCESS | 2009 | |i|pagename|runs| 18:17:44 INFO - PROCESS | 2009 | |0;ai-astar;113;114;113;114;111;115;113;113;112;113 18:17:44 INFO - PROCESS | 2009 | |1;audio-beat-detection;154;113;112;150;113;114;112;111;144;122 18:17:44 INFO - PROCESS | 2009 | |2;audio-dft;184;184;186;184;184;183;181;183;183;184 18:17:44 INFO - PROCESS | 2009 | |3;audio-fft;82;59;58;91;62;60;59;60;84;59 18:17:44 INFO - PROCESS | 2009 | |4;audio-oscillator;89;71;94;91;98;89;91;67;67;89 18:17:44 INFO - PROCESS | 2009 | |5;imaging-gaussian-blur;87;85;88;84;88;85;90;85;86;84 18:17:44 INFO - PROCESS | 2009 | |6;imaging-darkroom;93;94;93;93;93;94;94;93;94;93 18:17:44 INFO - PROCESS | 2009 | |7;imaging-desaturate;84;84;79;81;81;83;91;143;119;84 18:17:44 INFO - PROCESS | 2009 | |8;json-parse-financial;56;54;54;53;54;55;53;55;54;53 18:17:44 INFO - PROCESS | 2009 | |9;json-stringify-tinderbox;66;73;69;76;73;71;69;70;69;72 18:17:44 INFO - PROCESS | 2009 | |10;stanford-crypto-aes;100;105;105;74;101;103;106;88;88;87 18:17:44 INFO - PROCESS | 2009 | |11;stanford-crypto-ccm;146;151;154;166;139;150;157;153;194;144 18:17:44 INFO - PROCESS | 2009 | |12;stanford-crypto-pbkdf2;175;175;172;173;175;174;176;175;175;174 18:17:44 INFO - PROCESS | 2009 | |13;stanford-crypto-sha256-iterative;69;68;69;72;81;89;87;86;76;68 18:17:44 INFO - PROCESS | 2009 | __end_tp_report 18:17:44 INFO - PROCESS | 2009 | __start_cc_report 18:17:44 INFO - PROCESS | 2009 | _x_x_mozilla_cycle_collect,2137 18:17:44 INFO - PROCESS | 2009 | __end_cc_report 18:17:44 INFO - PROCESS | 2009 | __startTimestamp1477358264312__endTimestamp 18:17:44 INFO - PROCESS | 2009 | 18:17:44 INFO - PROCESS | 2009 | ------- Summary: start ------- 18:17:44 INFO - PROCESS | 2009 | Number of tests: 14 18:17:44 INFO - PROCESS | 2009 | 18:17:44 INFO - PROCESS | 2009 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.00 stddev:1.10 (1.0%) stddev-sans-first:1.17 18:17:44 INFO - PROCESS | 2009 | Values: 113.0 114.0 113.0 114.0 111.0 115.0 113.0 113.0 112.0 113.0 18:17:44 INFO - PROCESS | 2009 | 18:17:44 INFO - PROCESS | 2009 | [#1] audio-beat-detection Cycles:10 Average:124.50 Median:118.00 stddev:17.56 (14.9%) stddev-sans-first:15.04 18:17:44 INFO - PROCESS | 2009 | Values: 154.0 113.0 112.0 150.0 113.0 114.0 112.0 111.0 144.0 122.0 18:17:44 INFO - PROCESS | 2009 | 18:17:44 INFO - PROCESS | 2009 | [#2] audio-dft Cycles:10 Average:183.60 Median:184.00 stddev:1.26 (0.7%) stddev-sans-first:1.33 18:17:44 INFO - PROCESS | 2009 | Values: 184.0 184.0 186.0 184.0 184.0 183.0 181.0 183.0 183.0 184.0 18:17:44 INFO - PROCESS | 2009 | 18:17:44 INFO - PROCESS | 2009 | [#3] audio-fft Cycles:10 Average:67.40 Median:61.00 stddev:12.84 (21.1%) stddev-sans-first:12.49 18:17:44 INFO - PROCESS | 2009 | Values: 82.0 59.0 58.0 91.0 62.0 60.0 59.0 60.0 84.0 59.0 18:17:44 INFO - PROCESS | 2009 | 18:17:44 INFO - PROCESS | 2009 | [#4] audio-oscillator Cycles:10 Average:84.60 Median:90.00 stddev:11.61 (12.9%) stddev-sans-first:12.20 18:17:44 INFO - PROCESS | 2009 | Values: 89.0 71.0 94.0 91.0 98.0 89.0 91.0 67.0 67.0 89.0 18:17:44 INFO - PROCESS | 2009 | 18:17:44 INFO - PROCESS | 2009 | [#5] imaging-gaussian-blur Cycles:10 Average:86.20 Median:86.50 stddev:1.99 (2.3%) stddev-sans-first:2.09 18:17:44 INFO - PROCESS | 2009 | Values: 87.0 85.0 88.0 84.0 88.0 85.0 90.0 85.0 86.0 84.0 18:17:44 INFO - PROCESS | 2009 | 18:17:44 INFO - PROCESS | 2009 | [#6] imaging-darkroom Cycles:10 Average:93.40 Median:93.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 18:17:44 INFO - PROCESS | 2009 | Values: 93.0 94.0 93.0 93.0 93.0 94.0 94.0 93.0 94.0 93.0 18:17:44 INFO - PROCESS | 2009 | 18:17:44 INFO - PROCESS | 2009 | [#7] imaging-desaturate Cycles:10 Average:92.90 Median:83.50 stddev:21.10 (25.3%) stddev-sans-first:22.13 18:17:44 INFO - PROCESS | 2009 | Values: 84.0 84.0 79.0 81.0 81.0 83.0 91.0 143.0 119.0 84.0 18:17:44 INFO - PROCESS | 2009 | 18:17:44 INFO - PROCESS | 2009 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:0.99 (1.8%) stddev-sans-first:0.78 18:17:44 INFO - PROCESS | 2009 | Values: 56.0 54.0 54.0 53.0 54.0 55.0 53.0 55.0 54.0 53.0 18:17:44 INFO - PROCESS | 2009 | 18:17:44 INFO - PROCESS | 2009 | [#9] json-stringify-tinderbox Cycles:10 Average:70.80 Median:71.50 stddev:2.82 (3.9%) stddev-sans-first:2.40 18:17:44 INFO - PROCESS | 2009 | Values: 66.0 73.0 69.0 76.0 73.0 71.0 69.0 70.0 69.0 72.0 18:17:44 INFO - PROCESS | 2009 | 18:17:44 INFO - PROCESS | 2009 | [#10] stanford-crypto-aes Cycles:10 Average:95.70 Median:90.00 stddev:10.77 (12.0%) stddev-sans-first:11.31 18:17:44 INFO - PROCESS | 2009 | Values: 100.0 105.0 105.0 74.0 101.0 103.0 106.0 88.0 88.0 87.0 18:17:44 INFO - PROCESS | 2009 | 18:17:44 INFO - PROCESS | 2009 | [#11] stanford-crypto-ccm Cycles:10 Average:155.40 Median:153.50 stddev:15.45 (10.1%) stddev-sans-first:16.01 18:17:44 INFO - PROCESS | 2009 | Values: 146.0 151.0 154.0 166.0 139.0 150.0 157.0 153.0 194.0 144.0 18:17:44 INFO - PROCESS | 2009 | 18:17:44 INFO - PROCESS | 2009 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.40 Median:175.00 stddev:1.17 (0.7%) stddev-sans-first:1.22 18:17:44 INFO - PROCESS | 2009 | Values: 175.0 175.0 172.0 173.0 175.0 174.0 176.0 175.0 175.0 174.0 18:17:44 INFO - PROCESS | 2009 | 18:17:44 INFO - PROCESS | 2009 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.50 Median:78.50 stddev:8.53 (10.9%) stddev-sans-first:8.60 18:17:44 INFO - PROCESS | 2009 | Values: 69.0 68.0 69.0 72.0 81.0 89.0 87.0 86.0 76.0 68.0 18:17:44 INFO - PROCESS | 2009 | -------- Summary: end -------- 18:17:44 INFO - PROCESS | 2009 | 18:17:45 INFO - TEST-INFO | 2009: exit 0 18:17:45 INFO - TEST-OK | kraken | took 60026ms 18:17:45 INFO - SUITE-END | took 1179s 18:17:45 INFO - Completed test suite (00:19:39) 18:17:45 INFO - javascript benchmark 18:17:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2977.642682878055, 3266.1181481000144, 3297.0603378037263, 3304.1244070321363, 3323.435016047273, 5586.469285417889, 5636.718164091794, 5678.5741069419755, 5696.601237913348, 5733.799317023905, 5582.7766889324475, 5734.913976290359, 5748.568857335696, 5769.884602307951, 5773.220615216955, 5044.218146187347, 5157.123289040872, 5169.276301317818, 5190.92213616796, 5248.947510524903, 5310.654807437504, 5316.149416093426, 5316.654417462872, 5319.069162896497, 5386.218998245252, 4545.909081818361, 5087.872803179913, 5294.894102117974, 5305.310309659758, 5355.0, 5106.5659418949435, 5180.740962951837, 5189.896202075975, 5245.580353571743, 5270.7628156733035, 5134.101532231882, 5174.715390653512, 5175.792968281265, 5186.896262074775, 5199.610029247784, 5072.619553533463, 5689.857753556153, 5712.914306285409, 5743.856403589902, 5746.310442746855, 6088.512918966517, 6114.054067497291, 6118.040554665182, 6131.65193447331, 6233.688315584248, 6158.076288556707, 6190.3190649028575, 6273.749050037993, 6294.055891616248, 6296.464800491964, 5825.417458254183, 5845.1232315153065, 5848.181254624356, 5855.941440585625, 5893.616914900561, 6197.5351848610635, 6203.193584834033, 6258.217722784652, 6281.591696539802, 6282.874342513215, 5123.359580052494, 6096.512279017668, 6150.907736383958, 6182.783602573888, 6208.317085120633, 6275.0, 6280.183576135165, 6283.403076707706, 6291.622502649856, 6292.842678933063, 6153.538484613672, 6172.783952561639, 6226.40849119333, 6244.46922011625, 6250.281217659936, 6104.542159337979, 6114.054067497291, 6136.519078024374, 6138.878900475427, 6258.874822503524, 4920.6555541111775, 4921.286413470027, 4936.407631084293, 4966.577840883493, 4967.627427942919, 4375.124975005012, 4449.132419178294, 4457.509673935864, 4460.085682435093, 4495.190865644216, 5648.51987581052, 5714.485696287271, 5779.537636989031, 5816.941830581724, 5827.825165245049, 6167.074938759222, 6193.659348735772, 6229.781957631551, 6242.750289988349, 6292.811215663537, 5884.32330282023, 5890.175375447441, 5890.587658863838, 5893.499052580579, 5918.556108291896, 5439.945600544023, 5441.374241962225, 5441.428649991773, 5444.863878403072, 5444.891102178013, 6099.37031394974, 6142.6522545212965, 6164.352742961924, 6243.282022567463, 6294.496440284858, 5110.48895110486, 5746.051901436216, 6148.3236843948025, 6285.151504546828, 6285.811425657238, 6280.685965701605, 6306.432421082125, 6306.810795676137, 6309.558330916791, 6321.620702757849, 5464.770426653971, 5734.856628584319, 6114.510839132948, 6208.658523781235, 6230.844228894314, 5991.101334799815, 6139.4001448444, 6174.629522228681, 6265.342139075514, 6270.2475702915945, 6136.754529818757, 6137.815865524041, 6139.2325959255095, 6152.200213972155, 6158.846028849314, 5887.0, 6035.879282414415, 6040.80902094145, 6084.087386892002, 6141.0, 5814.622049566765, 5827.0, 5874.060150375919, 5906.911396328973, 5969.791057312973, 6090.939090609215, 6113.633182009094, 6118.724657390517, 6118.877622447437, 6126.417990290915, 5692.658440493418, 5754.51086657622, 5762.423757624204, 5763.769449221984, 5825.155352473783], "value": 5668.280267840409, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [515.1731470989063, 535.3762866260806, 536.8308982670461, 542.8724249801294, 549.4725063938617, 30638.08085757428, 32054.839725801397, 40557.39163912544, 40642.390364144565, 43196.0, 41874.37188442176, 42268.57731422685, 42330.73007809763, 42471.36292955608, 42566.36150457746, 9560.521973901294, 9723.416595004286, 9746.171575416063, 9756.414615123116, 9762.36544624597, 9647.75880602987, 9713.36863103896, 9718.125368716814, 9726.610935562605, 9733.415995040285, 9609.663661771805, 9720.173785228264, 9737.853932191023, 9743.269254805882, 9759.365641233333, 9675.225981921429, 9706.029397060272, 9719.222462203077, 9722.805543889153, 9746.074122958307, 9546.61813527458, 9597.424154550748, 9637.277204209713, 9637.373570717951, 9640.42157470547, 40017.59982400168, 40345.38618455258, 40398.798006010074, 40436.59563404358, 40452.190956181, 3389.9661003390142, 3413.6927676508985, 3436.055084851686, 3440.088376580208, 3503.4744788281705, 30101.397972040435, 30206.0, 30462.39075218483, 31141.37717245665, 31144.37711245785, 3007.6691563927952, 3125.7030582094662, 3171.1120886151916, 3174.777765556412, 3287.1289108386295, 488576.0, 491519.5424022857, 491958.0, 492435.0, 502307.0, 61050.38949610536, 61553.0, 61633.69183154145, 61652.38347616556, 61655.38344616586, 33847.0, 34502.65497344994, 64856.0, 64859.0, 64884.67557662276, 15652.608684782745, 16252.83747162537, 16262.75605865913, 16282.918585407235, 16314.0, 11687.474063666985, 11710.355930423908, 11723.531058757555, 11747.236429632047, 11753.412329383496, 15344.0, 19079.32889395486, 19110.61778764445, 19165.712514312298, 19179.90410047941, 7219.350258476762, 7545.981292525548, 7929.207079292025, 8027.5584842834205, 8125.878111828328, 719.5898337947424, 765.4756491803132, 936.840737074699, 974.5224839828433, 996.3722854601555, 28143.296417589314, 29266.414671706872, 29473.411696762458, 29489.410211795643, 29752.702472974994, 990.7176454710517, 1013.7871047080048, 1025.7230547752065, 1038.2732087538752, 1062.176812969939, 12282.07259352888, 14919.40322387114, 15122.54632361031, 15189.848101519065, 15381.615459613375, 644375.0, 644721.0, 645539.0, 646693.0, 647137.0, 57742.0, 58293.0, 58303.8339233213, 58317.41682583205, 58417.707911461024, 1339.6583871112998, 1358.8505264420905, 1359.6600849787553, 1372.8901687864948, 1373.3270697358423, 27831.0, 28623.713762862106, 28904.586608298352, 29262.0, 29377.11868643944, 48385.0, 49154.75422622864, 49175.770605735146, 49194.0, 49316.753416234125, 498111.0, 499528.0, 500071.49964249943, 500172.0, 501213.0, 25904.0, 26148.0, 26164.215073547824, 26177.95288188451, 26213.4757304849, 44961.32558011698, 46413.76793116013, 47276.29085563788, 47393.05213895772, 47754.0, 38604.42093368658, 38630.6136938627, 38848.02879928024, 40064.0, 40661.98345041398, 33310.333793324484, 38758.99235618483, 39737.40393894152, 39783.80108099441, 40039.79980100081, 36698.79807211576, 36943.445848311756, 37582.0, 37904.86285411442, 38275.23449531049, 26091.547016081327, 32787.0, 33233.851737427685, 34192.145196369296, 34299.82850085734, 24061.398465038514, 24578.69839520665, 24931.501369972862, 25059.373515662253, 25676.486470270862], "value": 19583.069727483515, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.80066762279324, 369.1675272261053, 377.9074126838924, 385.18533302066123, 404.5691338724258, 14596.927015364934, 14872.553823385302, 15511.612209694764, 20137.899310503428, 20718.0, 19015.098490150976, 19494.220231190735, 19976.70034949473, 20231.59536809263, 20361.389158325273, 5569.610127291091, 5658.493613272639, 5870.647761134345, 5873.383294754053, 5891.145783861338, 5068.34111565496, 5557.722113894289, 5845.824625261228, 5854.560907931901, 5860.912086318687, 5489.862753431156, 5657.8585535361535, 5670.716464176795, 5737.168110623957, 5797.333306669724, 5735.713214339287, 5887.411258874121, 5888.941110588925, 5889.676067816268, 5891.878923587548, 5181.378234611833, 5279.894402111975, 5461.672299662033, 5689.971550142264, 5691.203231547586, 12782.808257876139, 13030.348482575928, 13047.673808154777, 13084.542041028519, 23224.53550928989, 2122.9256976005922, 2188.7482939461847, 2345.3784747041877, 2844.8293102413922, 2927.4730548501475, 9239.353245272834, 9481.0, 10074.848877266846, 10088.798224035478, 10224.591016359336, 1693.6782011417915, 1718.5274049636325, 1812.900290484023, 1839.5768973136119, 1892.7539419875327, 112956.0, 122799.38600306942, 125479.0, 130130.0, 131685.0, 9120.771980700403, 10639.255252132276, 10819.0, 11102.44487775608, 11542.769144617061, 12026.518939242333, 14051.016428849882, 14190.503332383318, 14202.431902723982, 14213.715725685428, 7649.04386951631, 7762.7671169865, 7974.282314591598, 8426.988761348677, 8578.699745508877, 8259.917400826034, 8278.503289802631, 8278.8344233115, 8455.02767181782, 8476.49141051539, 4452.131834292282, 4476.776161191928, 4477.507474177838, 4497.550244975541, 4526.275795872711, 1747.6242607839376, 1787.419243836362, 1850.898200598953, 1914.9329773457862, 1954.951126221856, 813.6623301330001, 849.5921957460454, 903.8599017152352, 909.1817364371985, 965.9758506037406, 18833.623327533373, 20437.795622043886, 20484.69272960907, 20588.485287867923, 20786.1685532577, 935.6491315756591, 957.4925289596525, 975.23444096384, 989.9554520046615, 990.782027953849, 10067.395956242503, 10632.574697012187, 10744.462776861126, 10744.785104298027, 10759.525309178933, 548721.0, 574024.0, 574282.0, 585987.0, 587854.0, 79073.0, 110253.0, 134922.0, 136206.3189684065, 136775.0, 982.7248370456284, 992.270681049428, 1004.7287232447198, 1026.697124348319, 1032.0762917189224, 13592.592222233348, 14341.641458963191, 15005.924970375516, 16757.40804623559, 18759.6248075035, 41051.97370065772, 54646.726766365915, 54942.0, 55920.72039639776, 56237.15644265257, 73582.0, 74598.0, 76815.0, 76856.61571692106, 78254.608726956, 6923.688434020381, 7767.019201659414, 7832.960835195788, 8113.959430202811, 8194.918050819415, 11435.714107147054, 12081.154319197572, 12332.907240603863, 12468.875311246771, 12556.434960426985, 10994.450277485934, 11016.0, 11018.559257629926, 11052.778944421227, 11108.000279974842, 10313.74215644615, 10362.378257304586, 10935.0, 10986.835197471884, 11371.772564548497, 10794.406307653155, 10868.728281793019, 11029.558817647205, 11205.271657342246, 11300.547978081113, 6861.318976850704, 7267.491275610657, 7295.489315747846, 7499.287567681062, 8179.550124743197, 9703.66037188695, 11096.833547496633, 11461.598844040418, 11472.713182170513, 11553.942230288794], "value": 9156.064915996909, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1515.0833745583925, 1553.8523840235177, 1765.6468706258752, 1898.8670793044491, 1934.3713293179712, 7453.329200371973, 8236.09402965674, 8738.0, 8738.781530461742, 8742.519161446135, 6662.66686665666, 7996.080450748165, 8248.13394593568, 8496.235338819504, 8502.149785021495, 1766.178726891995, 2268.0247493577754, 2292.2893902890114, 2321.071571371448, 2323.3494621506006, 2220.311703371952, 2312.2485192312483, 2347.6243800991847, 2350.083467447697, 2350.670906073151, 2317.397476656073, 2332.9766702333013, 2337.7545357737363, 2342.7466305526546, 2360.7521210272844, 2321.1527792355837, 2321.6517522371696, 2325.174563030117, 2338.4504641409253, 2342.8945697443655, 2335.497867958397, 2338.088145623208, 2341.215692742916, 2345.29641107667, 2348.635961425982, 8540.274076703488, 8720.607572659246, 8721.520316382597, 8738.300935925174, 8762.342824288204, 5060.468650791688, 5227.137522308814, 5228.973855130738, 5230.34620672416, 5232.136697444917, 3370.561826962504, 3437.3125374924866, 3583.964160358415, 3588.2644057968055, 3597.892063238107, 908.8136931928939, 1015.9288849780519, 1056.5932116135266, 1074.9731256718567, 1079.3685693869018, 11097.3896435696, 11239.943800281028, 11241.269317494336, 11248.775024499464, 11330.206885518017, 4458.621017213573, 4482.305242687388, 4691.507391723888, 4700.835470758507, 4707.435107787019, 9673.806523869483, 9674.903250967542, 9677.564509597085, 9690.418574885529, 9691.466969316756, 4508.864734057984, 5240.3973543042275, 5249.370075590953, 5255.474452554714, 5261.289725886956, 4168.520620128664, 4323.313907576048, 4326.891827704332, 4805.543473370024, 4827.058723548945, 3833.0, 3853.1523064925673, 3941.8029098544957, 3947.190825880745, 3995.2608767377546, 1263.0779530942464, 1263.3051821498323, 1267.2903174222465, 1272.1031672670745, 1280.7950727883494, 790.6442101054433, 843.0, 927.9514149011574, 931.753085432361, 932.7714709896119, 5763.6541807491685, 5908.497777688945, 5995.890760209375, 6044.117867287017, 6308.369163083655, 951.9666811661558, 957.0955447102422, 970.84466485362, 971.145392054987, 1000.5497526113278, 3369.629340772513, 3825.3305671507374, 3936.7637941723588, 4012.6388625023887, 4111.97944010278, 10111.544980475895, 10500.474976251156, 10564.418956957441, 10567.365958042543, 10827.729306767236, 10517.9474102629, 10519.631812886511, 10519.737006574744, 10520.526576304084, 10553.525091370906, 7566.886496702554, 7913.841723165505, 7931.484453510503, 8044.959775201087, 8046.396520260887, 5037.017781532566, 5800.912986305125, 5845.09401042839, 5978.491828194652, 6097.512199024156, 9402.15380615748, 9787.608495660093, 9788.951055244679, 9893.55479003461, 9935.65225217114, 9442.291828113057, 9857.211423085993, 10041.447720375449, 10074.54664540112, 10107.69676909694, 7110.786676399716, 7377.704891804482, 7396.9260307396235, 7468.589227592534, 7537.8115547111765, 8279.213474719892, 8367.665293388196, 8370.204830541088, 8370.581470926307, 8388.328933685169, 7195.784126476214, 7250.9637451812405, 7423.628818559158, 7515.774526764206, 7536.698532058656, 7157.677904494414, 7232.710691572489, 7387.1874093848555, 7390.224026477143, 7427.294407031323, 6823.249442561215, 6965.094537710065, 6969.54697944632, 6976.860462790614, 6979.40675042627, 4306.375575541466, 4942.92585611209, 4949.727764972817, 5001.749912504288, 5064.772085256099, 4617.215073437591, 4723.976380118077, 4875.536824001714, 4891.413030436371, 5018.723970181675], "value": 4514.201827423869, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [263.66777859896536, 297.40370557033145, 298.6207516454103, 306.26801943355383, 313.9968600313996, 4329.848455304065, 4966.528179822911, 5160.587697518619, 5188.37739471263, 5216.347956505437, 4963.766305162682, 5078.822241221558, 5133.230015497677, 5149.81975630853, 5198.116320225561, 3526.4710293455933, 4002.479677641917, 4014.8193331300163, 4032.3749818778138, 4050.1899620075956, 3565.823278318149, 3849.788261645608, 3956.4856220496818, 3974.503187101612, 4032.092779124688, 3757.4176002719623, 3973.5430425501004, 4002.739821911581, 4006.6794656427414, 4020.477337946063, 3457.4122399191947, 3857.267119247334, 3965.286248475273, 3987.4710880870493, 3994.6005399460114, 3500.579930408367, 3502.369573476773, 3505.7020153287003, 3510.350585141757, 3515.402381595135, 4346.087321662455, 4676.638297659694, 5046.21783623539, 5079.847604571869, 5084.923726144111, 4510.684252102355, 4514.774261286955, 4518.864434066983, 4541.523140070278, 4545.0, 4358.6730995175485, 5442.12925931853, 5459.454054594548, 5483.314585676791, 5524.309461317335, 2932.692067332942, 3100.3489267253904, 3656.579493358271, 3777.8866634001024, 3795.221979494197, 5680.971595142039, 5720.456556627114, 5724.627899186539, 5768.423157684198, 5825.242718446617, 3279.901233086895, 3298.901032969015, 3796.3925771876366, 3800.600936901641, 3806.467094606757, 3268.526063720795, 3843.404272337792, 3859.710521710883, 3862.748921320105, 3892.7664340139117, 4273.305911225442, 4432.623227025674, 4459.554044595515, 4491.8427855025575, 4524.502304746476, 4543.818607162161, 4755.429348478205, 5318.9202161967605, 5462.9726851365485, 5526.281583394213, 1115.9107271418268, 1222.7798996180595, 1248.5630029489605, 1273.6433798536425, 1299.4996926183487, 865.4374656473343, 891.6745387933487, 892.5314210039782, 892.9508877011697, 894.4302748676032, 4567.269236922077, 4800.567948884617, 4851.902961940741, 5125.7693403796175, 5143.408508021551, 4894.486078961658, 5049.646524743306, 5321.148616221386, 5440.319960004999, 5587.497125258747, 5007.94833085049, 5105.387353517602, 5107.693538387709, 5109.897802043938, 5153.011253472977, 1978.7229787829715, 2243.6746671732835, 2430.4774473488283, 2439.634054891745, 2446.47400808827, 4240.915181696349, 4244.87265382039, 4327.502337231196, 4658.790354434059, 5388.784448622089, 4934.629902757236, 5296.947030529645, 5710.200571919934, 5886.793962211302, 5896.351401345849, 5649.954758369715, 5821.708914554255, 5870.236869206976, 5900.616459930091, 5933.940660593339, 5208.5051920067535, 5233.947660523346, 5558.60979778699, 5698.772049117989, 5711.457411545896, 4847.757612119451, 4875.658703890836, 5096.898062038665, 5624.3250809903075, 5711.457411545896, 4978.551930326288, 5251.658642188246, 5774.595778295479, 5777.3933736957015, 5801.361850196559, 3249.8050116993054, 3264.9020529384156, 3667.8716244931297, 3870.206607645482, 3895.571487136356, 4626.0, 5455.018096742466, 5507.9449205507435, 5619.409961954099, 5646.825972000727, 4477.798499067615, 5409.29607173739, 5428.321459817523, 5438.9394068156325, 5452.890942181213, 5057.873553161053, 5311.203319501951, 5444.8366549003595, 5450.5367043801725, 5465.398806131243, 5095.337606111182, 5228.438065348028, 5259.948620038264, 5286.0441636594705, 5405.86485337854, 4790.760461976957, 4833.371661684099, 4845.2732090186755, 5511.944880551304, 5526.866992266495, 4638.443386793607, 4893.9021219576125, 5305.840824775263, 5369.48989845964, 5382.946170538401], "value": 3928.275575016995, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [685.5886468119126, 689.6689588997278, 726.8073960400494, 762.8131107878571, 867.2411639815161, 15261.0, 15713.13577753223, 15906.284217210225, 15924.601884952854, 15926.920365398171, 14277.143371397724, 14350.995430319881, 14501.854981450182, 14515.0, 14686.485972990948, 868.0754995929346, 893.5576889439704, 894.6019021535419, 895.9372843900929, 896.9372143949926, 702.1609177033447, 720.1394333771145, 722.5628494760673, 871.6731225790329, 896.8609865470862, 929.1126973740062, 947.0482165423739, 947.1759569174793, 947.5072962059725, 950.7955789505289, 937.8733870927406, 939.1359948847077, 939.229831538139, 941.0260380506178, 941.0307383395113, 544.4827413956757, 544.7820871651371, 561.3011800308601, 694.4791406445166, 695.4123765418213, 15010.324535395825, 15542.844571554253, 15547.378104875792, 15552.766708499381, 15606.063636181865, 13711.314434278247, 13877.167369957835, 13922.651933701638, 14010.509632162928, 14173.0, 10645.84031239532, 12287.508499660004, 12449.875501245053, 12632.49470021198, 12858.485660573566, 4447.79984900677, 4452.666050046259, 4471.150481408522, 4654.8091038918155, 4670.743109128996, 98564.0, 98597.0, 98761.0, 99869.0, 100324.99999999927, 11042.227044106836, 11049.28179668319, 11067.169962252703, 11160.107191424666, 11295.830562541569, 21960.717660056136, 21991.450213744465, 22011.0, 22017.0, 22028.88985555094, 7128.643567821692, 7441.218672039467, 7468.066491688539, 7503.062117235346, 7553.73561925341, 4213.641840443596, 4226.619604235633, 4255.787210639518, 4300.591443812833, 4370.650347972155, 3446.9310613788084, 3588.4796704477703, 3613.060604242863, 3613.313470440608, 3620.0, 666.8032930285577, 669.3908543225739, 674.2583158525582, 683.0983102305009, 691.7163962775238, 600.4265926040621, 606.4021303864262, 630.5460068750492, 643.6459947029209, 650.4113777031794, 6920.550164239308, 9056.649039855296, 9060.365774395728, 9156.175944165057, 9215.631374744935, 460.7719179006346, 617.1668247865435, 618.8855061813579, 621.083901245659, 627.8242092214188, 3852.5954774748807, 4129.194807012604, 4400.317950717644, 4428.68999170055, 4491.663125265618, 106200.0, 120921.0, 126268.7373126257, 127432.0, 147508.0799452494, 121450.57098857974, 124161.0, 125842.37078814548, 128019.33086239705, 130179.0, 72090.63954680298, 107835.0, 112620.31069533963, 112811.43594281976, 113506.29740553898, 9562.28282878773, 9792.510374481106, 9801.754956126153, 9840.45877476717, 9844.704658860246, 46402.0, 55114.346569602974, 62032.68983655233, 62127.44681382821, 62650.06024909539, 73741.0, 98282.01717983015, 98697.0, 99466.5026674862, 99672.54748061346, 10373.481325933522, 13054.738905222031, 13232.603021909357, 13281.800772988607, 13417.329133543479, 14809.629759256104, 14813.851861481247, 14912.0, 15228.619284517976, 15325.6168595786, 13576.321183940567, 13701.45194192221, 13853.376598053314, 13861.653458663613, 14351.497697580535, 12158.696032599255, 12375.071869609996, 13315.400806963517, 13438.260895650443, 13447.798283025959, 13543.79684304756, 13553.457861685421, 13607.591772246848, 13992.860071399156, 14333.996620236483, 9955.402675839472, 11049.447527623748, 11371.31772093677, 11558.30650160993, 11562.88437115618, 10635.627753028606, 11242.606508772154, 11450.370229637118, 11500.654980350602, 11515.36665483373], "value": 7743.205961573067, "unit": "score"}], "name": "dromaeo_css", "value": 7202.202428226638, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 114.0, 111.0, 115.0, 113.0, 113.0, 112.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 113.0, 112.0, 150.0, 113.0, 114.0, 112.0, 111.0, 144.0, 122.0], "value": 124.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 186.0, 184.0, 184.0, 183.0, 181.0, 183.0, 183.0, 184.0], "value": 183.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 58.0, 91.0, 62.0, 60.0, 59.0, 60.0, 84.0, 59.0], "value": 67.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 94.0, 91.0, 98.0, 89.0, 91.0, 67.0, 67.0, 89.0], "value": 84.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 88.0, 84.0, 88.0, 85.0, 90.0, 85.0, 86.0, 84.0], "value": 86.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 93.0, 93.0, 93.0, 94.0, 94.0, 93.0, 94.0, 93.0], "value": 93.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 79.0, 81.0, 81.0, 83.0, 91.0, 143.0, 119.0, 84.0], "value": 92.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 54.0, 53.0, 54.0, 55.0, 53.0, 55.0, 54.0, 53.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 73.0, 69.0, 76.0, 73.0, 71.0, 69.0, 70.0, 69.0, 72.0], "value": 70.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 105.0, 105.0, 74.0, 101.0, 103.0, 106.0, 88.0, 88.0, 87.0], "value": 95.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 151.0, 154.0, 166.0, 139.0, 150.0, 157.0, 153.0, 194.0, 144.0], "value": 155.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 175.0, 172.0, 173.0, 175.0, 174.0, 176.0, 175.0, 175.0, 174.0], "value": 174.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 69.0, 72.0, 81.0, 89.0, 87.0, 86.0, 76.0, 68.0], "value": 76.5, "unit": "score"}], "name": "kraken", "value": 1472.6000000000001, "alertThreshold": 2.0}]} 18:17:45 INFO - Return code: 0 18:17:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:17:45 INFO - # TBPL SUCCESS # 18:17:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:17:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:17:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:17:45 INFO - 2016-10-24 18:17:45.643 screenresolution[2013:15431] starting screenresolution argv=screenresolution get 18:17:45 INFO - 2016-10-24 18:17:45.646 screenresolution[2013:15431] Display 0: 1600x1200x32@60 18:17:45 INFO - 2016-10-24 18:17:45.653 screenresolution[2014:15434] starting screenresolution argv=screenresolution list 18:17:45 INFO - Available Modes on Display 0 18:17:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:17:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:17:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:17:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:17:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:17:45 INFO - Intel Iris: 18:17:45 INFO - Chipset Model: Intel Iris 18:17:45 INFO - Type: GPU 18:17:45 INFO - Bus: Built-In 18:17:45 INFO - VRAM (Dynamic, Max): 1536 MB 18:17:45 INFO - Vendor: Intel (0x8086) 18:17:45 INFO - Device ID: 0x0a2e 18:17:45 INFO - Revision ID: 0x0009 18:17:45 INFO - Displays: 18:17:45 INFO - Display: 18:17:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:17:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:17:45 INFO - Display Serial Number: 1600x1200 60 18:17:45 INFO - Main Display: Yes 18:17:45 INFO - Mirror: Off 18:17:45 INFO - Online: Yes 18:17:45 INFO - Rotation: Supported 18:17:45 INFO - Return code: 0 18:17:45 INFO - Running post-action listener: _resource_record_post_action 18:17:45 INFO - [mozharness: 2016-10-25 01:17:45.888366Z] Finished run-tests step (success) 18:17:45 INFO - Running post-run listener: _resource_record_post_run 18:17:45 INFO - Total resource usage - Wall time: 1214s; CPU: 53.0%; Read bytes: 1736704; Write bytes: 705973760; Read time: 13; Write time: 1976 18:17:45 INFO - TinderboxPrint: CPU usage
53.5% 18:17:45 INFO - TinderboxPrint: I/O read bytes / time
1,736,704 / 13 18:17:45 INFO - TinderboxPrint: I/O write bytes / time
705,973,760 / 1,976 18:17:45 INFO - TinderboxPrint: CPU idle
2,259.2 (46.5%) 18:17:45 INFO - TinderboxPrint: CPU system
971.9 (20.0%) 18:17:45 INFO - TinderboxPrint: CPU user
1,626.7 (33.5%) 18:17:45 INFO - TinderboxPrint: Swap in / out
406,454,272 / 0 18:17:45 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 395432448; Write bytes: 389826560; Read time: 29390; Write time: 826 18:17:45 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 872448; Write bytes: 297616896; Read time: 10; Write time: 1098 18:17:46 INFO - Running post-run listener: _upload_blobber_files 18:17:46 INFO - Blob upload gear active. 18:17:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:17:46 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 18:17:46 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', 'Larch', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:17:46 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 Larch -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:17:46 INFO - Traceback (most recent call last): 18:17:46 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 18:17:46 INFO - main() 18:17:46 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 18:17:46 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 18:17:46 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 18:17:46 INFO - return set(response.json().get('whitelist', [])) 18:17:46 INFO - File "/builds/slave/test/build/venv/lib/python2.7/site-packages/requests/models.py", line 651, in json 18:17:46 INFO - return json.loads(self.text or self.content, **kwargs) 18:17:46 INFO - File "/tools/python27/lib/python2.7/json/__init__.py", line 326, in loads 18:17:46 INFO - return _default_decoder.decode(s) 18:17:46 INFO - File "/tools/python27/lib/python2.7/json/decoder.py", line 366, in decode 18:17:46 INFO - obj, end = self.raw_decode(s, idx=_w(s, 0).end()) 18:17:46 INFO - File "/tools/python27/lib/python2.7/json/decoder.py", line 384, in raw_decode 18:17:46 INFO - raise ValueError("No JSON object could be decoded") 18:17:46 INFO - ValueError: No JSON object could be decoded 18:17:46 ERROR - Return code: 1 18:17:46 INFO - Setting buildbot property blobber_files to {} 18:17:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:17:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:17:46 INFO - Contents: 18:17:46 INFO - blobber_files:{} 18:17:46 INFO - Running post-run listener: copy_logs_to_upload_dir 18:17:46 INFO - Copying logs to upload dir... 18:17:46 INFO - mkdir: /builds/slave/test/build/upload/logs 18:17:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.213477 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-10-24 18:17:46.850298) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 18:17:46.853694) ========= 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.suCx7kL9cC/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.hP2YQtOs2b/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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:{} build_url:https://queue.taskcluster.net/v1/task/SXNuQEL4Qp24IXVJuariQw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011018 build_url: 'https://queue.taskcluster.net/v1/task/SXNuQEL4Qp24IXVJuariQw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 18:17:46.888432) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 18:17:46.888831) ========= 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.suCx7kL9cC/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.hP2YQtOs2b/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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.005224 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 18:17:46.937609) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 18:17:46.938413) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 18:17:46.939082) ========= ========= Total master_lag: 0.19 =========