builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0112 starttime: 1487177749.41 results: success (0) buildid: 20170215072545 builduid: 63b2d8220d534a7ea8ccdd6ed8c4e646 revision: b58ee06413e1a365c40f90ab1d1ca7d5db1916c0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-15 08:55:49.412038) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-15 08:55:49.412525) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-15 08:55:49.412853) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-15 08:55:49.446422) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 08:55:49.447077) ========= 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.Pso9WU0oyx/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.S8xkCj8oMs/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 --2017-02-15 08:55:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.2M=0.001s 2017-02-15 08:55:49 (14.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131883 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 08:55:49.607331) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 08:55:49.607674) ========= 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.Pso9WU0oyx/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.S8xkCj8oMs/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.026774 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 08:55:49.656802) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-15 08:55:49.657197) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b58ee06413e1a365c40f90ab1d1ca7d5db1916c0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b58ee06413e1a365c40f90ab1d1ca7d5db1916c0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Pso9WU0oyx/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.S8xkCj8oMs/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 2017-02-15 08:55:49,760 truncating revision to first 12 chars 2017-02-15 08:55:49,760 Setting DEBUG logging. 2017-02-15 08:55:49,760 attempt 1/10 2017-02-15 08:55:49,760 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b58ee06413e1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-15 08:55:50,491 unpacking tar archive at: mozilla-aurora-b58ee06413e1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.012736 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-15 08:55:50.697366) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-15 08:55:50.700735) ========= script_repo_revision: b58ee06413e1a365c40f90ab1d1ca7d5db1916c0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-15 08:55:50.701180) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-15 08:55:50.701497) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-15 08:55:50.724540) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2017-02-15 08:55:50.724894) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Pso9WU0oyx/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.S8xkCj8oMs/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 08:55:50 INFO - MultiFileLogger online at 20170215 08:55:50 in /builds/slave/test 08:55:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:55:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:55:50 INFO - {'append_to_log': False, 08:55:50 INFO - 'base_work_dir': '/builds/slave/test', 08:55:50 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:55:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:55:50 INFO - 'branch': 'Mozilla-Aurora', 08:55:50 INFO - 'buildbot_json_path': 'buildprops.json', 08:55:50 INFO - 'config_files': ('talos/mac_config.py',), 08:55:50 INFO - 'default_actions': ('clobber', 08:55:50 INFO - 'read-buildbot-config', 08:55:50 INFO - 'download-and-extract', 08:55:50 INFO - 'populate-webroot', 08:55:50 INFO - 'create-virtualenv', 08:55:50 INFO - 'install', 08:55:50 INFO - 'run-tests'), 08:55:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:55:50 INFO - 'download_minidump_stackwalk': True, 08:55:50 INFO - 'download_symbols': 'ondemand', 08:55:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:55:50 INFO - 'tooltool.py': '/tools/tooltool.py', 08:55:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:55:50 INFO - '/tools/misc-python/virtualenv.py')}, 08:55:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:55:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:55:50 INFO - 'installer_path': 'installer.exe', 08:55:50 INFO - 'log_level': 'info', 08:55:50 INFO - 'log_name': 'talos', 08:55:50 INFO - 'log_to_console': True, 08:55:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:55:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:55:50 INFO - 'opt_config_files': (), 08:55:50 INFO - 'pip_index': False, 08:55:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:55:50 INFO - 'cmd': ('bash', 08:55:50 INFO - '-c', 08:55:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:55:50 INFO - 'enabled': True, 08:55:50 INFO - 'halt_on_failure': False, 08:55:50 INFO - 'name': 'check_screen_resolution'},), 08:55:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:55:50 INFO - 'cmd': ('bash', 08:55:50 INFO - '-c', 08:55:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:55:50 INFO - 'enabled': True, 08:55:50 INFO - 'halt_on_failure': False, 08:55:50 INFO - 'name': 'check_screen_resolution'},), 08:55:50 INFO - 'run_cmd_checks_enabled': True, 08:55:50 INFO - 'sps_profile': False, 08:55:50 INFO - 'sps_profile_interval': 0, 08:55:50 INFO - 'suite': 'dromaeojs', 08:55:50 INFO - 'system_bits': '32', 08:55:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:55:50 INFO - 'title': 't-yosemite-r7-0112', 08:55:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:55:50 INFO - 'use_talos_json': True, 08:55:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:55:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:55:50 INFO - 'work_dir': 'build'} 08:55:50 INFO - [mozharness: 2017-02-15 16:55:50.946867Z] Running clobber step. 08:55:50 INFO - Running pre-action listener: _resource_record_pre_action 08:55:50 INFO - Running main action method: clobber 08:55:50 INFO - rmtree: /builds/slave/test/build 08:55:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:55:53 INFO - Running post-action listener: _resource_record_post_action 08:55:53 INFO - [mozharness: 2017-02-15 16:55:53.390731Z] Finished clobber step (success) 08:55:53 INFO - [mozharness: 2017-02-15 16:55:53.390859Z] Running read-buildbot-config step. 08:55:53 INFO - Running pre-action listener: _resource_record_pre_action 08:55:53 INFO - Running main action method: read_buildbot_config 08:55:53 INFO - Using buildbot properties: 08:55:53 INFO - { 08:55:53 INFO - "project": "", 08:55:53 INFO - "product": "firefox", 08:55:53 INFO - "script_repo_revision": "production", 08:55:53 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 08:55:53 INFO - "repository": "", 08:55:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 08:55:53 INFO - "buildid": "20170215072545", 08:55:53 INFO - "pgo_build": "False", 08:55:53 INFO - "basedir": "/builds/slave/test", 08:55:53 INFO - "buildnumber": 4, 08:55:53 INFO - "slavename": "t-yosemite-r7-0112", 08:55:53 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:55:53 INFO - "platform": "yosemite_r7", 08:55:53 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:55:53 INFO - "branch": "mozilla-aurora", 08:55:53 INFO - "repo_path": "releases/mozilla-aurora", 08:55:53 INFO - "revision": "b58ee06413e1a365c40f90ab1d1ca7d5db1916c0", 08:55:53 INFO - "stage_platform": "macosx64", 08:55:53 INFO - "builduid": "63b2d8220d534a7ea8ccdd6ed8c4e646", 08:55:53 INFO - "slavebuilddir": "test" 08:55:53 INFO - } 08:55:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/b6heWV48RHWXdfz-rRciUQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 08:55:53 INFO - Running post-action listener: _resource_record_post_action 08:55:53 INFO - [mozharness: 2017-02-15 16:55:53.394224Z] Finished read-buildbot-config step (success) 08:55:53 INFO - [mozharness: 2017-02-15 16:55:53.394328Z] Running download-and-extract step. 08:55:53 INFO - Running pre-action listener: _resource_record_pre_action 08:55:53 INFO - Running main action method: download_and_extract 08:55:53 INFO - mkdir: /builds/slave/test/build/tests 08:55:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:53 INFO - trying https://queue.taskcluster.net/v1/task/b6heWV48RHWXdfz-rRciUQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 08:55:53 INFO - Downloading https://queue.taskcluster.net/v1/task/b6heWV48RHWXdfz-rRciUQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:55:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b6heWV48RHWXdfz-rRciUQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 08:55:54 INFO - Downloaded 1199 bytes. 08:55:54 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:55:54 INFO - Using the following test package requirements: 08:55:54 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:55:54 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:55:54 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 08:55:54 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:55:54 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 08:55:54 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:55:54 INFO - u'jsshell-mac.zip'], 08:55:54 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:55:54 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 08:55:54 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:55:54 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:55:54 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 08:55:54 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:55:54 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 08:55:54 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:55:54 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 08:55:54 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:55:54 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 08:55:54 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:55:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b6heWV48RHWXdfz-rRciUQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:55:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b6heWV48RHWXdfz-rRciUQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:55:54 INFO - Fetch https://queue.taskcluster.net/v1/task/b6heWV48RHWXdfz-rRciUQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:55:57 INFO - Expected file size: 16358324 08:55:57 INFO - Obtained file size: 16358324 08:56:03 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:56:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b6heWV48RHWXdfz-rRciUQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:56:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b6heWV48RHWXdfz-rRciUQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:56:03 INFO - Fetch https://queue.taskcluster.net/v1/task/b6heWV48RHWXdfz-rRciUQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:56:06 INFO - Expected file size: 16358324 08:56:06 INFO - Obtained file size: 16358324 08:56:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b6heWV48RHWXdfz-rRciUQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 08:56:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b6heWV48RHWXdfz-rRciUQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:56:12 INFO - Fetch https://queue.taskcluster.net/v1/task/b6heWV48RHWXdfz-rRciUQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 08:56:14 INFO - Expected file size: 14403485 08:56:14 INFO - Obtained file size: 14403485 08:56:14 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')]} 08:56:14 INFO - trying https://queue.taskcluster.net/v1/task/b6heWV48RHWXdfz-rRciUQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:56:14 INFO - Downloading https://queue.taskcluster.net/v1/task/b6heWV48RHWXdfz-rRciUQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 08:56:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b6heWV48RHWXdfz-rRciUQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 08:56:18 INFO - Downloaded 73940225 bytes. 08:56:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b6heWV48RHWXdfz-rRciUQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:56:18 INFO - mkdir: /builds/slave/test/properties 08:56:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:56:18 INFO - Writing to file /builds/slave/test/properties/build_url 08:56:18 INFO - Contents: 08:56:18 INFO - build_url:https://queue.taskcluster.net/v1/task/b6heWV48RHWXdfz-rRciUQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:56:19 INFO - Running post-action listener: _resource_record_post_action 08:56:19 INFO - Running post-action listener: set_extra_try_arguments 08:56:19 INFO - [mozharness: 2017-02-15 16:56:19.775173Z] Finished download-and-extract step (success) 08:56:19 INFO - [mozharness: 2017-02-15 16:56:19.775294Z] Running populate-webroot step. 08:56:19 INFO - Running pre-action listener: _resource_record_pre_action 08:56:19 INFO - Running main action method: populate_webroot 08:56:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:56:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:56:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:56:19 INFO - '--tppagecycles', 08:56:19 INFO - '7'], 08:56:19 INFO - 'tests': ['tsvgm']}}, 08:56:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:56:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:56:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:56:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:56:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:56:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:56:19 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:56:19 INFO - 'talos_options': ['--disable-e10s'], 08:56:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:56:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:56:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:56:19 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:56:19 INFO - 'talos_options': ['--disable-e10s'], 08:56:19 INFO - 'tests': ['damp', 'tps']}, 08:56:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:56:19 INFO - 'tests': ['damp', 'tps']}, 08:56:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:56:19 INFO - 'tests': ['dromaeo_dom']}, 08:56:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:56:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:56:19 INFO - 'tests': ['basic_compositor_video']}, 08:56:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:56:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:56:19 INFO - 'tests': ['a11yr', 08:56:19 INFO - 'ts_paint', 08:56:19 INFO - 'tpaint', 08:56:19 INFO - 'sessionrestore', 08:56:19 INFO - 'sessionrestore_no_auto_restore', 08:56:19 INFO - 'tabpaint']}, 08:56:19 INFO - 'other-e10s': {'tests': ['a11yr', 08:56:19 INFO - 'ts_paint', 08:56:19 INFO - 'tpaint', 08:56:19 INFO - 'sessionrestore', 08:56:19 INFO - 'sessionrestore_no_auto_restore', 08:56:19 INFO - 'tabpaint']}, 08:56:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:56:19 INFO - 'ts_paint', 08:56:19 INFO - 'tpaint', 08:56:19 INFO - 'sessionrestore', 08:56:19 INFO - 'sessionrestore_no_auto_restore', 08:56:19 INFO - 'tabpaint']}, 08:56:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:56:19 INFO - 'ts_paint', 08:56:19 INFO - 'tpaint', 08:56:19 INFO - 'sessionrestore', 08:56:19 INFO - 'sessionrestore_no_auto_restore', 08:56:19 INFO - 'tabpaint']}, 08:56:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:56:19 INFO - 'tests': ['a11yr', 08:56:19 INFO - 'ts_paint', 08:56:19 INFO - 'tpaint', 08:56:19 INFO - 'sessionrestore', 08:56:19 INFO - 'sessionrestore_no_auto_restore', 08:56:19 INFO - 'tabpaint']}, 08:56:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:56:19 INFO - 'tests': ['a11yr', 08:56:19 INFO - 'ts_paint', 08:56:19 INFO - 'tpaint', 08:56:19 INFO - 'sessionrestore', 08:56:19 INFO - 'sessionrestore_no_auto_restore', 08:56:19 INFO - 'tabpaint']}, 08:56:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:56:19 INFO - 'tests': ['tsvgx', 08:56:19 INFO - 'tsvgr_opacity', 08:56:19 INFO - 'tart', 08:56:19 INFO - 'tscrollx', 08:56:19 INFO - 'cart', 08:56:19 INFO - 'tsvg_static']}, 08:56:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:56:19 INFO - 'tsvgr_opacity', 08:56:19 INFO - 'tart', 08:56:19 INFO - 'tscrollx', 08:56:19 INFO - 'cart', 08:56:19 INFO - 'tsvg_static']}, 08:56:19 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:56:19 INFO - 'talos_options': ['--disable-e10s'], 08:56:19 INFO - 'tests': ['tp5o']}, 08:56:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:56:19 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:56:19 INFO - 'talos_options': ['--disable-e10s', 08:56:19 INFO - '--xperf_path', 08:56:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:56:19 INFO - 'tests': ['tp5n']}, 08:56:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:56:19 INFO - 'talos_options': ['--xperf_path', 08:56:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:56:19 INFO - 'tests': ['tp5n']}}, 08:56:19 INFO - 'talos.zip': {'path': '', 08:56:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:56:19 INFO - Running post-action listener: _resource_record_post_action 08:56:19 INFO - [mozharness: 2017-02-15 16:56:19.794047Z] Finished populate-webroot step (success) 08:56:19 INFO - [mozharness: 2017-02-15 16:56:19.794188Z] Running create-virtualenv step. 08:56:19 INFO - Running pre-action listener: _resource_record_pre_action 08:56:19 INFO - Running main action method: create_virtualenv 08:56:19 INFO - Creating virtualenv /builds/slave/test/build/venv 08:56:19 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 08:56:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:56:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:56:19 INFO - Using real prefix '/tools/python27' 08:56:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:56:20 INFO - Installing distribute.............................................................................................................................................................................................done. 08:56:23 INFO - Installing pip.................done. 08:56:23 INFO - Return code: 0 08:56:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:56:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:56:23 INFO - Reading from file tmpfile_stdout 08:56:23 INFO - Output received: 08:56:23 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) 08:56:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:56:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:23 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 0x10410eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104111768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8924790e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103eecd30>, '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 0x103e13db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ee1be8>, '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.Pso9WU0oyx/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.S8xkCj8oMs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 08:56:23 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 08:56:23 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 08:56:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pso9WU0oyx/Render', 08:56:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:23 INFO - 'HOME': '/Users/cltbld', 08:56:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:23 INFO - 'LOGNAME': 'cltbld', 08:56:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:23 INFO - 'MOZ_NO_REMOTE': '1', 08:56:23 INFO - 'NO_EM_RESTART': '1', 08:56:23 INFO - 'PAGER': '/bin/cat', 08:56:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:23 INFO - 'PWD': '/builds/slave/test', 08:56:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:23 INFO - 'SHELL': '/bin/bash', 08:56:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S8xkCj8oMs/Listeners', 08:56:23 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 08:56:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:23 INFO - 'USER': 'cltbld', 08:56:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:23 INFO - 'XPC_FLAGS': '0x0', 08:56:23 INFO - 'XPC_SERVICE_NAME': '0', 08:56:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:24 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:56:24 INFO - Cleaning up... 08:56:24 INFO - Return code: 0 08:56:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:56: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')]} 08:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56: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')]} 08:56:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10410eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104111768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8924790e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103eecd30>, '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 0x103e13db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ee1be8>, '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.Pso9WU0oyx/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.S8xkCj8oMs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 08:56:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:56:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:56:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pso9WU0oyx/Render', 08:56:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:24 INFO - 'HOME': '/Users/cltbld', 08:56:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:24 INFO - 'LOGNAME': 'cltbld', 08:56:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:24 INFO - 'MOZ_NO_REMOTE': '1', 08:56:24 INFO - 'NO_EM_RESTART': '1', 08:56:24 INFO - 'PAGER': '/bin/cat', 08:56:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:24 INFO - 'PWD': '/builds/slave/test', 08:56:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:24 INFO - 'SHELL': '/bin/bash', 08:56:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S8xkCj8oMs/Listeners', 08:56:24 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 08:56:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:24 INFO - 'USER': 'cltbld', 08:56:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:24 INFO - 'XPC_FLAGS': '0x0', 08:56:24 INFO - 'XPC_SERVICE_NAME': '0', 08:56:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:24 INFO - Downloading/unpacking psutil>=3.1.1 08:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:56:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:56:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:56:27 INFO - Installing collected packages: psutil 08:56:27 INFO - Running setup.py install for psutil 08:56:27 INFO - building 'psutil._psutil_osx' extension 08:56:27 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 08:56:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:56:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:56:28 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 08:56:28 INFO - building 'psutil._psutil_posix' extension 08:56:28 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 08:56:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:56:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:56:28 INFO - ^ 08:56:28 INFO - 1 warning generated. 08:56:28 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 08:56:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:56:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:56:28 INFO - Successfully installed psutil 08:56:28 INFO - Cleaning up... 08:56:29 INFO - Return code: 0 08:56:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10410eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104111768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8924790e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103eecd30>, '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 0x103e13db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ee1be8>, '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.Pso9WU0oyx/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.S8xkCj8oMs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 08:56:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:56:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:56:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pso9WU0oyx/Render', 08:56:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:29 INFO - 'HOME': '/Users/cltbld', 08:56:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:29 INFO - 'LOGNAME': 'cltbld', 08:56:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:29 INFO - 'MOZ_NO_REMOTE': '1', 08:56:29 INFO - 'NO_EM_RESTART': '1', 08:56:29 INFO - 'PAGER': '/bin/cat', 08:56:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:29 INFO - 'PWD': '/builds/slave/test', 08:56:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:29 INFO - 'SHELL': '/bin/bash', 08:56:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S8xkCj8oMs/Listeners', 08:56:29 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 08:56:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:29 INFO - 'USER': 'cltbld', 08:56:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:29 INFO - 'XPC_FLAGS': '0x0', 08:56:29 INFO - 'XPC_SERVICE_NAME': '0', 08:56:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:56:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:56:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:56:32 INFO - Installing collected packages: mozsystemmonitor 08:56:32 INFO - Running setup.py install for mozsystemmonitor 08:56:32 INFO - Successfully installed mozsystemmonitor 08:56:32 INFO - Cleaning up... 08:56:32 INFO - Return code: 0 08:56:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:56:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10410eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104111768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8924790e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103eecd30>, '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 0x103e13db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ee1be8>, '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.Pso9WU0oyx/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.S8xkCj8oMs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 08:56:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:56:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:56:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pso9WU0oyx/Render', 08:56:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:32 INFO - 'HOME': '/Users/cltbld', 08:56:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:32 INFO - 'LOGNAME': 'cltbld', 08:56:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:32 INFO - 'MOZ_NO_REMOTE': '1', 08:56:32 INFO - 'NO_EM_RESTART': '1', 08:56:32 INFO - 'PAGER': '/bin/cat', 08:56:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:32 INFO - 'PWD': '/builds/slave/test', 08:56:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:32 INFO - 'SHELL': '/bin/bash', 08:56:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S8xkCj8oMs/Listeners', 08:56:32 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 08:56:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:32 INFO - 'USER': 'cltbld', 08:56:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:32 INFO - 'XPC_FLAGS': '0x0', 08:56:32 INFO - 'XPC_SERVICE_NAME': '0', 08:56:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:32 INFO - Downloading/unpacking jsonschema==2.5.1 08:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:56:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:35 INFO - Downloading functools32-3.2.3-2.tar.gz 08:56:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:56:35 INFO - warning: no files found matching '*.txt' 08:56:35 INFO - no previously-included directories found matching 'build' 08:56:35 INFO - no previously-included directories found matching 'dist' 08:56:35 INFO - no previously-included directories found matching '.git*' 08:56:35 INFO - Installing collected packages: jsonschema, functools32 08:56:35 INFO - Running setup.py install for functools32 08:56:35 INFO - warning: no files found matching '*.txt' 08:56:35 INFO - no previously-included directories found matching 'build' 08:56:35 INFO - no previously-included directories found matching 'dist' 08:56:35 INFO - no previously-included directories found matching '.git*' 08:56:35 INFO - Successfully installed jsonschema functools32 08:56:35 INFO - Cleaning up... 08:56:35 INFO - Return code: 0 08:56:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:56:35 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')]} 08:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:35 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')]} 08:56:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:35 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 0x10410eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104111768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8924790e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103eecd30>, '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 0x103e13db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ee1be8>, '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.Pso9WU0oyx/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.S8xkCj8oMs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 08:56:35 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 08:56:35 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 08:56:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pso9WU0oyx/Render', 08:56:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:35 INFO - 'HOME': '/Users/cltbld', 08:56:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:35 INFO - 'LOGNAME': 'cltbld', 08:56:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:35 INFO - 'MOZ_NO_REMOTE': '1', 08:56:35 INFO - 'NO_EM_RESTART': '1', 08:56:35 INFO - 'PAGER': '/bin/cat', 08:56:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:35 INFO - 'PWD': '/builds/slave/test', 08:56:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:35 INFO - 'SHELL': '/bin/bash', 08:56:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S8xkCj8oMs/Listeners', 08:56:35 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 08:56:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:35 INFO - 'USER': 'cltbld', 08:56:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:35 INFO - 'XPC_FLAGS': '0x0', 08:56:35 INFO - 'XPC_SERVICE_NAME': '0', 08:56:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:56:36 INFO - Cleaning up... 08:56:36 INFO - Return code: 0 08:56:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:56:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10410eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104111768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8924790e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103eecd30>, '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 0x103e13db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ee1be8>, '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.Pso9WU0oyx/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.S8xkCj8oMs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 08:56:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:56:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:56:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pso9WU0oyx/Render', 08:56:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:36 INFO - 'HOME': '/Users/cltbld', 08:56:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:36 INFO - 'LOGNAME': 'cltbld', 08:56:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:36 INFO - 'MOZ_NO_REMOTE': '1', 08:56:36 INFO - 'NO_EM_RESTART': '1', 08:56:36 INFO - 'PAGER': '/bin/cat', 08:56:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:36 INFO - 'PWD': '/builds/slave/test', 08:56:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:36 INFO - 'SHELL': '/bin/bash', 08:56:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S8xkCj8oMs/Listeners', 08:56:36 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 08:56:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:36 INFO - 'USER': 'cltbld', 08:56:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:36 INFO - 'XPC_FLAGS': '0x0', 08:56:36 INFO - 'XPC_SERVICE_NAME': '0', 08:56:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:36 INFO - Downloading/unpacking blobuploader==1.2.4 08:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:38 INFO - Downloading blobuploader-1.2.4.tar.gz 08:56:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:56:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:56:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:40 INFO - Downloading docopt-0.6.1.tar.gz 08:56:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:56:40 INFO - Installing collected packages: blobuploader, requests, docopt 08:56:40 INFO - Running setup.py install for blobuploader 08:56:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:56:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:56:40 INFO - Running setup.py install for requests 08:56:41 INFO - Running setup.py install for docopt 08:56:41 INFO - Successfully installed blobuploader requests docopt 08:56:41 INFO - Cleaning up... 08:56:41 INFO - Return code: 0 08:56:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10410eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104111768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8924790e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103eecd30>, '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 0x103e13db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ee1be8>, '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.Pso9WU0oyx/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.S8xkCj8oMs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 08:56:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:56:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:56:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pso9WU0oyx/Render', 08:56:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:41 INFO - 'HOME': '/Users/cltbld', 08:56:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:41 INFO - 'LOGNAME': 'cltbld', 08:56:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:41 INFO - 'MOZ_NO_REMOTE': '1', 08:56:41 INFO - 'NO_EM_RESTART': '1', 08:56:41 INFO - 'PAGER': '/bin/cat', 08:56:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:41 INFO - 'PWD': '/builds/slave/test', 08:56:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:41 INFO - 'SHELL': '/bin/bash', 08:56:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S8xkCj8oMs/Listeners', 08:56:41 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 08:56:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:41 INFO - 'USER': 'cltbld', 08:56:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:41 INFO - 'XPC_FLAGS': '0x0', 08:56:41 INFO - 'XPC_SERVICE_NAME': '0', 08:56:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:56:41 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-MUTkPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:56:41 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-Xh_hqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:56:41 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-TxdczY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:56:41 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-WqFuiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:56:41 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-Obu1AA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:56:42 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-JXl4zy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:56:42 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-gi_gIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:56:42 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-i7GE7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:56:42 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-fWdxMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:56:42 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-CiyWlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:56:42 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-fbEA0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:56:42 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-uUEzab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:56:42 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-x6eHeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:56:42 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-CCIJGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:42 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-HgYCiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:56:43 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-YhUGGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:56:43 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-V6MyV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:56:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:56:43 INFO - Running setup.py install for manifestparser 08:56:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:56:43 INFO - Running setup.py install for mozcrash 08:56:43 INFO - Running setup.py install for mozdebug 08:56:43 INFO - Running setup.py install for mozdevice 08:56:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:56:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:56:43 INFO - Running setup.py install for mozfile 08:56:44 INFO - Running setup.py install for mozhttpd 08:56:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:56:44 INFO - Running setup.py install for mozinfo 08:56:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:56:44 INFO - Running setup.py install for mozInstall 08:56:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:56:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:56:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:56:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:56:44 INFO - Running setup.py install for mozleak 08:56:44 INFO - Running setup.py install for mozlog 08:56:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:56:44 INFO - Running setup.py install for moznetwork 08:56:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:56:44 INFO - Running setup.py install for mozprocess 08:56:45 INFO - Running setup.py install for mozprofile 08:56:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:56:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:56:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:56:45 INFO - Running setup.py install for mozrunner 08:56:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:56:45 INFO - Running setup.py install for mozscreenshot 08:56:45 INFO - Running setup.py install for moztest 08:56:45 INFO - Running setup.py install for mozversion 08:56:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:56:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:56:45 INFO - Cleaning up... 08:56:45 INFO - Return code: 0 08:56:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56:45 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')]} 08:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:45 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')]} 08:56:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10410eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104111768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8924790e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103eecd30>, '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 0x103e13db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ee1be8>, '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.Pso9WU0oyx/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.S8xkCj8oMs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 08:56:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:56:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:56:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pso9WU0oyx/Render', 08:56:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:46 INFO - 'HOME': '/Users/cltbld', 08:56:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:46 INFO - 'LOGNAME': 'cltbld', 08:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:46 INFO - 'MOZ_NO_REMOTE': '1', 08:56:46 INFO - 'NO_EM_RESTART': '1', 08:56:46 INFO - 'PAGER': '/bin/cat', 08:56:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:46 INFO - 'PWD': '/builds/slave/test', 08:56:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:46 INFO - 'SHELL': '/bin/bash', 08:56:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S8xkCj8oMs/Listeners', 08:56:46 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 08:56:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:46 INFO - 'USER': 'cltbld', 08:56:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:46 INFO - 'XPC_FLAGS': '0x0', 08:56:46 INFO - 'XPC_SERVICE_NAME': '0', 08:56:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:56:46 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-rwnFN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:56:46 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-lc9mqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:56:46 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-mymz0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:56:46 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-45TyOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:56:46 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-2jTpoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:56:46 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-b2f_KM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:56:47 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-dTkEev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:56:47 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-IcTatb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:56:47 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-7mJZ_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:56:47 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-pJnBXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:56:47 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-h4l1n_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:56:47 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-4JAZUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 08:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:56:47 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-hDuOr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:56:47 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-PIgJLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:47 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-_odoBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:48 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)) 08:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:56:48 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-rs2Ezd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 08:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:56:48 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-UYbuHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:56:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:51 INFO - Downloading blessings-1.6.tar.gz 08:56:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:56:51 INFO - Installing collected packages: blessings 08:56:51 INFO - Running setup.py install for blessings 08:56:51 INFO - Successfully installed blessings 08:56:51 INFO - Cleaning up... 08:56:51 INFO - Return code: 0 08:56:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:56:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:56:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:56:51 INFO - Reading from file tmpfile_stdout 08:56:51 INFO - Current package versions: 08:56:51 INFO - blessings == 1.6 08:56:51 INFO - blobuploader == 1.2.4 08:56:51 INFO - docopt == 0.6.1 08:56:51 INFO - functools32 == 3.2.3-2 08:56:51 INFO - jsonschema == 2.5.1 08:56:51 INFO - manifestparser == 1.1 08:56:51 INFO - mozInstall == 1.12 08:56:51 INFO - mozcrash == 1.0 08:56:51 INFO - mozdebug == 0.1 08:56:51 INFO - mozdevice == 0.49 08:56:51 INFO - mozfile == 1.2 08:56:51 INFO - mozhttpd == 0.7 08:56:51 INFO - mozinfo == 0.9 08:56:51 INFO - mozleak == 0.1 08:56:51 INFO - mozlog == 3.4 08:56:51 INFO - moznetwork == 0.27 08:56:51 INFO - mozprocess == 0.24 08:56:51 INFO - mozprofile == 0.28 08:56:51 INFO - mozrunner == 6.13 08:56:51 INFO - mozscreenshot == 0.1 08:56:51 INFO - mozsystemmonitor == 0.3 08:56:51 INFO - moztest == 0.8 08:56:51 INFO - mozversion == 1.4 08:56:51 INFO - psutil == 3.1.1 08:56:51 INFO - requests == 1.2.3 08:56:51 INFO - wsgiref == 0.1.2 08:56:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:51 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 0x10410eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104111768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8924790e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103eecd30>, '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 0x103e13db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ee1be8>, '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.Pso9WU0oyx/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.S8xkCj8oMs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 08:56:51 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 08:56:51 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 08:56:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pso9WU0oyx/Render', 08:56:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:51 INFO - 'HOME': '/Users/cltbld', 08:56:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:51 INFO - 'LOGNAME': 'cltbld', 08:56:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:51 INFO - 'MOZ_NO_REMOTE': '1', 08:56:51 INFO - 'NO_EM_RESTART': '1', 08:56:51 INFO - 'PAGER': '/bin/cat', 08:56:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:51 INFO - 'PWD': '/builds/slave/test', 08:56:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:51 INFO - 'SHELL': '/bin/bash', 08:56:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S8xkCj8oMs/Listeners', 08:56:51 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 08:56:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:51 INFO - 'USER': 'cltbld', 08:56:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:51 INFO - 'XPC_FLAGS': '0x0', 08:56:51 INFO - 'XPC_SERVICE_NAME': '0', 08:56:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:56:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:56:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:56:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:56:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:56:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:56:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:56:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:56:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:56:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:56:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:56:52 INFO - Cleaning up... 08:56:52 INFO - Return code: 0 08:56:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:56:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10410eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104111768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8924790e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103eecd30>, '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 0x103e13db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ee1be8>, '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.Pso9WU0oyx/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.S8xkCj8oMs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 08:56:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:56:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:56:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pso9WU0oyx/Render', 08:56:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:52 INFO - 'HOME': '/Users/cltbld', 08:56:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:52 INFO - 'LOGNAME': 'cltbld', 08:56:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:52 INFO - 'MOZ_NO_REMOTE': '1', 08:56:52 INFO - 'NO_EM_RESTART': '1', 08:56:52 INFO - 'PAGER': '/bin/cat', 08:56:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:52 INFO - 'PWD': '/builds/slave/test', 08:56:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:52 INFO - 'SHELL': '/bin/bash', 08:56:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S8xkCj8oMs/Listeners', 08:56:52 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 08:56:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:52 INFO - 'USER': 'cltbld', 08:56:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:52 INFO - 'XPC_FLAGS': '0x0', 08:56:52 INFO - 'XPC_SERVICE_NAME': '0', 08:56:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:56:52 INFO - Cleaning up... 08:56:52 INFO - Return code: 0 08:56:52 INFO - Running post-action listener: _resource_record_post_action 08:56:52 INFO - Running post-action listener: _start_resource_monitoring 08:56:52 INFO - Starting resource monitoring. 08:56:52 INFO - [mozharness: 2017-02-15 16:56:52.432996Z] Finished create-virtualenv step (success) 08:56:52 INFO - [mozharness: 2017-02-15 16:56:52.433928Z] Running install step. 08:56:52 INFO - Running pre-action listener: _resource_record_pre_action 08:56:52 INFO - Running main action method: install 08:56:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:56:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:56:52 INFO - Reading from file tmpfile_stdout 08:56:52 INFO - Detecting whether we're running mozinstall >=1.0... 08:56:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:56:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:56:52 INFO - Reading from file tmpfile_stdout 08:56:52 INFO - Output received: 08:56:52 INFO - Usage: mozinstall [options] installer 08:56:52 INFO - Options: 08:56:52 INFO - -h, --help show this help message and exit 08:56:52 INFO - -d DEST, --destination=DEST 08:56:52 INFO - Directory to install application into. [default: 08:56:52 INFO - "/builds/slave/test"] 08:56:52 INFO - --app=APP Application being installed. [default: firefox] 08:56:52 INFO - mkdir: /builds/slave/test/build/application 08:56:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:56:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:57:12 INFO - Reading from file tmpfile_stdout 08:57:12 INFO - Output received: 08:57:12 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:57:12 INFO - Running post-action listener: _resource_record_post_action 08:57:12 INFO - [mozharness: 2017-02-15 16:57:12.553871Z] Finished install step (success) 08:57:12 INFO - [mozharness: 2017-02-15 16:57:12.554041Z] Running run-tests step. 08:57:12 INFO - Running pre-action listener: _resource_record_pre_action 08:57:12 INFO - Running main action method: run_tests 08:57:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:57:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:57:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:57:12 INFO - 2017-02-15 08:57:12.568 screenresolution[1623:7444] starting screenresolution argv=screenresolution get 08:57:12 INFO - 2017-02-15 08:57:12.571 screenresolution[1623:7444] Display 0: 1600x1200x32@60 08:57:12 INFO - 2017-02-15 08:57:12.576 screenresolution[1624:7447] starting screenresolution argv=screenresolution list 08:57:12 INFO - Available Modes on Display 0 08:57:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:57:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:57:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:57:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:57:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:57:12 INFO - Intel Iris: 08:57:12 INFO - Chipset Model: Intel Iris 08:57:12 INFO - Type: GPU 08:57:12 INFO - Bus: Built-In 08:57:12 INFO - VRAM (Dynamic, Max): 1536 MB 08:57:12 INFO - Vendor: Intel (0x8086) 08:57:12 INFO - Device ID: 0x0a2e 08:57:12 INFO - Revision ID: 0x0009 08:57:12 INFO - Displays: 08:57:12 INFO - Display: 08:57:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:57:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:57:12 INFO - Display Serial Number: 1600x1200 60 08:57:12 INFO - Main Display: Yes 08:57:12 INFO - Mirror: Off 08:57:12 INFO - Online: Yes 08:57:12 INFO - Rotation: Supported 08:57:12 INFO - Return code: 0 08:57:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:57:12 INFO - Python 2.7.3 08:57:12 INFO - Return code: 0 08:57:12 INFO - grabbing minidump binary from tooltool 08:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:12 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 0x103eecd30>, '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 0x103e13db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ee1be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:57:12 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 08:57:12 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 08:57:12 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 08:57:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:57:12 INFO - Return code: 0 08:57:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:57:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:57:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:57:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:57:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:57:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b6heWV48RHWXdfz-rRciUQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0112', '--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 08:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/b6heWV48RHWXdfz-rRciUQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0112 --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 08:57:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pso9WU0oyx/Render', 08:57:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:57:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:57:12 INFO - 'HOME': '/Users/cltbld', 08:57:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:57:12 INFO - 'LOGNAME': 'cltbld', 08:57:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:57:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:12 INFO - 'MOZ_NO_REMOTE': '1', 08:57:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:57:12 INFO - 'NO_EM_RESTART': '1', 08:57:12 INFO - 'PAGER': '/bin/cat', 08:57:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:12 INFO - 'PWD': '/builds/slave/test', 08:57:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:57:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:57:12 INFO - 'SHELL': '/bin/bash', 08:57:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S8xkCj8oMs/Listeners', 08:57:12 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 08:57:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:57:12 INFO - 'USER': 'cltbld', 08:57:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:57:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:57:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:12 INFO - 'XPC_FLAGS': '0x0', 08:57:12 INFO - 'XPC_SERVICE_NAME': '0', 08:57:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:57:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b6heWV48RHWXdfz-rRciUQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0112', '--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 08:57:13 INFO - mozversion application_buildid: 20170215072545 08:57:13 INFO - mozversion application_changeset: b58ee06413e1a365c40f90ab1d1ca7d5db1916c0 08:57:13 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:57:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:57:13 INFO - mozversion application_name: Firefox 08:57:13 INFO - mozversion application_remotingname: firefox-dev 08:57:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:57:13 INFO - mozversion application_vendor: Mozilla 08:57:13 INFO - mozversion application_version: 53.0a2 08:57:13 INFO - mozversion platform_buildid: 20170215072545 08:57:13 INFO - mozversion platform_changeset: b58ee06413e1a365c40f90ab1d1ca7d5db1916c0 08:57:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:57:13 INFO - mozversion platform_version: 53.0a2 08:57:13 INFO - using testdate: 1487177833 08:57:13 INFO - actual date: 1487177833 08:57:13 INFO - starting webserver on 'localhost:49241' 08:57:13 INFO - SUITE-START | Running 2 tests 08:57:13 INFO - TEST-START | dromaeo_css 08:57:13 INFO - operating with platform_type : mac_ 08:57:13 INFO - Initialising browser for dromaeo_css test... 08:57:13 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpDv8An5/profile http://localhost:49241/getInfo.html) 08:57:15 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 08:57:15 INFO - PROCESS | 1634 | colorDepth:24 08:57:15 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 08:57:15 INFO - PROCESS | 1634 | __metrics 08:57:15 INFO - PROCESS | 1634 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:57:15 INFO - PROCESS | 1634 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:57:16 INFO - TEST-INFO | 1634: exit 0 08:57:16 INFO - Browser initialized. 08:57:16 INFO - Running cycle 1/1 for dromaeo_css test... 08:57:16 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpDv8An5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:57:28 INFO - PROCESS | 1636 | RSS: Main: 213237760 08:57:28 INFO - PROCESS | 1636 | 09:00:32 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 09:00:34 INFO - PROCESS | 1636 | RSS: Main: 342704128 09:00:34 INFO - PROCESS | 1636 | 09:02:18 INFO - PROCESS | 1636 | ************************* 09:02:18 INFO - PROCESS | 1636 | A coding exception was thrown and uncaught in a Task. 09:02:18 INFO - PROCESS | 1636 | 09:02:18 ERROR - PROCESS | 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:02:18 INFO - PROCESS | 1636 | Full stack: 09:02:18 INFO - PROCESS | 1636 | ************************* 09:03:37 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 09:03:37 INFO - PROCESS | 1636 | RSS: Main: 348897280 09:03:37 INFO - PROCESS | 1636 | 09:06:40 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 09:06:40 INFO - PROCESS | 1636 | RSS: Main: 331313152 09:06:40 INFO - PROCESS | 1636 | 09:09:43 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 09:09:43 INFO - PROCESS | 1636 | RSS: Main: 315953152 09:09:43 INFO - PROCESS | 1636 | 09:12:47 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 09:12:48 INFO - PROCESS | 1636 | RSS: Main: 309194752 09:12:48 INFO - PROCESS | 1636 | 09:15:51 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 09:15:51 INFO - PROCESS | 1636 | RSS: Main: 375427072 09:15:51 INFO - PROCESS | 1636 | 09:15:51 INFO - PROCESS | 1636 | __start_tp_report 09:15:51 INFO - PROCESS | 1636 | _x_x_mozilla_page_load 09:15:51 INFO - PROCESS | 1636 | _x_x_mozilla_page_load_details 09:15:51 INFO - PROCESS | 1636 | |i|pagename|runs| 09:15:51 INFO - PROCESS | 1636 | |0;dojo.html;2927.941441171177;3319.684629960154;3340.6826351496607;3341;3365.5456513370686;5658.830235092949;5696.658200507973;5696.743646535905;5701;5706.429357064291;5657.575681823859;5764.5676574256995;5770.163326317692;5774.960507108719;5783.884322313551;5246.895062098756;5281;5292.10034294169;5302.072137375963;5344.198370244475;4265.253580623394;5187.818426355078;5194.71429071401;5352.063388906945;5360.303160589118;5216.426193118754;5224.63427560071;5229.764660590283;5281.656692314988;5296.993571221475;5235.424103348629;5254.737263136828;5278.049951008817;5280.07598670235;5300.469953004707;5153.922691159635;5219.608529360313;5237.057329680656;5257.763400646942;5295.443978382292;5553.250311207976;5568.969740598002;5592.720363981784;5594.916076258859;5639.6334238274385;6216.844578885564;6267.9686601567155;6269.122322874801;6283.968580157116;6290.654014029226;6266.905996410058;6269.937300627026;6273.937260627426;6275.592086514362;6299.433051025429;5607.7476513556985;5729.054705973551;5741.368449470555;5798.884022319572;5817.534597232211;6191.288001879751;6208.192934918432;6249.0938813871735;6293.559450838489;6297.275813281532;6185.288691800411;6188.319284878659;6191.442770150708;6200.968995155085;6203.2245969253845;6135.11040899076;6193.783217587363;6211.534134939898;6273.843153921189;6292.119103325538;5123.795048198031;6117.380029168308;6128.233970753656;6167.722452489649;6175.84560385985;6189.8452538686;6263.906041409383;6265.248170219603;6268.1851359323;6275.717592708339;4937.770428824684;4999.625028122905;5002.449730529639;5010.649254552146;5020.3724534433195;4384.364267181241;4401.163778882003;4405.647548196201;4417.757023363682;4475.552444755564;5795.710214489259;5835.591508594358;5875.529957603381;5885.293764748258;5907.113932910098;6092.51259899207;6122.8251069701855;6146.647737497743;6183.84540386494;6205.968970155121;5733.885322293614;5746.683932383676;5751.1085781703905;5793.159991801165;5810.82567522975;5481.205225242317;5496.862578435491;5498.5876059295715;5498.697571633518;5507.944920550824;6142.78500252498;6152.723127459365;6161.106639537153;6196.039613859859;6255.280642726145;6164.229471316085;6182.1345011697495;6183.319834818257;6186.721597528212;6189.35011823752;5421.7560209791445;6263.4362907338555;6271;6297.338779428277;6299;4153.563875793119;5525.756704741401;6074.757009719739;6153.554199418753;6184.474319682878;5274.578033757213;5649.322081350264;6214.627122372672;6247.531435142473;6248.250209974832;6032.517398608188;6062.90905636407;6068.848278793065;6080.69596520181;6081.27024757032;5963.671998040149;6003.249593800775;6152.261728592597;6169.383061693795;6179.721912513858;5861.912071318849;5912.911306330322;5918.260217472816;5950.047992321381;5999.070144127667;5036.571891389126;6101.145839582373;6108.51131909455;6112.969435152796;6126.203593532812;5768.451997060272;5982.611130276518;5986.102084687332;6003.159557661844;6095.299040610209 09:15:51 INFO - PROCESS | 1636 | |1;ext.html;465.2346889366991;470.804616084325;471.2860017074132;471.2860017074132;520.8177138001697;31696.841515792417;41731.374029389546;43165.99999999996;43233.78383108088;43333.566664333346;43956.12087758243;44307;44432.77783611086;44475.55524444755;44683.55316446834;8579.52812595307;9346.252299816015;9528.333016688835;9540.475273859935;9545.61817527298;8539.615717292736;11437.313761174315;11706.707332316717;11711.765764684702;11732;11655.592054278102;11706.356150411766;11727.17909746318;11751.823722644167;11758.294502329887;8601.483910965362;8801.427907186013;11727.648170554854;11781.41092945358;11798.528058877591;11317.83023254652;11576.826347604792;11616.88383116175;11800.881991180064;11830.822537661941;42282.15435691269;42570.14859702789;42579.36130958038;42622.57377426217;42711.145777084595;3653.2876089162623;3660.4875317455576;3738.6822120119823;3745.1573395985956;3897.8051097445014;28286.858565707247;28306.433871322457;28345.433091338266;28680.713192868014;28796.280092997633;3145.7640676949322;3221.4201443740117;3360.059183428644;3380.9492857607156;3382.729381649462;429513;481607;482046.9999999965;484313;485154;58929;59353.70323148357;59431;59439.70280148571;59481.70259148763;62108.68945655243;62266.68866655638;62302.81940132074;62359;62411.37588624146;15577.532674019798;15586.610334741496;15598.220088995506;16077.196140192944;16101.919490402473;11316.434178291218;11582.36297003673;11588.188826782045;12687.873121268854;12784.61646150617;16142.19289035567;16282.348706051862;16359;18519.814801851808;18881.96149211779;7712.614369281513;7832.882506762403;7843.882341764878;7865.331446827084;7929.1277959424415;857.3227150550995;880.5729221327651;885.6280362247871;893.2541327991071;915.1214833759532;30293.69706302953;30712;30733;30766.76932922658;31300;917.0783362720557;980.9607615695435;1057.2546354819833;1069.6149386220955;1103.5916710817048;15493.612659683373;15806.20968951548;15912.92043539798;15925.030471357119;16244.431444899608;599032;606383;607013;607958.56227907;608689;63793.68103159455;64374;64419;64460.677696611216;64592;1410.6614412540916;1433.254707552067;1445.4244873088385;1452.7167202395642;1453.6438572549794;28445.573316400685;29624.111276661733;29978.70021299759;30073.248168795955;30570.847145764128;49058.75470622624;49293;54019;54080.72959635177;54180.72909635427;509213;509641;509877;510000;510796;27110;27405.31486712848;27704.584431233143;27738.5839212416;27793.722062779114;40971.79514102411;41519;47677.76161119172;49545.752271238416;50500;36919.26161476809;37505;37595.06012349713;37844.810775945945;38695.93692662343;31877.20306992344;34676;36405.63594364023;36554.81722591476;37496.81251593724;36269.27461450809;36792.63207367892;36812.44781328336;37019.44470832886;37085;31173.53239701452;32616.510752339207;33253;33330.66669333276;33332.83333583413;24312.784360782243;24644.890979905587;24798.752012479643;25148.74851251464;25237 09:15:51 INFO - PROCESS | 1636 | |2;jquery.html;396.32624538284915;398.12809946217783;403.8384646141545;408.6893960589951;427.9208346455906;16733.414330498435;20206.595868082648;21134.048967796447;21349.252776152836;21626.89186554069;21121.47196320093;21153.259635912746;21480.355589332306;22099.779002209973;22314.88842555789;5647.604667673275;5959.225300710901;5961.701914904237;5965.970170149165;5977;5721.170430287606;5863;5976.521878249751;5993.970030149843;6058.061000544901;6090.451859332659;6102.206713127287;6106.816795496142;6113.388661133873;6114.877702445949;5934.643921364732;6438.484921206292;6521.184851893513;6525.836854078639;6536.411722944958;5680.176374425727;5749.741261643236;5799.594028418012;5838.737256823453;5853.385394533555;13389;13565.050446468751;13659.795103073462;13785.655358616015;13790.310484475736;2520.3195137313005;2599.766021058095;2619.5677713177492;2637.7757890579323;2647.6160956661174;10038.347507411994;10064.29549931505;10232.334898231591;10542.051215390651;10576.259661823675;1763.356374923144;1830.1398342778873;1830.2404502131599;1831.8351348378576;1837.9172937217857;128495;130190;137782;139930.90103648455;141475.29262353724;11611.88388116108;12015.279083254858;12028.518859245532;12037;12046.216995895415;13134.146280491737;15512.534623961299;16061.437849675205;16067.11630860314;16115.919420402823;7285.4171666266575;8819.647214111492;8947.776305592412;8976.640934362684;9050.004499505048;8738.820259265045;8753.606087726068;8755.124487551195;8880.023197448276;8903.688370906988;3958.5645578986287;4830.541098595628;4831.347768051268;4832.855014349575;4895.779689913891;1987.7217189593468;2032.2606404216313;2033.2070492507933;2035.3792093411355;2043.3665563675308;851.5912362066243;884.2704768565959;889.6610601045385;895.9507227102572;916.5234078279391;20282.290119845733;21135.471613209484;21177.699828345336;21230.36308910735;21331.040103195395;855.1918437076903;912.1516989199976;936.0156468287274;941.7975135345933;943.1605870775015;8674.522901240367;10333.18918166595;10364.170866330676;10896.564137434414;10904.836427453594;737228;745700;749477;750897;768916;84813;112289.4385528067;120650;121823.39088304502;152089.23955380372;962.2542529539663;998.2463240253562;999.7850462150527;1002.2733518199248;1003.513296051429;18995.620087597894;19383.903080484506;19747.703784442958;19761.505962351057;19770.209191632173;54840.45159548354;55659;56313.43686563246;56705.71647141903;57065.00272490443;68455;81026;83953;84206;85035.1496485052;8121.35029197651;8239.134890836376;8310.667573297;8374.246317831425;8513.19124683154;12152.57465988686;12493.75012499763;12817.935910320388;12868.935655321664;13098.410571524495;8332.625031873458;10718.24972251966;10805.135589153006;11016.449177540931;11329.320240785579;10984.395858227874;11013.559457621606;11322.26405283654;11347.205695601559;11489.310641361544;11128.054115400282;11205.551777928791;11248.325100493996;11355.943220283845;11587.768244634892;8077.27304542594;8095.907052547831;8334.333253339839;8478.57607119654;8655.09121542229;10316.48417579103;10674.985876341736;10927.45362731876;11272.380019099028;11619.419029048344 09:15:51 INFO - PROCESS | 1636 | |3;mootools.html;1436.9634431318227;1437.7340192064469;1442.141925554295;1459.8175228096488;1460.0144902191018;8018.639161237744;8440.409171358007;8443.831123377537;8453.281471074959;8465.195806398398;7381.077365329334;7670.578118203496;7672.961635191817;8027.117017128126;8240.83518329633;2307.100230909942;2328.650702394646;2361.7047869016374;2365;2366.290112966112;2343.4375749820006;2357.5049239659693;2377.061060880951;2382.9642555361684;2390.629452434867;2030.8984550772477;2115.4499830044224;2117.3859580721573;2269.6255117905525;2350.788429041386;2333.591621466245;2357.9410514737096;2360.9645855312183;2361.8464799787957;2362.5629258587214;2301.137073597401;2380.2264264114233;2380.7262164850918;2382.321038504018;2384.0582969727034;7048.18945821232;8352.83294334116;8406.78983025423;8418.579071046484;8429.409941304111;5140.74296285188;5300.708461034642;5302.469753024705;5302.946970530284;5317.893642127175;3323.3851737428654;3395.507651390559;3522.0138361258887;3575.481555174485;3597.982010089933;1233.9814902776466;1277.8594354620984;1725.9223334949957;1760.586262228388;1831.78018637763;10455.424951627658;10639.787204255948;10762.892371076266;10771.5691372345;10779.946100269448;4469.5530446955045;4522.29904364824;4575.748333841604;4576.153411618861;4587.151376995266;8719.564021798884;8722.912770872337;8723.476591404537;8728.78178045554;8733.781655458664;5178.249153872667;5186.351706036746;5188.092083885381;5193.818216362409;5206.323177986837;4762.071396077731;4769.6661233714;4826.831060912851;4882.829100981448;4886.340344053508;3490.5636795400574;3613.837377318027;3637.2907283079544;3665.047087757149;3681.9079523012138;1159.1769843411105;1164.889335513125;1165.1494409081417;1173.6420391780418;1175.9588414405455;711.9038929744419;762.8054846014231;764.3846703403814;778.6807408962298;849.9885136687323;4625.923760699097;5327.786888524493;5414.40441551429;5418.8916221675345;5623.887522249532;811.8457493076297;926.3978414030934;975.2782940623887;980.7008862296925;1008.7931973945324;3580.5524309461316;3656.4149736042637;3749.812509374575;3784.9810750946067;3799.3920972644796;9475.526223688788;9845.360051596623;10028.398296102258;10097.394156350643;10103.989601039984;9535.38020028696;9949.204063674888;10010.499475026365;10019.949900250453;10028;7331.340179383881;7597.3162415382885;7606.733764318223;7608.972788673569;7632.427567932427;5367.624266301322;5408.621396502207;5479.945200547943;5628;5727.284089488814;8950.865737013819;9046.728598142066;9231;9326.95336523313;9364.531773411167;9270.53647317618;9438.292128090558;9480.194183494481;9531.809363812547;9639.9036009639;6116.541259405473;7076.0801095857205;7154;7296.854062918605;7306.232845551141;7679.155292917886;7812.1797211292;7864.370850332074;7867.449278550446;7874.724384646739;7085.114360704912;7144.749933752294;7192.065031545865;7203.71185152609;7317.341439270491;7062.435005199469;7077.363037326665;7082.504224704221;7107.324804143598;7125.216226215216;6269.216347956505;6328.968355158195;6406.519511036598;6409.615423074631;6428.971364581645;4898.9020219594695;4909.018196360671;4941.752912354296;4960.280759289811;4982.5764809990105;4833.250846118857;4854.417469903634;4907.779149938333;4965.751712414292;5026.447090819934 09:15:51 INFO - PROCESS | 1636 | |4;prototype.html;350.05834305717616;358.673607017614;361.59862552566653;372.77819697280125;375.21205468516104;4671.906561868765;5051.621128415365;5319.388270348911;5356.232443293714;5389.838304850856;4576.354999675332;5082;5136.943518606433;5206.609504287175;5224.4775522447735;3991.1419044905338;4076.8369265229353;4126.172378317361;4158.729682570638;4174.41558181854;4148.460700108982;4150.3566947123245;4171.395147703581;4174.394712766662;4180.665546756252;3729.962700372989;3960.544537378195;3975.5030621172355;4002.679785617144;4037.9596204037875;3953.3476976298875;3967.940480892789;3971.205758848242;3971.2653159165648;3983.721139520235;3063.5098384258413;3359.277755282626;3466.6013408457848;3482.407990641597;3489;4661.417322834645;4797.352357431737;4841.111966333133;5120.871978200575;5185.403678576974;3776.9613356326954;3851.9229615407817;4503.446311022692;4580.335851301543;4604.674639307162;5352.63507805511;5606.551475881961;5608.383077861432;5613.775448982035;5629.662220266756;2925.5319148936283;3252.7151775048724;3841.80903919783;3842.4812650292133;3879.1853710720784;4942.728149951751;5245.685258884441;5624.184493248497;5844.47399734026;5860.443257890493;3162.76279279055;3848.2688289224957;3855.691544676419;3867.9806600966817;3888.5528164260904;3341.9614035438362;3364.9327013459592;3932.2135572885536;3944.225098705594;3951.940720889189;3685.3919103348185;3809.542854857435;4544.84120042977;4561.338605902192;4625.814967401334;5604.747786349624;5606.365008446024;5622.437756224344;5626.2967129108865;5661.433856614306;1043.8068957242933;1119.2277328643372;1142.9199956003;1169.2925779903205;1216.8804699676318;758.2720588235355;817.7301490508119;834.7753237621791;840.6049156896249;866.921977022071;4294.957050429518;4693.436787585511;5005.246065450911;5039.546440820343;5065.442801291855;5086.415062267813;5300.496452836975;5301.946980530222;5504.669719816824;5529.834104976857;4272.230998420252;4371.650267978554;4720.0087981523575;4826.276058591239;4983.25251212321;2396.5206958608346;2856.7857410694282;2863.527517959555;2899.318395330703;2902.9114082219166;4888.828890988798;5433.049216387117;5484.972575137179;5539.556835453154;5698.635066447461;4550;4871.780769865364;5133;5484.860904247346;5535;4779.737114458738;5505.724713764296;5612.915806262991;5654.802081927195;5685.346185188673;4742.857714268577;5015.448300686994;5263.526072792092;5368.865778355573;5427.185922111715;4999.600031997359;5035.571976382049;5367.470270972754;5371.334886185295;5422.376426710979;5167.682241028664;5284.327392462202;5299.284596579567;5335.639411949928;5575.1915972183;3195.8242296672975;3494.371013217645;3678.485012098362;3839.7745893449637;3882.495275614152;4972.3535940328975;5301.522862942354;5560.944390556205;5768.192453056491;5781.5428442912435;5125.847144199371;5594.748236329294;5606.467385598362;5610.541259272537;5634.88730225385;5202.3497062867145;5368.865778355573;5536.390996990408;5571.749271282721;5598.412166722598;4550.88622784433;4856.203204814241;5127.820526281562;5342.183657556449;5423.674579525241;4819.072371051608;5118.462561431145;5416.560484092551;5507.9449205507435;5537.781688028627;4849.2726091086615;5111.881752131271;5402.51377376038;5419.916016796577;5467 09:15:51 INFO - PROCESS | 1636 | |5;yui.html;704.503325155765;760.9353204977576;814.9225823546763;819.1726356380054;828.6975254032276;15278.618034549141;15881.444149454772;15918.52244432666;15927.964682295642;15958.84041159588;14339;14517;14519.854801451982;14527.92736036321;14535.854641453583;663.7809522857445;683.692338447698;687.1204857782047;835.3150416658343;865.4374656473311;855.4525103933456;870.0733718589681;870.6038752367689;870.6865528409768;870.7039606533777;920.9263258939302;922.8385032619299;923.1368670293298;923.3351986569659;923.6213152607432;712.803978905805;734.9742759003462;741.1550832051465;917.8485549884261;919.8528235482324;548.1968915538755;548.3775914337216;620.9472194863442;677.7187467201105;685.4790359326947;14715.337809798584;14947.177905215318;15028.549143525712;15074;15075.246237688181;12980.480780768758;13052.412641431063;13150.145240559334;13901.304934753221;14431.855681443156;12853.357332133355;12874.227546347156;12973.091883568153;13079.934600327033;13224;4292.270314046588;4394.736315821061;4460.50934397216;4522.3216517522305;4660.627149828006;101546.49226753892;103590;105849.47075264575;106879;107894.46052769765;10428.634997775041;10753.677389678322;10921.344719316867;11167.329960202414;11619.128565357632;21121.155153793676;21160.894195528923;21402.357929262147;21480.033398497104;21523.354299371043;7303.89044164338;7454.180040195574;7480.251974802585;7742.961285193538;7918.683252669829;4154.589371980688;4280.357946308017;4346.700133468812;4353.25994580922;4388.846390376385;3088.660247372787;3311.122552523583;3312.7184189343693;3358.026172410023;3392.6776956189124;656.7569999100364;660.7654282729658;660.7918505670698;663.6781161136845;674.7975607317785;442.82508409178195;537.5887446103734;547.1956224350199;554.8585110796721;575.1258087706746;9574.569144388519;9725.513724313756;9744.90255097454;9845.45849978258;9917.256205784595;625.43710660406;644.8645784385332;663.4824836627438;663.7743167323036;666.9233038200572;4636.466806317249;4647.09381670571;4698.929516057262;4712.198926182557;4761.35721677576;91590.62614060794;106596;106958;107011.4649426748;107040;92415;95747.52126239325;95752.52123739476;97948.02051979389;99282.00717992873;80864;80919.59540202262;81650.18349816544;83593;84291.7356239657;8986.460812351279;9140.131687489678;9158.038405967543;9162.31282653817;9171.266298695955;53303.73348133235;53442.93114137773;54545.72727136498;55617.72191139018;56104.15843762428;70863.58272834617;72021.27978720146;72499.63750181426;75311.49377012538;75615;9701;10881.564737410416;10919.45702261091;11296.83054754163;11300.605674211069;11839.230450020721;11997.76004479923;12128.332941688292;12185.69535761613;12213.511459541518;10829.512671929624;11024.228304018963;11637.650870473899;11664.533418663159;11742.119341049627;10320.896791031993;11139.610113645984;13005.154664946747;13596.388162532512;13987.950903682467;10038.749031274276;12837.550685726328;13427.395767190696;13695.315234238049;13913.791293130409;9895.950520247352;10772.784544309226;10916.707491426889;11166.994970452699;11180.273282236629;10874.945625271823;10955.56177752881;10958.780824383308;10967.396793176453;10993 09:15:51 INFO - PROCESS | 1636 | __end_tp_report 09:15:51 INFO - PROCESS | 1636 | __start_cc_report 09:15:51 INFO - PROCESS | 1636 | _x_x_mozilla_cycle_collect,1402 09:15:51 INFO - PROCESS | 1636 | __end_cc_report 09:15:51 INFO - PROCESS | 1636 | __startTimestamp1487178951463__endTimestamp 09:15:51 INFO - PROCESS | 1636 | 09:15:51 INFO - PROCESS | 1636 | ------- Summary: start ------- 09:15:51 INFO - PROCESS | 1636 | Number of tests: 6 09:15:51 INFO - PROCESS | 1636 | 09:15:51 INFO - PROCESS | 1636 | [#0] dojo.html Cycles:165 Average:5703.15 Median:5885.29 stddev:653.40 (11.1%) stddev-sans-first:618.08 09:15:51 INFO - PROCESS | 1636 | Values: 2927.9 3319.7 3340.7 3341.0 3365.5 5658.8 5696.7 5696.7 5701.0 5706.4 5657.6 5764.6 5770.2 5775.0 5783.9 5246.9 5281.0 5292.1 5302.1 5344.2 4265.3 5187.8 5194.7 5352.1 5360.3 5216.4 5224.6 5229.8 5281.7 5297.0 5235.4 5254.7 5278.0 5280.1 5300.5 5153.9 5219.6 5237.1 5257.8 5295.4 5553.3 5569.0 5592.7 5594.9 5639.6 6216.8 6268.0 6269.1 6284.0 6290.7 6266.9 6269.9 6273.9 6275.6 6299.4 5607.7 5729.1 5741.4 5798.9 5817.5 6191.3 6208.2 6249.1 6293.6 6297.3 6185.3 6188.3 6191.4 6201.0 6203.2 6135.1 6193.8 6211.5 6273.8 6292.1 5123.8 6117.4 6128.2 6167.7 6175.8 6189.8 6263.9 6265.2 6268.2 6275.7 4937.8 4999.6 5002.4 5010.6 5020.4 4384.4 4401.2 4405.6 4417.8 4475.6 5795.7 5835.6 5875.5 5885.3 5907.1 6092.5 6122.8 6146.6 6183.8 6206.0 5733.9 5746.7 5751.1 5793.2 5810.8 5481.2 5496.9 5498.6 5498.7 5507.9 6142.8 6152.7 6161.1 6196.0 6255.3 6164.2 6182.1 6183.3 6186.7 6189.4 5421.8 6263.4 6271.0 6297.3 6299.0 4153.6 5525.8 6074.8 6153.6 6184.5 5274.6 5649.3 6214.6 6247.5 6248.3 6032.5 6062.9 6068.8 6080.7 6081.3 5963.7 6003.2 6152.3 6169.4 6179.7 5861.9 5912.9 5918.3 5950.0 5999.1 5036.6 6101.1 6108.5 6113.0 6126.2 5768.5 5982.6 5986.1 6003.2 6095.3 09:15:51 INFO - PROCESS | 1636 | 09:15:51 INFO - PROCESS | 1636 | [#1] ext.html Cycles:180 Average:67159.82 Median:36969.35 stddev:141914.39 (383.9%) stddev-sans-first:142224.15 09:15:51 INFO - PROCESS | 1636 | Values: 465.2 470.8 471.3 471.3 520.8 31696.8 41731.4 43166.0 43233.8 43333.6 43956.1 44307.0 44432.8 44475.6 44683.6 8579.5 9346.3 9528.3 9540.5 9545.6 8539.6 11437.3 11706.7 11711.8 11732.0 11655.6 11706.4 11727.2 11751.8 11758.3 8601.5 8801.4 11727.6 11781.4 11798.5 11317.8 11576.8 11616.9 11800.9 11830.8 42282.2 42570.1 42579.4 42622.6 42711.1 3653.3 3660.5 3738.7 3745.2 3897.8 28286.9 28306.4 28345.4 28680.7 28796.3 3145.8 3221.4 3360.1 3380.9 3382.7 429513.0 481607.0 482047.0 484313.0 485154.0 58929.0 59353.7 59431.0 59439.7 59481.7 62108.7 62266.7 62302.8 62359.0 62411.4 15577.5 15586.6 15598.2 16077.2 16101.9 11316.4 11582.4 11588.2 12687.9 12784.6 16142.2 16282.3 16359.0 18519.8 18882.0 7712.6 7832.9 7843.9 7865.3 7929.1 857.3 880.6 885.6 893.3 915.1 30293.7 30712.0 30733.0 30766.8 31300.0 917.1 981.0 1057.3 1069.6 1103.6 15493.6 15806.2 15912.9 15925.0 16244.4 599032.0 606383.0 607013.0 607958.6 608689.0 63793.7 64374.0 64419.0 64460.7 64592.0 1410.7 1433.3 1445.4 1452.7 1453.6 28445.6 29624.1 29978.7 30073.2 30570.8 49058.8 49293.0 54019.0 54080.7 54180.7 509213.0 509641.0 509877.0 510000.0 510796.0 27110.0 27405.3 27704.6 27738.6 27793.7 40971.8 41519.0 47677.8 49545.8 50500.0 36919.3 37505.0 37595.1 37844.8 38695.9 31877.2 34676.0 36405.6 36554.8 37496.8 36269.3 36792.6 36812.4 37019.4 37085.0 31173.5 32616.5 33253.0 33330.7 33332.8 24312.8 24644.9 24798.8 25148.7 25237.0 09:15:51 INFO - PROCESS | 1636 | 09:15:51 INFO - PROCESS | 1636 | [#2] jquery.html Cycles:180 Average:39444.95 Median:2609.67 stddev:124335.99 (4764.4%) stddev-sans-first:124650.21 09:15:51 INFO - PROCESS | 1636 | Values: 396.3 398.1 403.8 408.7 427.9 16733.4 20206.6 21134.0 21349.3 21626.9 21121.5 21153.3 21480.4 22099.8 22314.9 5647.6 5959.2 5961.7 5966.0 5977.0 5721.2 5863.0 5976.5 5994.0 6058.1 6090.5 6102.2 6106.8 6113.4 6114.9 5934.6 6438.5 6521.2 6525.8 6536.4 5680.2 5749.7 5799.6 5838.7 5853.4 13389.0 13565.1 13659.8 13785.7 13790.3 2520.3 2599.8 2619.6 2637.8 2647.6 10038.3 10064.3 10232.3 10542.1 10576.3 1763.4 1830.1 1830.2 1831.8 1837.9 128495.0 130190.0 137782.0 139930.9 141475.3 11611.9 12015.3 12028.5 12037.0 12046.2 13134.1 15512.5 16061.4 16067.1 16115.9 7285.4 8819.6 8947.8 8976.6 9050.0 8738.8 8753.6 8755.1 8880.0 8903.7 3958.6 4830.5 4831.3 4832.9 4895.8 1987.7 2032.3 2033.2 2035.4 2043.4 851.6 884.3 889.7 896.0 916.5 20282.3 21135.5 21177.7 21230.4 21331.0 855.2 912.2 936.0 941.8 943.2 8674.5 10333.2 10364.2 10896.6 10904.8 737228.0 745700.0 749477.0 750897.0 768916.0 84813.0 112289.4 120650.0 121823.4 152089.2 962.3 998.2 999.8 1002.3 1003.5 18995.6 19383.9 19747.7 19761.5 19770.2 54840.5 55659.0 56313.4 56705.7 57065.0 68455.0 81026.0 83953.0 84206.0 85035.1 8121.4 8239.1 8310.7 8374.2 8513.2 12152.6 12493.8 12817.9 12868.9 13098.4 8332.6 10718.2 10805.1 11016.4 11329.3 10984.4 11013.6 11322.3 11347.2 11489.3 11128.1 11205.6 11248.3 11355.9 11587.8 8077.3 8095.9 8334.3 8478.6 8655.1 10316.5 10675.0 10927.5 11272.4 11619.4 09:15:51 INFO - PROCESS | 1636 | 09:15:51 INFO - PROCESS | 1636 | [#3] mootools.html Cycles:180 Average:5389.15 Median:5187.22 stddev:2903.40 (56.0%) stddev-sans-first:2896.35 09:15:51 INFO - PROCESS | 1636 | Values: 1437.0 1437.7 1442.1 1459.8 1460.0 8018.6 8440.4 8443.8 8453.3 8465.2 7381.1 7670.6 7673.0 8027.1 8240.8 2307.1 2328.7 2361.7 2365.0 2366.3 2343.4 2357.5 2377.1 2383.0 2390.6 2030.9 2115.4 2117.4 2269.6 2350.8 2333.6 2357.9 2361.0 2361.8 2362.6 2301.1 2380.2 2380.7 2382.3 2384.1 7048.2 8352.8 8406.8 8418.6 8429.4 5140.7 5300.7 5302.5 5302.9 5317.9 3323.4 3395.5 3522.0 3575.5 3598.0 1234.0 1277.9 1725.9 1760.6 1831.8 10455.4 10639.8 10762.9 10771.6 10779.9 4469.6 4522.3 4575.7 4576.2 4587.2 8719.6 8722.9 8723.5 8728.8 8733.8 5178.2 5186.4 5188.1 5193.8 5206.3 4762.1 4769.7 4826.8 4882.8 4886.3 3490.6 3613.8 3637.3 3665.0 3681.9 1159.2 1164.9 1165.1 1173.6 1176.0 711.9 762.8 764.4 778.7 850.0 4625.9 5327.8 5414.4 5418.9 5623.9 811.8 926.4 975.3 980.7 1008.8 3580.6 3656.4 3749.8 3785.0 3799.4 9475.5 9845.4 10028.4 10097.4 10104.0 9535.4 9949.2 10010.5 10019.9 10028.0 7331.3 7597.3 7606.7 7609.0 7632.4 5367.6 5408.6 5479.9 5628.0 5727.3 8950.9 9046.7 9231.0 9327.0 9364.5 9270.5 9438.3 9480.2 9531.8 9639.9 6116.5 7076.1 7154.0 7296.9 7306.2 7679.2 7812.2 7864.4 7867.4 7874.7 7085.1 7144.7 7192.1 7203.7 7317.3 7062.4 7077.4 7082.5 7107.3 7125.2 6269.2 6329.0 6406.5 6409.6 6429.0 4898.9 4909.0 4941.8 4960.3 4982.6 4833.3 4854.4 4907.8 4965.8 5026.4 09:15:51 INFO - PROCESS | 1636 | 09:15:51 INFO - PROCESS | 1636 | [#4] prototype.html Cycles:180 Average:4392.43 Median:4957.54 stddev:1347.67 (27.2%) stddev-sans-first:1316.86 09:15:51 INFO - PROCESS | 1636 | Values: 350.1 358.7 361.6 372.8 375.2 4671.9 5051.6 5319.4 5356.2 5389.8 4576.4 5082.0 5136.9 5206.6 5224.5 3991.1 4076.8 4126.2 4158.7 4174.4 4148.5 4150.4 4171.4 4174.4 4180.7 3730.0 3960.5 3975.5 4002.7 4038.0 3953.3 3967.9 3971.2 3971.3 3983.7 3063.5 3359.3 3466.6 3482.4 3489.0 4661.4 4797.4 4841.1 5120.9 5185.4 3777.0 3851.9 4503.4 4580.3 4604.7 5352.6 5606.6 5608.4 5613.8 5629.7 2925.5 3252.7 3841.8 3842.5 3879.2 4942.7 5245.7 5624.2 5844.5 5860.4 3162.8 3848.3 3855.7 3868.0 3888.6 3342.0 3364.9 3932.2 3944.2 3951.9 3685.4 3809.5 4544.8 4561.3 4625.8 5604.7 5606.4 5622.4 5626.3 5661.4 1043.8 1119.2 1142.9 1169.3 1216.9 758.3 817.7 834.8 840.6 866.9 4295.0 4693.4 5005.2 5039.5 5065.4 5086.4 5300.5 5301.9 5504.7 5529.8 4272.2 4371.7 4720.0 4826.3 4983.3 2396.5 2856.8 2863.5 2899.3 2902.9 4888.8 5433.0 5485.0 5539.6 5698.6 4550.0 4871.8 5133.0 5484.9 5535.0 4779.7 5505.7 5612.9 5654.8 5685.3 4742.9 5015.4 5263.5 5368.9 5427.2 4999.6 5035.6 5367.5 5371.3 5422.4 5167.7 5284.3 5299.3 5335.6 5575.2 3195.8 3494.4 3678.5 3839.8 3882.5 4972.4 5301.5 5560.9 5768.2 5781.5 5125.8 5594.7 5606.5 5610.5 5634.9 5202.3 5368.9 5536.4 5571.7 5598.4 4550.9 4856.2 5127.8 5342.2 5423.7 4819.1 5118.5 5416.6 5507.9 5537.8 4849.3 5111.9 5402.5 5419.9 5467.0 09:15:51 INFO - PROCESS | 1636 | 09:15:51 INFO - PROCESS | 1636 | [#5] yui.html Cycles:180 Average:20845.31 Median:4491.42 stddev:30591.04 (681.1%) stddev-sans-first:30639.48 09:15:51 INFO - PROCESS | 1636 | Values: 704.5 760.9 814.9 819.2 828.7 15278.6 15881.4 15918.5 15928.0 15958.8 14339.0 14517.0 14519.9 14527.9 14535.9 663.8 683.7 687.1 835.3 865.4 855.5 870.1 870.6 870.7 870.7 920.9 922.8 923.1 923.3 923.6 712.8 735.0 741.2 917.8 919.9 548.2 548.4 620.9 677.7 685.5 14715.3 14947.2 15028.5 15074.0 15075.2 12980.5 13052.4 13150.1 13901.3 14431.9 12853.4 12874.2 12973.1 13079.9 13224.0 4292.3 4394.7 4460.5 4522.3 4660.6 101546.5 103590.0 105849.5 106879.0 107894.5 10428.6 10753.7 10921.3 11167.3 11619.1 21121.2 21160.9 21402.4 21480.0 21523.4 7303.9 7454.2 7480.3 7743.0 7918.7 4154.6 4280.4 4346.7 4353.3 4388.8 3088.7 3311.1 3312.7 3358.0 3392.7 656.8 660.8 660.8 663.7 674.8 442.8 537.6 547.2 554.9 575.1 9574.6 9725.5 9744.9 9845.5 9917.3 625.4 644.9 663.5 663.8 666.9 4636.5 4647.1 4698.9 4712.2 4761.4 91590.6 106596.0 106958.0 107011.5 107040.0 92415.0 95747.5 95752.5 97948.0 99282.0 80864.0 80919.6 81650.2 83593.0 84291.7 8986.5 9140.1 9158.0 9162.3 9171.3 53303.7 53442.9 54545.7 55617.7 56104.2 70863.6 72021.3 72499.6 75311.5 75615.0 9701.0 10881.6 10919.5 11296.8 11300.6 11839.2 11997.8 12128.3 12185.7 12213.5 10829.5 11024.2 11637.7 11664.5 11742.1 10320.9 11139.6 13005.2 13596.4 13988.0 10038.7 12837.6 13427.4 13695.3 13913.8 9896.0 10772.8 10916.7 11167.0 11180.3 10874.9 10955.6 10958.8 10967.4 10993.0 09:15:51 INFO - PROCESS | 1636 | -------- Summary: end -------- 09:15:51 INFO - PROCESS | 1636 | 09:15:52 INFO - TEST-INFO | 1636: exit 0 09:15:52 INFO - TEST-OK | dromaeo_css | took 1118967ms 09:15:52 INFO - TEST-START | kraken 09:15:52 INFO - operating with platform_type : mac_ 09:15:52 INFO - Initialising browser for kraken test... 09:15:52 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpyC0juI/profile http://localhost:49241/getInfo.html) 09:15:54 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 09:15:54 INFO - PROCESS | 1645 | colorDepth:24 09:15:54 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 09:15:54 INFO - PROCESS | 1645 | __metrics 09:15:54 INFO - PROCESS | 1645 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:15:54 INFO - PROCESS | 1645 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:15:55 INFO - TEST-INFO | 1645: exit 0 09:15:55 INFO - Browser initialized. 09:15:55 INFO - Running cycle 1/1 for kraken test... 09:15:55 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpyC0juI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:16:07 INFO - PROCESS | 1646 | RSS: Main: 213716992 09:16:07 INFO - PROCESS | 1646 | 09:16:10 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 09:16:10 INFO - PROCESS | 1646 | RSS: Main: 266293248 09:16:10 INFO - PROCESS | 1646 | 09:16:13 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 09:16:14 INFO - PROCESS | 1646 | RSS: Main: 276344832 09:16:14 INFO - PROCESS | 1646 | 09:16:17 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 09:16:17 INFO - PROCESS | 1646 | RSS: Main: 374677504 09:16:17 INFO - PROCESS | 1646 | 09:16:19 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 09:16:20 INFO - PROCESS | 1646 | RSS: Main: 277381120 09:16:20 INFO - PROCESS | 1646 | 09:16:22 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:16:22 INFO - PROCESS | 1646 | RSS: Main: 278990848 09:16:22 INFO - PROCESS | 1646 | 09:16:25 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 09:16:26 INFO - PROCESS | 1646 | RSS: Main: 318828544 09:16:26 INFO - PROCESS | 1646 | 09:16:29 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 09:16:29 INFO - PROCESS | 1646 | RSS: Main: 321425408 09:16:29 INFO - PROCESS | 1646 | 09:16:32 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 09:16:33 INFO - PROCESS | 1646 | RSS: Main: 318910464 09:16:33 INFO - PROCESS | 1646 | 09:16:34 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:16:35 INFO - PROCESS | 1646 | RSS: Main: 295378944 09:16:35 INFO - PROCESS | 1646 | 09:16:37 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:16:38 INFO - PROCESS | 1646 | RSS: Main: 298520576 09:16:38 INFO - PROCESS | 1646 | 09:16:40 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:16:40 INFO - PROCESS | 1646 | RSS: Main: 299950080 09:16:40 INFO - PROCESS | 1646 | 09:16:43 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:16:44 INFO - PROCESS | 1646 | RSS: Main: 313794560 09:16:44 INFO - PROCESS | 1646 | 09:16:47 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:16:48 INFO - PROCESS | 1646 | RSS: Main: 308166656 09:16:48 INFO - PROCESS | 1646 | 09:16:49 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 09:16:50 INFO - PROCESS | 1646 | RSS: Main: 352841728 09:16:50 INFO - PROCESS | 1646 | 09:16:50 INFO - PROCESS | 1646 | __start_tp_report 09:16:50 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 09:16:50 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 09:16:50 INFO - PROCESS | 1646 | |i|pagename|runs| 09:16:50 INFO - PROCESS | 1646 | |0;ai-astar;114;111;112;113;116;129;112;114;111;112 09:16:50 INFO - PROCESS | 1646 | |1;audio-beat-detection;141;110;107;145;108;110;107;109;127;109 09:16:50 INFO - PROCESS | 1646 | |2;audio-dft;186;184;185;184;182;185;186;183;182;183 09:16:50 INFO - PROCESS | 1646 | |3;audio-fft;85;59;59;88;60;59;58;57;75;58 09:16:50 INFO - PROCESS | 1646 | |4;audio-oscillator;87;71;86;69;69;68;80;67;67;81 09:16:50 INFO - PROCESS | 1646 | |5;imaging-gaussian-blur;86;83;86;83;86;83;87;84;85;83 09:16:50 INFO - PROCESS | 1646 | |6;imaging-darkroom;92;92;101;93;93;134;149;93;93;93 09:16:50 INFO - PROCESS | 1646 | |7;imaging-desaturate;85;84;83;107;128;112;87;89;87;87 09:16:50 INFO - PROCESS | 1646 | |8;json-parse-financial;57;52;52;53;54;56;57;56;55;56 09:16:50 INFO - PROCESS | 1646 | |9;json-stringify-tinderbox;64;70;66;73;79;72;70;69;69;69 09:16:50 INFO - PROCESS | 1646 | |10;stanford-crypto-aes;84;83;84;83;80;81;92;78;80;78 09:16:50 INFO - PROCESS | 1646 | |11;stanford-crypto-ccm;138;137;137;137;137;140;139;142;183;149 09:16:50 INFO - PROCESS | 1646 | |12;stanford-crypto-pbkdf2;177;228;205;166;166;168;168;166;166;162 09:16:50 INFO - PROCESS | 1646 | |13;stanford-crypto-sha256-iterative;66;65;66;65;65;65;64;65;64;65 09:16:50 INFO - PROCESS | 1646 | __end_tp_report 09:16:50 INFO - PROCESS | 1646 | __start_cc_report 09:16:50 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,1956 09:16:50 INFO - PROCESS | 1646 | __end_cc_report 09:16:50 INFO - PROCESS | 1646 | __startTimestamp1487179010010__endTimestamp 09:16:50 INFO - PROCESS | 1646 | 09:16:50 INFO - PROCESS | 1646 | ------- Summary: start ------- 09:16:50 INFO - PROCESS | 1646 | Number of tests: 14 09:16:50 INFO - PROCESS | 1646 | 09:16:50 INFO - PROCESS | 1646 | [#0] ai-astar Cycles:10 Average:114.40 Median:113.50 stddev:5.36 (4.7%) stddev-sans-first:5.68 09:16:50 INFO - PROCESS | 1646 | Values: 114.0 111.0 112.0 113.0 116.0 129.0 112.0 114.0 111.0 112.0 09:16:50 INFO - PROCESS | 1646 | 09:16:50 INFO - PROCESS | 1646 | [#1] audio-beat-detection Cycles:10 Average:117.30 Median:110.00 stddev:14.78 (13.4%) stddev-sans-first:12.95 09:16:50 INFO - PROCESS | 1646 | Values: 141.0 110.0 107.0 145.0 108.0 110.0 107.0 109.0 127.0 109.0 09:16:50 INFO - PROCESS | 1646 | 09:16:50 INFO - PROCESS | 1646 | [#2] audio-dft Cycles:10 Average:184.00 Median:184.50 stddev:1.49 (0.8%) stddev-sans-first:1.39 09:16:50 INFO - PROCESS | 1646 | Values: 186.0 184.0 185.0 184.0 182.0 185.0 186.0 183.0 182.0 183.0 09:16:50 INFO - PROCESS | 1646 | 09:16:50 INFO - PROCESS | 1646 | [#3] audio-fft Cycles:10 Average:65.80 Median:59.50 stddev:12.10 (20.3%) stddev-sans-first:10.65 09:16:50 INFO - PROCESS | 1646 | Values: 85.0 59.0 59.0 88.0 60.0 59.0 58.0 57.0 75.0 58.0 09:16:50 INFO - PROCESS | 1646 | 09:16:50 INFO - PROCESS | 1646 | [#4] audio-oscillator Cycles:10 Average:74.50 Median:75.50 stddev:8.09 (10.7%) stddev-sans-first:7.20 09:16:50 INFO - PROCESS | 1646 | Values: 87.0 71.0 86.0 69.0 69.0 68.0 80.0 67.0 67.0 81.0 09:16:50 INFO - PROCESS | 1646 | 09:16:50 INFO - PROCESS | 1646 | [#5] imaging-gaussian-blur Cycles:10 Average:84.60 Median:85.50 stddev:1.58 (1.8%) stddev-sans-first:1.59 09:16:50 INFO - PROCESS | 1646 | Values: 86.0 83.0 86.0 83.0 86.0 83.0 87.0 84.0 85.0 83.0 09:16:50 INFO - PROCESS | 1646 | 09:16:50 INFO - PROCESS | 1646 | [#6] imaging-darkroom Cycles:10 Average:103.30 Median:93.00 stddev:20.61 (22.2%) stddev-sans-first:21.45 09:16:50 INFO - PROCESS | 1646 | Values: 92.0 92.0 101.0 93.0 93.0 134.0 149.0 93.0 93.0 93.0 09:16:50 INFO - PROCESS | 1646 | 09:16:50 INFO - PROCESS | 1646 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:86.00 stddev:15.33 (17.8%) stddev-sans-first:15.84 09:16:50 INFO - PROCESS | 1646 | Values: 85.0 84.0 83.0 107.0 128.0 112.0 87.0 89.0 87.0 87.0 09:16:50 INFO - PROCESS | 1646 | 09:16:50 INFO - PROCESS | 1646 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:56.00 stddev:1.93 (3.5%) stddev-sans-first:1.88 09:16:50 INFO - PROCESS | 1646 | Values: 57.0 52.0 52.0 53.0 54.0 56.0 57.0 56.0 55.0 56.0 09:16:50 INFO - PROCESS | 1646 | 09:16:50 INFO - PROCESS | 1646 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:70.00 stddev:4.07 (5.8%) stddev-sans-first:3.67 09:16:50 INFO - PROCESS | 1646 | Values: 64.0 70.0 66.0 73.0 79.0 72.0 70.0 69.0 69.0 69.0 09:16:50 INFO - PROCESS | 1646 | 09:16:50 INFO - PROCESS | 1646 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:83.00 stddev:4.08 (4.9%) stddev-sans-first:4.28 09:16:50 INFO - PROCESS | 1646 | Values: 84.0 83.0 84.0 83.0 80.0 81.0 92.0 78.0 80.0 78.0 09:16:50 INFO - PROCESS | 1646 | 09:16:50 INFO - PROCESS | 1646 | [#11] stanford-crypto-ccm Cycles:10 Average:143.90 Median:139.50 stddev:14.23 (10.2%) stddev-sans-first:14.93 09:16:50 INFO - PROCESS | 1646 | Values: 138.0 137.0 137.0 137.0 137.0 140.0 139.0 142.0 183.0 149.0 09:16:50 INFO - PROCESS | 1646 | 09:16:50 INFO - PROCESS | 1646 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.20 Median:168.00 stddev:21.74 (12.9%) stddev-sans-first:23.06 09:16:50 INFO - PROCESS | 1646 | Values: 177.0 228.0 205.0 166.0 166.0 168.0 168.0 166.0 166.0 162.0 09:16:50 INFO - PROCESS | 1646 | 09:16:50 INFO - PROCESS | 1646 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 09:16:50 INFO - PROCESS | 1646 | Values: 66.0 65.0 66.0 65.0 65.0 65.0 64.0 65.0 64.0 65.0 09:16:50 INFO - PROCESS | 1646 | -------- Summary: end -------- 09:16:50 INFO - PROCESS | 1646 | 09:16:50 INFO - TEST-INFO | 1646: exit 0 09:16:50 INFO - TEST-OK | kraken | took 58773ms 09:16:50 INFO - SUITE-END | took 1177s 09:16:51 INFO - Completed test suite (00:19:38) 09:16:51 INFO - javascript benchmark 09:16:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2927.941441171177, 3319.684629960154, 3340.6826351496607, 3341.0, 3365.5456513370686, 5658.830235092949, 5696.658200507973, 5696.743646535905, 5701.0, 5706.429357064291, 5657.575681823859, 5764.5676574256995, 5770.163326317692, 5774.960507108719, 5783.884322313551, 5246.895062098756, 5281.0, 5292.10034294169, 5302.072137375963, 5344.198370244475, 4265.253580623394, 5187.818426355078, 5194.71429071401, 5352.063388906945, 5360.303160589118, 5216.426193118754, 5224.63427560071, 5229.764660590283, 5281.656692314988, 5296.993571221475, 5235.424103348629, 5254.737263136828, 5278.049951008817, 5280.07598670235, 5300.469953004707, 5153.922691159635, 5219.608529360313, 5237.057329680656, 5257.763400646942, 5295.443978382292, 5553.250311207976, 5568.969740598002, 5592.720363981784, 5594.916076258859, 5639.6334238274385, 6216.844578885564, 6267.9686601567155, 6269.122322874801, 6283.968580157116, 6290.654014029226, 6266.905996410058, 6269.937300627026, 6273.937260627426, 6275.592086514362, 6299.433051025429, 5607.7476513556985, 5729.054705973551, 5741.368449470555, 5798.884022319572, 5817.534597232211, 6191.288001879751, 6208.192934918432, 6249.0938813871735, 6293.559450838489, 6297.275813281532, 6185.288691800411, 6188.319284878659, 6191.442770150708, 6200.968995155085, 6203.2245969253845, 6135.11040899076, 6193.783217587363, 6211.534134939898, 6273.843153921189, 6292.119103325538, 5123.795048198031, 6117.380029168308, 6128.233970753656, 6167.722452489649, 6175.84560385985, 6189.8452538686, 6263.906041409383, 6265.248170219603, 6268.1851359323, 6275.717592708339, 4937.770428824684, 4999.625028122905, 5002.449730529639, 5010.649254552146, 5020.3724534433195, 4384.364267181241, 4401.163778882003, 4405.647548196201, 4417.757023363682, 4475.552444755564, 5795.710214489259, 5835.591508594358, 5875.529957603381, 5885.293764748258, 5907.113932910098, 6092.51259899207, 6122.8251069701855, 6146.647737497743, 6183.84540386494, 6205.968970155121, 5733.885322293614, 5746.683932383676, 5751.1085781703905, 5793.159991801165, 5810.82567522975, 5481.205225242317, 5496.862578435491, 5498.5876059295715, 5498.697571633518, 5507.944920550824, 6142.78500252498, 6152.723127459365, 6161.106639537153, 6196.039613859859, 6255.280642726145, 6164.229471316085, 6182.1345011697495, 6183.319834818257, 6186.721597528212, 6189.35011823752, 5421.7560209791445, 6263.4362907338555, 6271.0, 6297.338779428277, 6299.0, 4153.563875793119, 5525.756704741401, 6074.757009719739, 6153.554199418753, 6184.474319682878, 5274.578033757213, 5649.322081350264, 6214.627122372672, 6247.531435142473, 6248.250209974832, 6032.517398608188, 6062.90905636407, 6068.848278793065, 6080.69596520181, 6081.27024757032, 5963.671998040149, 6003.249593800775, 6152.261728592597, 6169.383061693795, 6179.721912513858, 5861.912071318849, 5912.911306330322, 5918.260217472816, 5950.047992321381, 5999.070144127667, 5036.571891389126, 6101.145839582373, 6108.51131909455, 6112.969435152796, 6126.203593532812, 5768.451997060272, 5982.611130276518, 5986.102084687332, 6003.159557661844, 6095.299040610209], "value": 5662.5437300799085, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [465.2346889366991, 470.804616084325, 471.2860017074132, 471.2860017074132, 520.8177138001697, 31696.841515792417, 41731.374029389546, 43165.99999999996, 43233.78383108088, 43333.566664333346, 43956.12087758243, 44307.0, 44432.77783611086, 44475.55524444755, 44683.55316446834, 8579.52812595307, 9346.252299816015, 9528.333016688835, 9540.475273859935, 9545.61817527298, 8539.615717292736, 11437.313761174315, 11706.707332316717, 11711.765764684702, 11732.0, 11655.592054278102, 11706.356150411766, 11727.17909746318, 11751.823722644167, 11758.294502329887, 8601.483910965362, 8801.427907186013, 11727.648170554854, 11781.41092945358, 11798.528058877591, 11317.83023254652, 11576.826347604792, 11616.88383116175, 11800.881991180064, 11830.822537661941, 42282.15435691269, 42570.14859702789, 42579.36130958038, 42622.57377426217, 42711.145777084595, 3653.2876089162623, 3660.4875317455576, 3738.6822120119823, 3745.1573395985956, 3897.8051097445014, 28286.858565707247, 28306.433871322457, 28345.433091338266, 28680.713192868014, 28796.280092997633, 3145.7640676949322, 3221.4201443740117, 3360.059183428644, 3380.9492857607156, 3382.729381649462, 429513.0, 481607.0, 482046.9999999965, 484313.0, 485154.0, 58929.0, 59353.70323148357, 59431.0, 59439.70280148571, 59481.70259148763, 62108.68945655243, 62266.68866655638, 62302.81940132074, 62359.0, 62411.37588624146, 15577.532674019798, 15586.610334741496, 15598.220088995506, 16077.196140192944, 16101.919490402473, 11316.434178291218, 11582.36297003673, 11588.188826782045, 12687.873121268854, 12784.61646150617, 16142.19289035567, 16282.348706051862, 16359.0, 18519.814801851808, 18881.96149211779, 7712.614369281513, 7832.882506762403, 7843.882341764878, 7865.331446827084, 7929.1277959424415, 857.3227150550995, 880.5729221327651, 885.6280362247871, 893.2541327991071, 915.1214833759532, 30293.69706302953, 30712.0, 30733.0, 30766.76932922658, 31300.0, 917.0783362720557, 980.9607615695435, 1057.2546354819833, 1069.6149386220955, 1103.5916710817048, 15493.612659683373, 15806.20968951548, 15912.92043539798, 15925.030471357119, 16244.431444899608, 599032.0, 606383.0, 607013.0, 607958.56227907, 608689.0, 63793.68103159455, 64374.0, 64419.0, 64460.677696611216, 64592.0, 1410.6614412540916, 1433.254707552067, 1445.4244873088385, 1452.7167202395642, 1453.6438572549794, 28445.573316400685, 29624.111276661733, 29978.70021299759, 30073.248168795955, 30570.847145764128, 49058.75470622624, 49293.0, 54019.0, 54080.72959635177, 54180.72909635427, 509213.0, 509641.0, 509877.0, 510000.0, 510796.0, 27110.0, 27405.31486712848, 27704.584431233143, 27738.5839212416, 27793.722062779114, 40971.79514102411, 41519.0, 47677.76161119172, 49545.752271238416, 50500.0, 36919.26161476809, 37505.0, 37595.06012349713, 37844.810775945945, 38695.93692662343, 31877.20306992344, 34676.0, 36405.63594364023, 36554.81722591476, 37496.81251593724, 36269.27461450809, 36792.63207367892, 36812.44781328336, 37019.44470832886, 37085.0, 31173.53239701452, 32616.510752339207, 33253.0, 33330.66669333276, 33332.83333583413, 24312.784360782243, 24644.890979905587, 24798.752012479643, 25148.74851251464, 25237.0], "value": 20120.67075433127, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.32624538284915, 398.12809946217783, 403.8384646141545, 408.6893960589951, 427.9208346455906, 16733.414330498435, 20206.595868082648, 21134.048967796447, 21349.252776152836, 21626.89186554069, 21121.47196320093, 21153.259635912746, 21480.355589332306, 22099.779002209973, 22314.88842555789, 5647.604667673275, 5959.225300710901, 5961.701914904237, 5965.970170149165, 5977.0, 5721.170430287606, 5863.0, 5976.521878249751, 5993.970030149843, 6058.061000544901, 6090.451859332659, 6102.206713127287, 6106.816795496142, 6113.388661133873, 6114.877702445949, 5934.643921364732, 6438.484921206292, 6521.184851893513, 6525.836854078639, 6536.411722944958, 5680.176374425727, 5749.741261643236, 5799.594028418012, 5838.737256823453, 5853.385394533555, 13389.0, 13565.050446468751, 13659.795103073462, 13785.655358616015, 13790.310484475736, 2520.3195137313005, 2599.766021058095, 2619.5677713177492, 2637.7757890579323, 2647.6160956661174, 10038.347507411994, 10064.29549931505, 10232.334898231591, 10542.051215390651, 10576.259661823675, 1763.356374923144, 1830.1398342778873, 1830.2404502131599, 1831.8351348378576, 1837.9172937217857, 128495.0, 130190.0, 137782.0, 139930.90103648455, 141475.29262353724, 11611.88388116108, 12015.279083254858, 12028.518859245532, 12037.0, 12046.216995895415, 13134.146280491737, 15512.534623961299, 16061.437849675205, 16067.11630860314, 16115.919420402823, 7285.4171666266575, 8819.647214111492, 8947.776305592412, 8976.640934362684, 9050.004499505048, 8738.820259265045, 8753.606087726068, 8755.124487551195, 8880.023197448276, 8903.688370906988, 3958.5645578986287, 4830.541098595628, 4831.347768051268, 4832.855014349575, 4895.779689913891, 1987.7217189593468, 2032.2606404216313, 2033.2070492507933, 2035.3792093411355, 2043.3665563675308, 851.5912362066243, 884.2704768565959, 889.6610601045385, 895.9507227102572, 916.5234078279391, 20282.290119845733, 21135.471613209484, 21177.699828345336, 21230.36308910735, 21331.040103195395, 855.1918437076903, 912.1516989199976, 936.0156468287274, 941.7975135345933, 943.1605870775015, 8674.522901240367, 10333.18918166595, 10364.170866330676, 10896.564137434414, 10904.836427453594, 737228.0, 745700.0, 749477.0, 750897.0, 768916.0, 84813.0, 112289.4385528067, 120650.0, 121823.39088304502, 152089.23955380372, 962.2542529539663, 998.2463240253562, 999.7850462150527, 1002.2733518199248, 1003.513296051429, 18995.620087597894, 19383.903080484506, 19747.703784442958, 19761.505962351057, 19770.209191632173, 54840.45159548354, 55659.0, 56313.43686563246, 56705.71647141903, 57065.00272490443, 68455.0, 81026.0, 83953.0, 84206.0, 85035.1496485052, 8121.35029197651, 8239.134890836376, 8310.667573297, 8374.246317831425, 8513.19124683154, 12152.57465988686, 12493.75012499763, 12817.935910320388, 12868.935655321664, 13098.410571524495, 8332.625031873458, 10718.24972251966, 10805.135589153006, 11016.449177540931, 11329.320240785579, 10984.395858227874, 11013.559457621606, 11322.26405283654, 11347.205695601559, 11489.310641361544, 11128.054115400282, 11205.551777928791, 11248.325100493996, 11355.943220283845, 11587.768244634892, 8077.27304542594, 8095.907052547831, 8334.333253339839, 8478.57607119654, 8655.09121542229, 10316.48417579103, 10674.985876341736, 10927.45362731876, 11272.380019099028, 11619.419029048344], "value": 9664.372124907019, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1436.9634431318227, 1437.7340192064469, 1442.141925554295, 1459.8175228096488, 1460.0144902191018, 8018.639161237744, 8440.409171358007, 8443.831123377537, 8453.281471074959, 8465.195806398398, 7381.077365329334, 7670.578118203496, 7672.961635191817, 8027.117017128126, 8240.83518329633, 2307.100230909942, 2328.650702394646, 2361.7047869016374, 2365.0, 2366.290112966112, 2343.4375749820006, 2357.5049239659693, 2377.061060880951, 2382.9642555361684, 2390.629452434867, 2030.8984550772477, 2115.4499830044224, 2117.3859580721573, 2269.6255117905525, 2350.788429041386, 2333.591621466245, 2357.9410514737096, 2360.9645855312183, 2361.8464799787957, 2362.5629258587214, 2301.137073597401, 2380.2264264114233, 2380.7262164850918, 2382.321038504018, 2384.0582969727034, 7048.18945821232, 8352.83294334116, 8406.78983025423, 8418.579071046484, 8429.409941304111, 5140.74296285188, 5300.708461034642, 5302.469753024705, 5302.946970530284, 5317.893642127175, 3323.3851737428654, 3395.507651390559, 3522.0138361258887, 3575.481555174485, 3597.982010089933, 1233.9814902776466, 1277.8594354620984, 1725.9223334949957, 1760.586262228388, 1831.78018637763, 10455.424951627658, 10639.787204255948, 10762.892371076266, 10771.5691372345, 10779.946100269448, 4469.5530446955045, 4522.29904364824, 4575.748333841604, 4576.153411618861, 4587.151376995266, 8719.564021798884, 8722.912770872337, 8723.476591404537, 8728.78178045554, 8733.781655458664, 5178.249153872667, 5186.351706036746, 5188.092083885381, 5193.818216362409, 5206.323177986837, 4762.071396077731, 4769.6661233714, 4826.831060912851, 4882.829100981448, 4886.340344053508, 3490.5636795400574, 3613.837377318027, 3637.2907283079544, 3665.047087757149, 3681.9079523012138, 1159.1769843411105, 1164.889335513125, 1165.1494409081417, 1173.6420391780418, 1175.9588414405455, 711.9038929744419, 762.8054846014231, 764.3846703403814, 778.6807408962298, 849.9885136687323, 4625.923760699097, 5327.786888524493, 5414.40441551429, 5418.8916221675345, 5623.887522249532, 811.8457493076297, 926.3978414030934, 975.2782940623887, 980.7008862296925, 1008.7931973945324, 3580.5524309461316, 3656.4149736042637, 3749.812509374575, 3784.9810750946067, 3799.3920972644796, 9475.526223688788, 9845.360051596623, 10028.398296102258, 10097.394156350643, 10103.989601039984, 9535.38020028696, 9949.204063674888, 10010.499475026365, 10019.949900250453, 10028.0, 7331.340179383881, 7597.3162415382885, 7606.733764318223, 7608.972788673569, 7632.427567932427, 5367.624266301322, 5408.621396502207, 5479.945200547943, 5628.0, 5727.284089488814, 8950.865737013819, 9046.728598142066, 9231.0, 9326.95336523313, 9364.531773411167, 9270.53647317618, 9438.292128090558, 9480.194183494481, 9531.809363812547, 9639.9036009639, 6116.541259405473, 7076.0801095857205, 7154.0, 7296.854062918605, 7306.232845551141, 7679.155292917886, 7812.1797211292, 7864.370850332074, 7867.449278550446, 7874.724384646739, 7085.114360704912, 7144.749933752294, 7192.065031545865, 7203.71185152609, 7317.341439270491, 7062.435005199469, 7077.363037326665, 7082.504224704221, 7107.324804143598, 7125.216226215216, 6269.216347956505, 6328.968355158195, 6406.519511036598, 6409.615423074631, 6428.971364581645, 4898.9020219594695, 4909.018196360671, 4941.752912354296, 4960.280759289811, 4982.5764809990105, 4833.250846118857, 4854.417469903634, 4907.779149938333, 4965.751712414292, 5026.447090819934], "value": 4400.664881579066, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.05834305717616, 358.673607017614, 361.59862552566653, 372.77819697280125, 375.21205468516104, 4671.906561868765, 5051.621128415365, 5319.388270348911, 5356.232443293714, 5389.838304850856, 4576.354999675332, 5082.0, 5136.943518606433, 5206.609504287175, 5224.4775522447735, 3991.1419044905338, 4076.8369265229353, 4126.172378317361, 4158.729682570638, 4174.41558181854, 4148.460700108982, 4150.3566947123245, 4171.395147703581, 4174.394712766662, 4180.665546756252, 3729.962700372989, 3960.544537378195, 3975.5030621172355, 4002.679785617144, 4037.9596204037875, 3953.3476976298875, 3967.940480892789, 3971.205758848242, 3971.2653159165648, 3983.721139520235, 3063.5098384258413, 3359.277755282626, 3466.6013408457848, 3482.407990641597, 3489.0, 4661.417322834645, 4797.352357431737, 4841.111966333133, 5120.871978200575, 5185.403678576974, 3776.9613356326954, 3851.9229615407817, 4503.446311022692, 4580.335851301543, 4604.674639307162, 5352.63507805511, 5606.551475881961, 5608.383077861432, 5613.775448982035, 5629.662220266756, 2925.5319148936283, 3252.7151775048724, 3841.80903919783, 3842.4812650292133, 3879.1853710720784, 4942.728149951751, 5245.685258884441, 5624.184493248497, 5844.47399734026, 5860.443257890493, 3162.76279279055, 3848.2688289224957, 3855.691544676419, 3867.9806600966817, 3888.5528164260904, 3341.9614035438362, 3364.9327013459592, 3932.2135572885536, 3944.225098705594, 3951.940720889189, 3685.3919103348185, 3809.542854857435, 4544.84120042977, 4561.338605902192, 4625.814967401334, 5604.747786349624, 5606.365008446024, 5622.437756224344, 5626.2967129108865, 5661.433856614306, 1043.8068957242933, 1119.2277328643372, 1142.9199956003, 1169.2925779903205, 1216.8804699676318, 758.2720588235355, 817.7301490508119, 834.7753237621791, 840.6049156896249, 866.921977022071, 4294.957050429518, 4693.436787585511, 5005.246065450911, 5039.546440820343, 5065.442801291855, 5086.415062267813, 5300.496452836975, 5301.946980530222, 5504.669719816824, 5529.834104976857, 4272.230998420252, 4371.650267978554, 4720.0087981523575, 4826.276058591239, 4983.25251212321, 2396.5206958608346, 2856.7857410694282, 2863.527517959555, 2899.318395330703, 2902.9114082219166, 4888.828890988798, 5433.049216387117, 5484.972575137179, 5539.556835453154, 5698.635066447461, 4550.0, 4871.780769865364, 5133.0, 5484.860904247346, 5535.0, 4779.737114458738, 5505.724713764296, 5612.915806262991, 5654.802081927195, 5685.346185188673, 4742.857714268577, 5015.448300686994, 5263.526072792092, 5368.865778355573, 5427.185922111715, 4999.600031997359, 5035.571976382049, 5367.470270972754, 5371.334886185295, 5422.376426710979, 5167.682241028664, 5284.327392462202, 5299.284596579567, 5335.639411949928, 5575.1915972183, 3195.8242296672975, 3494.371013217645, 3678.485012098362, 3839.7745893449637, 3882.495275614152, 4972.3535940328975, 5301.522862942354, 5560.944390556205, 5768.192453056491, 5781.5428442912435, 5125.847144199371, 5594.748236329294, 5606.467385598362, 5610.541259272537, 5634.88730225385, 5202.3497062867145, 5368.865778355573, 5536.390996990408, 5571.749271282721, 5598.412166722598, 4550.88622784433, 4856.203204814241, 5127.820526281562, 5342.183657556449, 5423.674579525241, 4819.072371051608, 5118.462561431145, 5416.560484092551, 5507.9449205507435, 5537.781688028627, 4849.2726091086615, 5111.881752131271, 5402.51377376038, 5419.916016796577, 5467.0], "value": 3971.3494543368074, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.503325155765, 760.9353204977576, 814.9225823546763, 819.1726356380054, 828.6975254032276, 15278.618034549141, 15881.444149454772, 15918.52244432666, 15927.964682295642, 15958.84041159588, 14339.0, 14517.0, 14519.854801451982, 14527.92736036321, 14535.854641453583, 663.7809522857445, 683.692338447698, 687.1204857782047, 835.3150416658343, 865.4374656473311, 855.4525103933456, 870.0733718589681, 870.6038752367689, 870.6865528409768, 870.7039606533777, 920.9263258939302, 922.8385032619299, 923.1368670293298, 923.3351986569659, 923.6213152607432, 712.803978905805, 734.9742759003462, 741.1550832051465, 917.8485549884261, 919.8528235482324, 548.1968915538755, 548.3775914337216, 620.9472194863442, 677.7187467201105, 685.4790359326947, 14715.337809798584, 14947.177905215318, 15028.549143525712, 15074.0, 15075.246237688181, 12980.480780768758, 13052.412641431063, 13150.145240559334, 13901.304934753221, 14431.855681443156, 12853.357332133355, 12874.227546347156, 12973.091883568153, 13079.934600327033, 13224.0, 4292.270314046588, 4394.736315821061, 4460.50934397216, 4522.3216517522305, 4660.627149828006, 101546.49226753892, 103590.0, 105849.47075264575, 106879.0, 107894.46052769765, 10428.634997775041, 10753.677389678322, 10921.344719316867, 11167.329960202414, 11619.128565357632, 21121.155153793676, 21160.894195528923, 21402.357929262147, 21480.033398497104, 21523.354299371043, 7303.89044164338, 7454.180040195574, 7480.251974802585, 7742.961285193538, 7918.683252669829, 4154.589371980688, 4280.357946308017, 4346.700133468812, 4353.25994580922, 4388.846390376385, 3088.660247372787, 3311.122552523583, 3312.7184189343693, 3358.026172410023, 3392.6776956189124, 656.7569999100364, 660.7654282729658, 660.7918505670698, 663.6781161136845, 674.7975607317785, 442.82508409178195, 537.5887446103734, 547.1956224350199, 554.8585110796721, 575.1258087706746, 9574.569144388519, 9725.513724313756, 9744.90255097454, 9845.45849978258, 9917.256205784595, 625.43710660406, 644.8645784385332, 663.4824836627438, 663.7743167323036, 666.9233038200572, 4636.466806317249, 4647.09381670571, 4698.929516057262, 4712.198926182557, 4761.35721677576, 91590.62614060794, 106596.0, 106958.0, 107011.4649426748, 107040.0, 92415.0, 95747.52126239325, 95752.52123739476, 97948.02051979389, 99282.00717992873, 80864.0, 80919.59540202262, 81650.18349816544, 83593.0, 84291.7356239657, 8986.460812351279, 9140.131687489678, 9158.038405967543, 9162.31282653817, 9171.266298695955, 53303.73348133235, 53442.93114137773, 54545.72727136498, 55617.72191139018, 56104.15843762428, 70863.58272834617, 72021.27978720146, 72499.63750181426, 75311.49377012538, 75615.0, 9701.0, 10881.564737410416, 10919.45702261091, 11296.83054754163, 11300.605674211069, 11839.230450020721, 11997.76004479923, 12128.332941688292, 12185.69535761613, 12213.511459541518, 10829.512671929624, 11024.228304018963, 11637.650870473899, 11664.533418663159, 11742.119341049627, 10320.896791031993, 11139.610113645984, 13005.154664946747, 13596.388162532512, 13987.950903682467, 10038.749031274276, 12837.550685726328, 13427.395767190696, 13695.315234238049, 13913.791293130409, 9895.950520247352, 10772.784544309226, 10916.707491426889, 11166.994970452699, 11180.273282236629, 10874.945625271823, 10955.56177752881, 10958.780824383308, 10967.396793176453, 10993.0], "value": 7341.64636530768, "unit": "score"}], "name": "dromaeo_css", "value": 7216.963003466212, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 111.0, 112.0, 113.0, 116.0, 129.0, 112.0, 114.0, 111.0, 112.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 110.0, 107.0, 145.0, 108.0, 110.0, 107.0, 109.0, 127.0, 109.0], "value": 117.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 185.0, 184.0, 182.0, 185.0, 186.0, 183.0, 182.0, 183.0], "value": 184.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 59.0, 59.0, 88.0, 60.0, 59.0, 58.0, 57.0, 75.0, 58.0], "value": 65.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 86.0, 69.0, 69.0, 68.0, 80.0, 67.0, 67.0, 81.0], "value": 74.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 86.0, 83.0, 86.0, 83.0, 87.0, 84.0, 85.0, 83.0], "value": 84.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 101.0, 93.0, 93.0, 134.0, 149.0, 93.0, 93.0, 93.0], "value": 103.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 83.0, 107.0, 128.0, 112.0, 87.0, 89.0, 87.0, 87.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 52.0, 52.0, 53.0, 54.0, 56.0, 57.0, 56.0, 55.0, 56.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 70.0, 66.0, 73.0, 79.0, 72.0, 70.0, 69.0, 69.0, 69.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 84.0, 83.0, 80.0, 81.0, 92.0, 78.0, 80.0, 78.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 137.0, 137.0, 137.0, 137.0, 140.0, 139.0, 142.0, 183.0, 149.0], "value": 143.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 228.0, 205.0, 166.0, 166.0, 168.0, 168.0, 166.0, 166.0, 162.0], "value": 177.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 65.0, 65.0, 65.0, 64.0, 65.0, 64.0, 65.0], "value": 65.0, "unit": "score"}], "name": "kraken", "value": 1432.1000000000001, "alertThreshold": 2.0}]} 09:16:51 INFO - Return code: 0 09:16:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:16:51 ERROR - # TBPL SUCCESS # 09:16:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:16:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:16:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:16:51 INFO - 2017-02-15 09:16:51.321 screenresolution[1650:9778] starting screenresolution argv=screenresolution get 09:16:51 INFO - 2017-02-15 09:16:51.323 screenresolution[1650:9778] Display 0: 1600x1200x32@60 09:16:51 INFO - 2017-02-15 09:16:51.330 screenresolution[1651:9781] starting screenresolution argv=screenresolution list 09:16:51 INFO - Available Modes on Display 0 09:16:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:16:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:16:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:16:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:16:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:16:51 INFO - Intel Iris: 09:16:51 INFO - Chipset Model: Intel Iris 09:16:51 INFO - Type: GPU 09:16:51 INFO - Bus: Built-In 09:16:51 INFO - VRAM (Dynamic, Max): 1536 MB 09:16:51 INFO - Vendor: Intel (0x8086) 09:16:51 INFO - Device ID: 0x0a2e 09:16:51 INFO - Revision ID: 0x0009 09:16:51 INFO - Displays: 09:16:51 INFO - Display: 09:16:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:16:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:16:51 INFO - Display Serial Number: 1600x1200 60 09:16:51 INFO - Main Display: Yes 09:16:51 INFO - Mirror: Off 09:16:51 INFO - Online: Yes 09:16:51 INFO - Rotation: Supported 09:16:51 INFO - Return code: 0 09:16:51 INFO - Running post-action listener: _resource_record_post_action 09:16:51 INFO - [mozharness: 2017-02-15 17:16:51.566917Z] Finished run-tests step (success) 09:16:51 INFO - Running post-run listener: _resource_record_post_run 09:16:51 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 39113728; Write bytes: 507981312; Read time: 377; Write time: 1625 09:16:51 INFO - TinderboxPrint: CPU usage
53.7% 09:16:51 INFO - TinderboxPrint: I/O read bytes / time
39,113,728 / 377 09:16:51 INFO - TinderboxPrint: I/O write bytes / time
507,981,312 / 1,625 09:16:51 INFO - TinderboxPrint: CPU idle
2,217.2 (46.3%) 09:16:51 INFO - TinderboxPrint: CPU system
962.0 (20.1%) 09:16:51 INFO - TinderboxPrint: CPU user
1,614.5 (33.7%) 09:16:51 INFO - TinderboxPrint: Swap in / out
246,423,552 / 0 09:16:51 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 208919040; Write bytes: 211019776; Read time: 15879; Write time: 507 09:16:51 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 34354176; Write bytes: 295470592; Read time: 342; Write time: 1112 09:16:52 INFO - Running post-run listener: _upload_blobber_files 09:16:52 INFO - Blob upload gear active. 09:16:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:16:52 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 09:16:52 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:16:52 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:16:52 INFO - (blobuploader) - INFO - Open directory for files ... 09:16:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:16:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:16:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:16:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:16:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:16:53 INFO - (blobuploader) - INFO - Done attempting. 09:16:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:16:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:16:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:16:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:16:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:16:55 INFO - (blobuploader) - INFO - Done attempting. 09:16:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:16:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:16:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:16:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:16:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:16:56 INFO - (blobuploader) - INFO - Done attempting. 09:16:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:16:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:16:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:16:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:16:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:16:58 INFO - (blobuploader) - INFO - Done attempting. 09:16:58 INFO - (blobuploader) - INFO - Iteration through files over. 09:16:58 INFO - Return code: 0 09:16:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:16:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:16:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/37f02276ecb7ff2abf8dcc0622a0d21c57830fa2bc0ed4d227523e1bebacda87d8d35bdbbf8e1739e2832919e13ac32f366465562d2b1a0b86a009e1e4ea3b5b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7eeba0100ab3df75aeb6f106bebf6bdfdd864095d11f7bda66e8e258b86d593136fa2012a0594efaefd8ffaf81a2d16147e5355d37ed93819317be1c10220f29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ee99e7ec55793d6d5a5a6498733de02e2cccea4f2612cfc33228a8f0cdebeeecc5717a7c86e7ec84991226889b54f630a66c42f80e119e319f3fd33fb35e29d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dff1d7279cb3f6228b02b797368e92d7861b22a657a6ba486867054523ce3fe0bb481054972d3ce3b4800f5f4448485d03df026be5976e2de60cff00622ac3c0"} 09:16:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:16:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:16:58 INFO - Contents: 09:16:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/37f02276ecb7ff2abf8dcc0622a0d21c57830fa2bc0ed4d227523e1bebacda87d8d35bdbbf8e1739e2832919e13ac32f366465562d2b1a0b86a009e1e4ea3b5b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7eeba0100ab3df75aeb6f106bebf6bdfdd864095d11f7bda66e8e258b86d593136fa2012a0594efaefd8ffaf81a2d16147e5355d37ed93819317be1c10220f29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ee99e7ec55793d6d5a5a6498733de02e2cccea4f2612cfc33228a8f0cdebeeecc5717a7c86e7ec84991226889b54f630a66c42f80e119e319f3fd33fb35e29d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dff1d7279cb3f6228b02b797368e92d7861b22a657a6ba486867054523ce3fe0bb481054972d3ce3b4800f5f4448485d03df026be5976e2de60cff00622ac3c0"} 09:16:58 INFO - Running post-run listener: copy_logs_to_upload_dir 09:16:58 INFO - Copying logs to upload dir... 09:16:58 INFO - mkdir: /builds/slave/test/build/upload/logs 09:16:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.130915 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2017-02-15 09:16:58.914217) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-15 09:16:58.922060) ========= 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.Pso9WU0oyx/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.S8xkCj8oMs/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/37f02276ecb7ff2abf8dcc0622a0d21c57830fa2bc0ed4d227523e1bebacda87d8d35bdbbf8e1739e2832919e13ac32f366465562d2b1a0b86a009e1e4ea3b5b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7eeba0100ab3df75aeb6f106bebf6bdfdd864095d11f7bda66e8e258b86d593136fa2012a0594efaefd8ffaf81a2d16147e5355d37ed93819317be1c10220f29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ee99e7ec55793d6d5a5a6498733de02e2cccea4f2612cfc33228a8f0cdebeeecc5717a7c86e7ec84991226889b54f630a66c42f80e119e319f3fd33fb35e29d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dff1d7279cb3f6228b02b797368e92d7861b22a657a6ba486867054523ce3fe0bb481054972d3ce3b4800f5f4448485d03df026be5976e2de60cff00622ac3c0"} build_url:https://queue.taskcluster.net/v1/task/b6heWV48RHWXdfz-rRciUQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011241 build_url: 'https://queue.taskcluster.net/v1/task/b6heWV48RHWXdfz-rRciUQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/37f02276ecb7ff2abf8dcc0622a0d21c57830fa2bc0ed4d227523e1bebacda87d8d35bdbbf8e1739e2832919e13ac32f366465562d2b1a0b86a009e1e4ea3b5b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7eeba0100ab3df75aeb6f106bebf6bdfdd864095d11f7bda66e8e258b86d593136fa2012a0594efaefd8ffaf81a2d16147e5355d37ed93819317be1c10220f29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ee99e7ec55793d6d5a5a6498733de02e2cccea4f2612cfc33228a8f0cdebeeecc5717a7c86e7ec84991226889b54f630a66c42f80e119e319f3fd33fb35e29d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dff1d7279cb3f6228b02b797368e92d7861b22a657a6ba486867054523ce3fe0bb481054972d3ce3b4800f5f4448485d03df026be5976e2de60cff00622ac3c0"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-15 09:16:58.959355) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 09:16:58.959670) ========= 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.Pso9WU0oyx/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.S8xkCj8oMs/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.005129 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 09:16:59.008179) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-15 09:16:59.008477) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-15 09:16:59.011809) ========= ========= Total master_lag: 0.21 =========