builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0193 starttime: 1481387838.33 results: success (0) buildid: 20161210063616 builduid: 6b53f8488df742c2a4b6d2ec62689f36 revision: 2ec25b58608c6e815b1b6b2901561adb0d24e9d3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-10 08:37:18.329635) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-10 08:37:18.330078) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-10 08:37:18.330365) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-10 08:37:18.357382) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 08:37:18.357757) ========= 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.166LJAyEcM/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.49WCBtit4m/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-10 08:37:18-- 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% 24.3M=0s 2016-12-10 08:37:18 (24.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.532967 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 08:37:18.915016) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 08:37:18.915352) ========= 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.166LJAyEcM/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.49WCBtit4m/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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.026158 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 08:37:18.963787) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-10 08:37:18.964134) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2ec25b58608c6e815b1b6b2901561adb0d24e9d3 --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 2ec25b58608c6e815b1b6b2901561adb0d24e9d3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.166LJAyEcM/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.49WCBtit4m/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-10 08:37:19,062 truncating revision to first 12 chars 2016-12-10 08:37:19,062 Setting DEBUG logging. 2016-12-10 08:37:19,062 attempt 1/10 2016-12-10 08:37:19,062 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2ec25b58608c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-10 08:37:20,418 unpacking tar archive at: mozilla-aurora-2ec25b58608c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.631703 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-10 08:37:20.621067) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-10 08:37:20.621641) ========= script_repo_revision: 2ec25b58608c6e815b1b6b2901561adb0d24e9d3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-10 08:37:20.622283) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-10 08:37:20.622763) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-10 08:37:20.657659) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-12-10 08:37:20.658147) ========= /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.166LJAyEcM/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.49WCBtit4m/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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:37:20 INFO - MultiFileLogger online at 20161210 08:37:20 in /builds/slave/test 08:37:20 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:37:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:37:20 INFO - {'append_to_log': False, 08:37:20 INFO - 'base_work_dir': '/builds/slave/test', 08:37:20 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:37:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:37:20 INFO - 'branch': 'Mozilla-Aurora', 08:37:20 INFO - 'buildbot_json_path': 'buildprops.json', 08:37:20 INFO - 'config_files': ('talos/mac_config.py',), 08:37:20 INFO - 'default_actions': ('clobber', 08:37:20 INFO - 'read-buildbot-config', 08:37:20 INFO - 'download-and-extract', 08:37:20 INFO - 'populate-webroot', 08:37:20 INFO - 'create-virtualenv', 08:37:20 INFO - 'install', 08:37:20 INFO - 'run-tests'), 08:37:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:37:20 INFO - 'download_minidump_stackwalk': True, 08:37:20 INFO - 'download_symbols': 'ondemand', 08:37:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:37:20 INFO - 'tooltool.py': '/tools/tooltool.py', 08:37:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:37:20 INFO - '/tools/misc-python/virtualenv.py')}, 08:37:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:37:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:37:20 INFO - 'installer_path': 'installer.exe', 08:37:20 INFO - 'log_level': 'info', 08:37:20 INFO - 'log_name': 'talos', 08:37:20 INFO - 'log_to_console': True, 08:37:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:37:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:37:20 INFO - 'opt_config_files': (), 08:37:20 INFO - 'pip_index': False, 08:37:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:37:20 INFO - 'cmd': ('bash', 08:37:20 INFO - '-c', 08:37:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:37:20 INFO - 'enabled': True, 08:37:20 INFO - 'halt_on_failure': False, 08:37:20 INFO - 'name': 'check_screen_resolution'},), 08:37:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:37:20 INFO - 'cmd': ('bash', 08:37:20 INFO - '-c', 08:37:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:37:20 INFO - 'enabled': True, 08:37:20 INFO - 'halt_on_failure': False, 08:37:20 INFO - 'name': 'check_screen_resolution'},), 08:37:20 INFO - 'run_cmd_checks_enabled': True, 08:37:20 INFO - 'sps_profile': False, 08:37:20 INFO - 'sps_profile_interval': 0, 08:37:20 INFO - 'suite': 'dromaeojs', 08:37:20 INFO - 'system_bits': '32', 08:37:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:37:20 INFO - 'title': 't-yosemite-r7-0193', 08:37:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:37:20 INFO - 'use_talos_json': True, 08:37:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:37:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:37:20 INFO - 'work_dir': 'build'} 08:37:20 INFO - [mozharness: 2016-12-10 16:37:20.872308Z] Running clobber step. 08:37:20 INFO - Running pre-action listener: _resource_record_pre_action 08:37:20 INFO - Running main action method: clobber 08:37:20 INFO - rmtree: /builds/slave/test/build 08:37:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:37:23 INFO - Running post-action listener: _resource_record_post_action 08:37:23 INFO - [mozharness: 2016-12-10 16:37:23.297719Z] Finished clobber step (success) 08:37:23 INFO - [mozharness: 2016-12-10 16:37:23.297841Z] Running read-buildbot-config step. 08:37:23 INFO - Running pre-action listener: _resource_record_pre_action 08:37:23 INFO - Running main action method: read_buildbot_config 08:37:23 INFO - Using buildbot properties: 08:37:23 INFO - { 08:37:23 INFO - "project": "", 08:37:23 INFO - "product": "firefox", 08:37:23 INFO - "script_repo_revision": "production", 08:37:23 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 08:37:23 INFO - "repository": "", 08:37:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 08:37:23 INFO - "buildid": "20161210063616", 08:37:23 INFO - "pgo_build": "False", 08:37:23 INFO - "basedir": "/builds/slave/test", 08:37:23 INFO - "buildnumber": 5, 08:37:23 INFO - "slavename": "t-yosemite-r7-0193", 08:37:23 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 08:37:23 INFO - "platform": "yosemite_r7", 08:37:23 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:37:23 INFO - "branch": "mozilla-aurora", 08:37:23 INFO - "repo_path": "releases/mozilla-aurora", 08:37:23 INFO - "revision": "2ec25b58608c6e815b1b6b2901561adb0d24e9d3", 08:37:23 INFO - "stage_platform": "macosx64", 08:37:23 INFO - "builduid": "6b53f8488df742c2a4b6d2ec62689f36", 08:37:23 INFO - "slavebuilddir": "test" 08:37:23 INFO - } 08:37:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/Jilm3JjLSsiooJi7dMFeCw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 08:37:23 INFO - Running post-action listener: _resource_record_post_action 08:37:23 INFO - [mozharness: 2016-12-10 16:37:23.301283Z] Finished read-buildbot-config step (success) 08:37:23 INFO - [mozharness: 2016-12-10 16:37:23.301417Z] Running download-and-extract step. 08:37:23 INFO - Running pre-action listener: _resource_record_pre_action 08:37:23 INFO - Running main action method: download_and_extract 08:37:23 INFO - mkdir: /builds/slave/test/build/tests 08:37: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:37:23 INFO - trying https://queue.taskcluster.net/v1/task/Jilm3JjLSsiooJi7dMFeCw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 08:37:23 INFO - Downloading https://queue.taskcluster.net/v1/task/Jilm3JjLSsiooJi7dMFeCw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 08:37:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jilm3JjLSsiooJi7dMFeCw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 08:37:24 INFO - Downloaded 1199 bytes. 08:37:24 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 08:37:24 INFO - Using the following test package requirements: 08:37:24 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 08:37:24 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:37:24 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 08:37:24 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:37:24 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 08:37:24 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:37:24 INFO - u'jsshell-mac.zip'], 08:37:24 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:37:24 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 08:37:24 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 08:37:24 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:37:24 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 08:37:24 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:37:24 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 08:37:24 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:37:24 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 08:37:24 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:37:24 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 08:37:24 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:37:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jilm3JjLSsiooJi7dMFeCw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 08:37:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jilm3JjLSsiooJi7dMFeCw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:37:24 INFO - Fetch https://queue.taskcluster.net/v1/task/Jilm3JjLSsiooJi7dMFeCw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 08:37:25 INFO - Http code: 200 08:37:25 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 08:37:25 INFO - x-amz-cf-id: --qscyCY7QMM37KKjfxSjlAr0-UCJVu0aOz0GtMYOEyWR8qPb6QoAA== 08:37:25 INFO - x-amz-version-id: ZLmOHzT5wGa3h5Un6Kyz6Xl_cY7.9efu 08:37:25 INFO - Expected file size: 16280954 08:37:25 INFO - Obtained file size: 16280954 08:37:32 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:37:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jilm3JjLSsiooJi7dMFeCw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 08:37:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jilm3JjLSsiooJi7dMFeCw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:37:32 INFO - Fetch https://queue.taskcluster.net/v1/task/Jilm3JjLSsiooJi7dMFeCw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 08:37:32 INFO - Http code: 200 08:37:32 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 08:37:32 INFO - x-amz-cf-id: tEMB0fcdjqvKEb5Dfp67OLbH1ns_j-i-8qXKflWDe8TcKZcQWGT4_w== 08:37:32 INFO - x-amz-version-id: ZLmOHzT5wGa3h5Un6Kyz6Xl_cY7.9efu 08:37:33 INFO - Expected file size: 16280954 08:37:33 INFO - Obtained file size: 16280954 08:37:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jilm3JjLSsiooJi7dMFeCw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 08:37:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jilm3JjLSsiooJi7dMFeCw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:37:39 INFO - Fetch https://queue.taskcluster.net/v1/task/Jilm3JjLSsiooJi7dMFeCw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 08:37:40 INFO - Http code: 200 08:37:40 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 08:37:40 INFO - x-amz-cf-id: Nzd7hv9JZdro0r5taFIIJgkOuHR6x_UP13PUrnagYzATdpJ07hwI4Q== 08:37:40 INFO - x-amz-version-id: 21tUHNJgRPn27appVmVgmdoBUl743sVt 08:37:40 INFO - Expected file size: 14409038 08:37:40 INFO - Obtained file size: 14409038 08:37:40 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:37:40 INFO - trying https://queue.taskcluster.net/v1/task/Jilm3JjLSsiooJi7dMFeCw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:37:40 INFO - Downloading https://queue.taskcluster.net/v1/task/Jilm3JjLSsiooJi7dMFeCw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 08:37:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jilm3JjLSsiooJi7dMFeCw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 08:37:43 INFO - Downloaded 109781794 bytes. 08:37:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Jilm3JjLSsiooJi7dMFeCw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:37:43 INFO - mkdir: /builds/slave/test/properties 08:37:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:37:43 INFO - Writing to file /builds/slave/test/properties/build_url 08:37:43 INFO - Contents: 08:37:43 INFO - build_url:https://queue.taskcluster.net/v1/task/Jilm3JjLSsiooJi7dMFeCw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:37:43 INFO - Running post-action listener: _resource_record_post_action 08:37:43 INFO - Running post-action listener: set_extra_try_arguments 08:37:43 INFO - [mozharness: 2016-12-10 16:37:43.976102Z] Finished download-and-extract step (success) 08:37:43 INFO - [mozharness: 2016-12-10 16:37:43.976244Z] Running populate-webroot step. 08:37:43 INFO - Running pre-action listener: _resource_record_pre_action 08:37:43 INFO - Running main action method: populate_webroot 08:37:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:37:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:37:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:37:43 INFO - '--tppagecycles', 08:37:43 INFO - '7'], 08:37:43 INFO - 'tests': ['tsvgm']}}, 08:37:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:37:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:37:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:37:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:37:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:37:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:37:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:43 INFO - 'talos_options': ['--disable-e10s'], 08:37:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:37:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:37:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:43 INFO - 'talos_options': ['--disable-e10s'], 08:37:43 INFO - 'tests': ['damp', 'tps']}, 08:37:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:43 INFO - 'tests': ['damp', 'tps']}, 08:37:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:37:43 INFO - 'tests': ['dromaeo_dom']}, 08:37:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:37:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:37:43 INFO - 'tests': ['basic_compositor_video']}, 08:37:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:37:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:37:43 INFO - 'tests': ['a11yr', 08:37:43 INFO - 'ts_paint', 08:37:43 INFO - 'tpaint', 08:37:43 INFO - 'sessionrestore', 08:37:43 INFO - 'sessionrestore_no_auto_restore', 08:37:43 INFO - 'tabpaint']}, 08:37:43 INFO - 'other-e10s': {'tests': ['a11yr', 08:37:43 INFO - 'ts_paint', 08:37:43 INFO - 'tpaint', 08:37:43 INFO - 'sessionrestore', 08:37:43 INFO - 'sessionrestore_no_auto_restore', 08:37:43 INFO - 'tabpaint']}, 08:37:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:37:43 INFO - 'ts_paint', 08:37:43 INFO - 'tpaint', 08:37:43 INFO - 'sessionrestore', 08:37:43 INFO - 'sessionrestore_no_auto_restore', 08:37:43 INFO - 'tabpaint']}, 08:37:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:37:43 INFO - 'ts_paint', 08:37:43 INFO - 'tpaint', 08:37:43 INFO - 'sessionrestore', 08:37:43 INFO - 'sessionrestore_no_auto_restore', 08:37:43 INFO - 'tabpaint']}, 08:37:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:37:43 INFO - 'tests': ['a11yr', 08:37:43 INFO - 'ts_paint', 08:37:43 INFO - 'tpaint', 08:37:43 INFO - 'sessionrestore', 08:37:43 INFO - 'sessionrestore_no_auto_restore', 08:37:43 INFO - 'tabpaint']}, 08:37:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:37:43 INFO - 'tests': ['a11yr', 08:37:43 INFO - 'ts_paint', 08:37:43 INFO - 'tpaint', 08:37:43 INFO - 'sessionrestore', 08:37:43 INFO - 'sessionrestore_no_auto_restore', 08:37:43 INFO - 'tabpaint']}, 08:37:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:37:43 INFO - 'tests': ['tsvgx', 08:37:43 INFO - 'tsvgr_opacity', 08:37:43 INFO - 'tart', 08:37:43 INFO - 'tscrollx', 08:37:43 INFO - 'cart']}, 08:37:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:37:43 INFO - 'tsvgr_opacity', 08:37:43 INFO - 'tart', 08:37:43 INFO - 'tscrollx', 08:37:43 INFO - 'cart']}, 08:37:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:43 INFO - 'talos_options': ['--disable-e10s'], 08:37:43 INFO - 'tests': ['tp5o']}, 08:37:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:43 INFO - 'tests': ['tp5o']}, 08:37:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:43 INFO - 'talos_options': ['--disable-e10s', 08:37:43 INFO - '--xperf_path', 08:37:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:37:43 INFO - 'tests': ['tp5n']}, 08:37:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:43 INFO - 'talos_options': ['--xperf_path', 08:37:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:37:43 INFO - 'tests': ['tp5n']}}, 08:37:43 INFO - 'talos.zip': {'path': '', 08:37:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:37:43 INFO - Running post-action listener: _resource_record_post_action 08:37:43 INFO - [mozharness: 2016-12-10 16:37:43.995017Z] Finished populate-webroot step (success) 08:37:43 INFO - [mozharness: 2016-12-10 16:37:43.995153Z] Running create-virtualenv step. 08:37:43 INFO - Running pre-action listener: _resource_record_pre_action 08:37:43 INFO - Running main action method: create_virtualenv 08:37:43 INFO - Creating virtualenv /builds/slave/test/build/venv 08:37:43 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:37:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:37:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:37:44 INFO - Using real prefix '/tools/python27' 08:37:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:37:44 INFO - Installing distribute.............................................................................................................................................................................................done. 08:37:47 INFO - Installing pip.................done. 08:37:47 INFO - Return code: 0 08:37:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:37:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:37:47 INFO - Reading from file tmpfile_stdout 08:37:47 INFO - Output received: 08:37:47 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:37:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107645490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075bb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5b3c916d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107459d30>, '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 0x1072bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107451b20>, '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.166LJAyEcM/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.49WCBtit4m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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:37:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:37:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:37:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.166LJAyEcM/Render', 08:37:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:37:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:37:47 INFO - 'HOME': '/Users/cltbld', 08:37:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:37:47 INFO - 'LOGNAME': 'cltbld', 08:37:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:47 INFO - 'MOZ_NO_REMOTE': '1', 08:37:47 INFO - 'NO_EM_RESTART': '1', 08:37:47 INFO - 'PAGER': '/bin/cat', 08:37:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:37:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:47 INFO - 'PWD': '/builds/slave/test', 08:37:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:37:47 INFO - 'SHELL': '/bin/bash', 08:37:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.49WCBtit4m/Listeners', 08:37:47 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 08:37:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:37:47 INFO - 'USER': 'cltbld', 08:37:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:37:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:37:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:47 INFO - 'XPC_FLAGS': '0x0', 08:37:47 INFO - 'XPC_SERVICE_NAME': '0', 08:37:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:37:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:48 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:37:48 INFO - Cleaning up... 08:37:48 INFO - Return code: 0 08:37:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:37:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:48 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 0x107645490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075bb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5b3c916d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107459d30>, '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 0x1072bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107451b20>, '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.166LJAyEcM/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.49WCBtit4m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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:37:48 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:37:48 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:37:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.166LJAyEcM/Render', 08:37:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:37:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:37:48 INFO - 'HOME': '/Users/cltbld', 08:37:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:37:48 INFO - 'LOGNAME': 'cltbld', 08:37:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:48 INFO - 'MOZ_NO_REMOTE': '1', 08:37:48 INFO - 'NO_EM_RESTART': '1', 08:37:48 INFO - 'PAGER': '/bin/cat', 08:37:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:37:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:48 INFO - 'PWD': '/builds/slave/test', 08:37:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:37:48 INFO - 'SHELL': '/bin/bash', 08:37:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.49WCBtit4m/Listeners', 08:37:48 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 08:37:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:37:48 INFO - 'USER': 'cltbld', 08:37:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:37:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:37:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:48 INFO - 'XPC_FLAGS': '0x0', 08:37:48 INFO - 'XPC_SERVICE_NAME': '0', 08:37:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:37:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:48 INFO - Downloading/unpacking psutil>=3.1.1 08:37: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:37: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:37: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:37: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:37: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:37: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:37:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:37:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:37:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:37:52 INFO - Installing collected packages: psutil 08:37:52 INFO - Running setup.py install for psutil 08:37:52 INFO - building 'psutil._psutil_osx' extension 08:37:52 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:37:53 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:37:53 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:37:53 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:37:53 INFO - building 'psutil._psutil_posix' extension 08:37:53 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:37:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:37:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:37:53 INFO - ^ 08:37:53 INFO - 1 warning generated. 08:37:53 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:37:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:37:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:37:53 INFO - Successfully installed psutil 08:37:53 INFO - Cleaning up... 08:37:53 INFO - Return code: 0 08:37:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:37: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:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37: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:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:53 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 0x107645490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075bb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5b3c916d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107459d30>, '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 0x1072bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107451b20>, '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.166LJAyEcM/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.49WCBtit4m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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:37:53 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:37:53 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:37:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.166LJAyEcM/Render', 08:37:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:37:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:37:53 INFO - 'HOME': '/Users/cltbld', 08:37:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:37:53 INFO - 'LOGNAME': 'cltbld', 08:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:53 INFO - 'MOZ_NO_REMOTE': '1', 08:37:53 INFO - 'NO_EM_RESTART': '1', 08:37:53 INFO - 'PAGER': '/bin/cat', 08:37:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:53 INFO - 'PWD': '/builds/slave/test', 08:37:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:37:53 INFO - 'SHELL': '/bin/bash', 08:37:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.49WCBtit4m/Listeners', 08:37:53 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 08:37:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:37:53 INFO - 'USER': 'cltbld', 08:37:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:37:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:53 INFO - 'XPC_FLAGS': '0x0', 08:37:53 INFO - 'XPC_SERVICE_NAME': '0', 08:37:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:37:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:37:54 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:37:54 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:37:54 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:37:54 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:37:54 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:37:54 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:37:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:37:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:37:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:37:56 INFO - Installing collected packages: mozsystemmonitor 08:37:56 INFO - Running setup.py install for mozsystemmonitor 08:37:56 INFO - Successfully installed mozsystemmonitor 08:37:56 INFO - Cleaning up... 08:37:56 INFO - Return code: 0 08:37:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:37:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107645490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075bb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5b3c916d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107459d30>, '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 0x1072bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107451b20>, '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.166LJAyEcM/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.49WCBtit4m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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:37:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:37:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:37:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.166LJAyEcM/Render', 08:37:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:37:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:37:56 INFO - 'HOME': '/Users/cltbld', 08:37:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:37:56 INFO - 'LOGNAME': 'cltbld', 08:37:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:56 INFO - 'MOZ_NO_REMOTE': '1', 08:37:56 INFO - 'NO_EM_RESTART': '1', 08:37:56 INFO - 'PAGER': '/bin/cat', 08:37:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:37:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:56 INFO - 'PWD': '/builds/slave/test', 08:37:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:37:56 INFO - 'SHELL': '/bin/bash', 08:37:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.49WCBtit4m/Listeners', 08:37:56 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 08:37:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:37:56 INFO - 'USER': 'cltbld', 08:37:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:37:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:37:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:56 INFO - 'XPC_FLAGS': '0x0', 08:37:56 INFO - 'XPC_SERVICE_NAME': '0', 08:37:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:37:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:57 INFO - Downloading/unpacking jsonschema==2.5.1 08:37:57 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:37:57 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:37:57 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:37:57 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:37:57 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:37:57 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:37:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:37:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:37:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:00 INFO - Downloading functools32-3.2.3-2.tar.gz 08:38:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:38:00 INFO - warning: no files found matching '*.txt' 08:38:00 INFO - no previously-included directories found matching 'build' 08:38:00 INFO - no previously-included directories found matching 'dist' 08:38:00 INFO - no previously-included directories found matching '.git*' 08:38:00 INFO - Installing collected packages: jsonschema, functools32 08:38:00 INFO - Running setup.py install for functools32 08:38:00 INFO - warning: no files found matching '*.txt' 08:38:00 INFO - no previously-included directories found matching 'build' 08:38:00 INFO - no previously-included directories found matching 'dist' 08:38:00 INFO - no previously-included directories found matching '.git*' 08:38:00 INFO - Successfully installed jsonschema functools32 08:38:00 INFO - Cleaning up... 08:38:00 INFO - Return code: 0 08:38:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:38:00 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:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:00 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:38:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:00 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 0x107645490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075bb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5b3c916d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107459d30>, '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 0x1072bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107451b20>, '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.166LJAyEcM/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.49WCBtit4m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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:38:00 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:38:00 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:38:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.166LJAyEcM/Render', 08:38:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:38:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:38:00 INFO - 'HOME': '/Users/cltbld', 08:38:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:38:00 INFO - 'LOGNAME': 'cltbld', 08:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:00 INFO - 'MOZ_NO_REMOTE': '1', 08:38:00 INFO - 'NO_EM_RESTART': '1', 08:38:00 INFO - 'PAGER': '/bin/cat', 08:38:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:00 INFO - 'PWD': '/builds/slave/test', 08:38:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:38:00 INFO - 'SHELL': '/bin/bash', 08:38:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.49WCBtit4m/Listeners', 08:38:00 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 08:38:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:38:00 INFO - 'USER': 'cltbld', 08:38:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:38:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:00 INFO - 'XPC_FLAGS': '0x0', 08:38:00 INFO - 'XPC_SERVICE_NAME': '0', 08:38:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:38:00 INFO - Cleaning up... 08:38:00 INFO - Return code: 0 08:38:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:38:00 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:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:00 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:38:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:00 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 0x107645490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075bb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5b3c916d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107459d30>, '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 0x1072bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107451b20>, '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.166LJAyEcM/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.49WCBtit4m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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:38:00 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:38:00 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:38:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.166LJAyEcM/Render', 08:38:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:38:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:38:00 INFO - 'HOME': '/Users/cltbld', 08:38:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:38:00 INFO - 'LOGNAME': 'cltbld', 08:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:00 INFO - 'MOZ_NO_REMOTE': '1', 08:38:00 INFO - 'NO_EM_RESTART': '1', 08:38:00 INFO - 'PAGER': '/bin/cat', 08:38:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:00 INFO - 'PWD': '/builds/slave/test', 08:38:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:38:00 INFO - 'SHELL': '/bin/bash', 08:38:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.49WCBtit4m/Listeners', 08:38:00 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 08:38:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:38:00 INFO - 'USER': 'cltbld', 08:38:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:38:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:00 INFO - 'XPC_FLAGS': '0x0', 08:38:00 INFO - 'XPC_SERVICE_NAME': '0', 08:38:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:38:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:01 INFO - Downloading/unpacking blobuploader==1.2.4 08:38:01 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:38:01 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:38:01 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:38:01 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:38:01 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:38:01 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:38:03 INFO - Downloading blobuploader-1.2.4.tar.gz 08:38:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:38:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:38:03 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:38:03 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:38:03 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:38:03 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:38:03 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:38:03 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:38:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:38:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:04 INFO - Downloading docopt-0.6.1.tar.gz 08:38:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:38:04 INFO - Installing collected packages: blobuploader, requests, docopt 08:38:04 INFO - Running setup.py install for blobuploader 08:38:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:38:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:38:05 INFO - Running setup.py install for requests 08:38:05 INFO - Running setup.py install for docopt 08:38:05 INFO - Successfully installed blobuploader requests docopt 08:38:05 INFO - Cleaning up... 08:38:05 INFO - Return code: 0 08:38:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:05 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 0x107645490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075bb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5b3c916d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107459d30>, '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 0x1072bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107451b20>, '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.166LJAyEcM/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.49WCBtit4m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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:38:05 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:38:05 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:38:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.166LJAyEcM/Render', 08:38:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:38:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:38:05 INFO - 'HOME': '/Users/cltbld', 08:38:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:38:05 INFO - 'LOGNAME': 'cltbld', 08:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:05 INFO - 'MOZ_NO_REMOTE': '1', 08:38:05 INFO - 'NO_EM_RESTART': '1', 08:38:05 INFO - 'PAGER': '/bin/cat', 08:38:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:05 INFO - 'PWD': '/builds/slave/test', 08:38:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:38:05 INFO - 'SHELL': '/bin/bash', 08:38:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.49WCBtit4m/Listeners', 08:38:05 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 08:38:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:38:05 INFO - 'USER': 'cltbld', 08:38:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:38:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:05 INFO - 'XPC_FLAGS': '0x0', 08:38:05 INFO - 'XPC_SERVICE_NAME': '0', 08:38:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:38:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:38:06 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-prG8Py-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:38:06 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-BQyj27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:38:06 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-ziFX3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:38:06 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-FYvPEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:38:06 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-2g7jU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:38:06 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-KE7HUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:38:06 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-b0f4kB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:38:06 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-kCrZAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:38:06 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-g5lFbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:38:07 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-bQCAmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:38:07 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-4QJQsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:38:07 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-Z91hwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:38:07 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-Hp1Xbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:38:07 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-8psXsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:07 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-f97gLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:38:07 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-BGIS8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:38:07 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-c9waxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:38:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:38:07 INFO - Running setup.py install for manifestparser 08:38:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:38:08 INFO - Running setup.py install for mozcrash 08:38:08 INFO - Running setup.py install for mozdebug 08:38:08 INFO - Running setup.py install for mozdevice 08:38:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:38:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:38:08 INFO - Running setup.py install for mozfile 08:38:08 INFO - Running setup.py install for mozhttpd 08:38:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:38:08 INFO - Running setup.py install for mozinfo 08:38:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:38:08 INFO - Running setup.py install for mozInstall 08:38:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:38:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:38:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:38:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:38:09 INFO - Running setup.py install for mozleak 08:38:09 INFO - Running setup.py install for mozlog 08:38:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:38:09 INFO - Running setup.py install for moznetwork 08:38:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:38:09 INFO - Running setup.py install for mozprocess 08:38:09 INFO - Running setup.py install for mozprofile 08:38:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:38:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:38:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:38:09 INFO - Running setup.py install for mozrunner 08:38:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:38:10 INFO - Running setup.py install for mozscreenshot 08:38:10 INFO - Running setup.py install for moztest 08:38:10 INFO - Running setup.py install for mozversion 08:38:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:38:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:38:10 INFO - Cleaning up... 08:38:10 INFO - Return code: 0 08:38:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:38:10 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:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:10 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:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:10 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 0x107645490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075bb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5b3c916d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107459d30>, '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 0x1072bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107451b20>, '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.166LJAyEcM/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.49WCBtit4m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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:38:10 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:38:10 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:38:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.166LJAyEcM/Render', 08:38:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:38:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:38:10 INFO - 'HOME': '/Users/cltbld', 08:38:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:38:10 INFO - 'LOGNAME': 'cltbld', 08:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:10 INFO - 'MOZ_NO_REMOTE': '1', 08:38:10 INFO - 'NO_EM_RESTART': '1', 08:38:10 INFO - 'PAGER': '/bin/cat', 08:38:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:10 INFO - 'PWD': '/builds/slave/test', 08:38:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:38:10 INFO - 'SHELL': '/bin/bash', 08:38:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.49WCBtit4m/Listeners', 08:38:10 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 08:38:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:38:10 INFO - 'USER': 'cltbld', 08:38:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:38:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:10 INFO - 'XPC_FLAGS': '0x0', 08:38:10 INFO - 'XPC_SERVICE_NAME': '0', 08:38:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:38:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:38:10 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-CDRcv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:38:10 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:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:38:10 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-_IKcvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:38:10 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:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:38:10 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-fFHN5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:38:11 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:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:38:11 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-2t1tZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:38:11 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-_7JkIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:38:11 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:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:38:11 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-ny6WeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:38:11 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:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:38:11 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-BXy960-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:38:11 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:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:38:11 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-Zeq_il-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:38:11 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:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:38:11 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-F5Ap9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:38:11 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:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:38:11 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-Qtrtya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:38:11 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:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:38:11 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-zIiSDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:38:11 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:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:38:11 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-iGeYZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:38:12 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-UYyRNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:38:12 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:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:38:12 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-H0BkVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:38:12 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:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:12 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-ro7wNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:12 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:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:38:12 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-VBJnY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:38:12 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-6k3YiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:38:12 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:38:12 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:38:12 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:38:12 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:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:38:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:38:12 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:38:12 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:38:12 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:38:12 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:38:12 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:38:12 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:38:15 INFO - Downloading blessings-1.6.tar.gz 08:38:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:38:15 INFO - Installing collected packages: blessings 08:38:15 INFO - Running setup.py install for blessings 08:38:15 INFO - Successfully installed blessings 08:38:15 INFO - Cleaning up... 08:38:15 INFO - Return code: 0 08:38:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:38:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:38:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:38:15 INFO - Reading from file tmpfile_stdout 08:38:15 INFO - Current package versions: 08:38:15 INFO - blessings == 1.6 08:38:15 INFO - blobuploader == 1.2.4 08:38:15 INFO - docopt == 0.6.1 08:38:15 INFO - functools32 == 3.2.3-2 08:38:15 INFO - jsonschema == 2.5.1 08:38:15 INFO - manifestparser == 1.1 08:38:15 INFO - mozInstall == 1.12 08:38:15 INFO - mozcrash == 1.0 08:38:15 INFO - mozdebug == 0.1 08:38:15 INFO - mozdevice == 0.48 08:38:15 INFO - mozfile == 1.2 08:38:15 INFO - mozhttpd == 0.7 08:38:15 INFO - mozinfo == 0.9 08:38:15 INFO - mozleak == 0.1 08:38:15 INFO - mozlog == 3.4 08:38:15 INFO - moznetwork == 0.27 08:38:15 INFO - mozprocess == 0.23 08:38:15 INFO - mozprofile == 0.28 08:38:15 INFO - mozrunner == 6.13 08:38:15 INFO - mozscreenshot == 0.1 08:38:15 INFO - mozsystemmonitor == 0.3 08:38:15 INFO - moztest == 0.7 08:38:15 INFO - mozversion == 1.4 08:38:15 INFO - psutil == 3.1.1 08:38:15 INFO - requests == 1.2.3 08:38:15 INFO - wsgiref == 0.1.2 08:38:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:38:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:15 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 0x107645490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075bb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5b3c916d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107459d30>, '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 0x1072bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107451b20>, '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.166LJAyEcM/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.49WCBtit4m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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:38:15 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:38:15 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:38:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.166LJAyEcM/Render', 08:38:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:38:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:38:15 INFO - 'HOME': '/Users/cltbld', 08:38:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:38:15 INFO - 'LOGNAME': 'cltbld', 08:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:15 INFO - 'MOZ_NO_REMOTE': '1', 08:38:15 INFO - 'NO_EM_RESTART': '1', 08:38:15 INFO - 'PAGER': '/bin/cat', 08:38:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:15 INFO - 'PWD': '/builds/slave/test', 08:38:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:38:15 INFO - 'SHELL': '/bin/bash', 08:38:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.49WCBtit4m/Listeners', 08:38:15 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 08:38:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:38:15 INFO - 'USER': 'cltbld', 08:38:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:38:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:15 INFO - 'XPC_FLAGS': '0x0', 08:38:15 INFO - 'XPC_SERVICE_NAME': '0', 08:38:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:38:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:15 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:38:15 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:38:15 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:38:15 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:38:15 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:38:15 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:38:15 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:38:15 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:38:15 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:38:15 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:38:15 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:38:15 INFO - Cleaning up... 08:38:15 INFO - Return code: 0 08:38:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:38:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107645490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075bb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5b3c916d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107459d30>, '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 0x1072bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107451b20>, '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.166LJAyEcM/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.49WCBtit4m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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:38:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:38:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:38:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.166LJAyEcM/Render', 08:38:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:38:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:38:15 INFO - 'HOME': '/Users/cltbld', 08:38:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:38:15 INFO - 'LOGNAME': 'cltbld', 08:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:15 INFO - 'MOZ_NO_REMOTE': '1', 08:38:15 INFO - 'NO_EM_RESTART': '1', 08:38:15 INFO - 'PAGER': '/bin/cat', 08:38:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:15 INFO - 'PWD': '/builds/slave/test', 08:38:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:38:15 INFO - 'SHELL': '/bin/bash', 08:38:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.49WCBtit4m/Listeners', 08:38:15 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 08:38:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:38:15 INFO - 'USER': 'cltbld', 08:38:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:38:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:15 INFO - 'XPC_FLAGS': '0x0', 08:38:15 INFO - 'XPC_SERVICE_NAME': '0', 08:38:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:38:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:38:16 INFO - Cleaning up... 08:38:16 INFO - Return code: 0 08:38:16 INFO - Running post-action listener: _resource_record_post_action 08:38:16 INFO - Running post-action listener: _start_resource_monitoring 08:38:16 INFO - Starting resource monitoring. 08:38:16 INFO - [mozharness: 2016-12-10 16:38:16.262481Z] Finished create-virtualenv step (success) 08:38:16 INFO - [mozharness: 2016-12-10 16:38:16.263478Z] Running install step. 08:38:16 INFO - Running pre-action listener: _resource_record_pre_action 08:38:16 INFO - Running main action method: install 08:38:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:38:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:38:16 INFO - Reading from file tmpfile_stdout 08:38:16 INFO - Detecting whether we're running mozinstall >=1.0... 08:38:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:38:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:38:16 INFO - Reading from file tmpfile_stdout 08:38:16 INFO - Output received: 08:38:16 INFO - Usage: mozinstall [options] installer 08:38:16 INFO - Options: 08:38:16 INFO - -h, --help show this help message and exit 08:38:16 INFO - -d DEST, --destination=DEST 08:38:16 INFO - Directory to install application into. [default: 08:38:16 INFO - "/builds/slave/test"] 08:38:16 INFO - --app=APP Application being installed. [default: firefox] 08:38:16 INFO - mkdir: /builds/slave/test/build/application 08:38:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:38:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:38:47 INFO - Reading from file tmpfile_stdout 08:38:47 INFO - Output received: 08:38:47 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:38:47 INFO - Running post-action listener: _resource_record_post_action 08:38:47 INFO - [mozharness: 2016-12-10 16:38:47.715657Z] Finished install step (success) 08:38:47 INFO - [mozharness: 2016-12-10 16:38:47.715844Z] Running run-tests step. 08:38:47 INFO - Running pre-action listener: _resource_record_pre_action 08:38:47 INFO - Running main action method: run_tests 08:38:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:38:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:38:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:38:47 INFO - 2016-12-10 08:38:47.730 screenresolution[1624:8279] starting screenresolution argv=screenresolution get 08:38:47 INFO - 2016-12-10 08:38:47.732 screenresolution[1624:8279] Display 0: 1600x1200x32@60 08:38:47 INFO - 2016-12-10 08:38:47.738 screenresolution[1625:8281] starting screenresolution argv=screenresolution list 08:38:47 INFO - Available Modes on Display 0 08:38:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:38:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:38:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:38:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:38:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:38:47 INFO - Intel Iris: 08:38:47 INFO - Chipset Model: Intel Iris 08:38:47 INFO - Type: GPU 08:38:47 INFO - Bus: Built-In 08:38:47 INFO - VRAM (Dynamic, Max): 1536 MB 08:38:47 INFO - Vendor: Intel (0x8086) 08:38:47 INFO - Device ID: 0x0a2e 08:38:47 INFO - Revision ID: 0x0009 08:38:47 INFO - Displays: 08:38:47 INFO - Display: 08:38:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:38:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:38:47 INFO - Display Serial Number: 1600x1200 60 08:38:47 INFO - Main Display: Yes 08:38:47 INFO - Mirror: Off 08:38:47 INFO - Online: Yes 08:38:47 INFO - Rotation: Supported 08:38:47 INFO - Return code: 0 08:38:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:38:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:38:47 INFO - Python 2.7.3 08:38:47 INFO - Return code: 0 08:38:47 INFO - grabbing minidump binary from tooltool 08:38:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:47 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 0x107459d30>, '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 0x1072bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107451b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:38:47 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:38:47 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:38:47 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:38:48 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:38:48 INFO - Return code: 0 08:38:48 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:38:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:38:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:38:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:38:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:38:48 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/Jilm3JjLSsiooJi7dMFeCw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0193', '--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:38:48 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/Jilm3JjLSsiooJi7dMFeCw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0193 --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:38:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.166LJAyEcM/Render', 08:38:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:38:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:38:48 INFO - 'HOME': '/Users/cltbld', 08:38:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:38:48 INFO - 'LOGNAME': 'cltbld', 08:38:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:38:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:38:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:48 INFO - 'MOZ_NO_REMOTE': '1', 08:38:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:38:48 INFO - 'NO_EM_RESTART': '1', 08:38:48 INFO - 'PAGER': '/bin/cat', 08:38:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:38:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:48 INFO - 'PWD': '/builds/slave/test', 08:38:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:38:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:38:48 INFO - 'SHELL': '/bin/bash', 08:38:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.49WCBtit4m/Listeners', 08:38:48 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 08:38:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:38:48 INFO - 'USER': 'cltbld', 08:38:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:38:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:38:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:48 INFO - 'XPC_FLAGS': '0x0', 08:38:48 INFO - 'XPC_SERVICE_NAME': '0', 08:38:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:38:48 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/Jilm3JjLSsiooJi7dMFeCw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0193', '--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:38:48 INFO - mozversion application_buildid: 20161210063616 08:38:48 INFO - mozversion application_changeset: 2ec25b58608c6e815b1b6b2901561adb0d24e9d3 08:38:48 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:38:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:38:48 INFO - mozversion application_name: Firefox 08:38:48 INFO - mozversion application_remotingname: firefox-dev 08:38:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:38:48 INFO - mozversion application_vendor: Mozilla 08:38:48 INFO - mozversion application_version: 52.0a2 08:38:48 INFO - mozversion platform_buildid: 20161210063616 08:38:48 INFO - mozversion platform_changeset: 2ec25b58608c6e815b1b6b2901561adb0d24e9d3 08:38:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:38:48 INFO - mozversion platform_version: 52.0a2 08:38:48 INFO - using testdate: 1481387928 08:38:48 INFO - actual date: 1481387928 08:38:48 INFO - starting webserver on 'localhost:49248' 08:38:48 INFO - SUITE-START | Running 2 tests 08:38:48 INFO - TEST-START | dromaeo_css 08:38:48 INFO - operating with platform_type : mac_ 08:38:48 INFO - Initialising browser for dromaeo_css test... 08:38:48 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/tmpZCRx0G/profile http://localhost:49248/getInfo.html) 08:38:51 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 08:38:51 INFO - PROCESS | 1635 | colorDepth:24 08:38:51 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 08:38:51 INFO - PROCESS | 1635 | __metrics 08:38:51 INFO - PROCESS | 1635 | 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:38:51 INFO - PROCESS | 1635 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:38:52 INFO - TEST-INFO | 1635: exit 0 08:38:52 INFO - Browser initialized. 08:38:52 INFO - Running cycle 1/1 for dromaeo_css test... 08:38:52 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/tmpZCRx0G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:39:04 INFO - PROCESS | 1638 | RSS: Main: 222535680 08:39:04 INFO - PROCESS | 1638 | 08:39:55 INFO - PROCESS | 1638 | 1481387995659 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:42:08 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49248/tests/dromaeo/cssquery-ext.html) 08:42:10 INFO - PROCESS | 1638 | RSS: Main: 345604096 08:42:10 INFO - PROCESS | 1638 | 08:45:13 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-ext.html (next: http://localhost:49248/tests/dromaeo/cssquery-jquery.html) 08:45:13 INFO - PROCESS | 1638 | RSS: Main: 351420416 08:45:13 INFO - PROCESS | 1638 | 08:48:16 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49248/tests/dromaeo/cssquery-mootools.html) 08:48:16 INFO - PROCESS | 1638 | RSS: Main: 322031616 08:48:16 INFO - PROCESS | 1638 | 08:51:19 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49248/tests/dromaeo/cssquery-prototype.html) 08:51:19 INFO - PROCESS | 1638 | RSS: Main: 328773632 08:51:19 INFO - PROCESS | 1638 | 08:54:22 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49248/tests/dromaeo/cssquery-yui.html) 08:54:23 INFO - PROCESS | 1638 | RSS: Main: 311373824 08:54:23 INFO - PROCESS | 1638 | 08:57:26 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-yui.html (next: http://localhost:49248/tests/dromaeo/cssquery-dojo.html) 08:57:26 INFO - PROCESS | 1638 | RSS: Main: 383700992 08:57:26 INFO - PROCESS | 1638 | 08:57:26 INFO - PROCESS | 1638 | __start_tp_report 08:57:26 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 08:57:26 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 08:57:26 INFO - PROCESS | 1638 | |i|pagename|runs| 08:57:26 INFO - PROCESS | 1638 | |0;dojo.html;2885.3075261937133;3311.0563489405517;3351.8324083795806;3360.6639336066382;3379.3410284994434;5578.4142665020145;5654.46282603153;5667.773289068437;5693.146028095788;5699.68651724155;5632.986062508747;5694.060480020791;5715.799947001856;5718.285214348207;5761.452661997114;5159.071367153911;5183.196604526304;5190.896182076356;5203.9219411708855;5217.843464696065;5112.003159383921;5130.07658621448;5136.563392111675;5269.156934890419;5319.654222475546;5141.717205553693;5202.271681964528;5210.140326846066;5231.450697676746;5240.528352448279;5152.51051150142;5173.870653233662;5180.222966555009;5185.066687996159;5239.16173412256;5057.266696329012;5161.870953226162;5165.483451654842;5175.844724658228;5219.739013049332;5408.91886621701;5451.672899626035;5459.563234941234;5552;5650.378458369576;6136.500946189515;6186.690665466754;6211.161493198406;6214.40963108504;6224.62652240867;6185;6205.441510264098;6206.193194884636;6218.564700470969;6237.407446292595;5638.802641907513;5706.087026075808;5706.914396284059;5809.622374545641;5856.560757943086;6131.418907120749;6161.383861613893;6163.3528479509005;6246.906296405557;6247.5939063960695;6131.202943617302;6142.017277235621;6142.293636231801;6156.938430615726;6160.630362178284;6088.786892458743;6134.294556126013;6137.60105593135;6201.007838745779;6203.96898015507;6092.939070609237;6093.025115981422;6130.275842464154;6139.386061393914;6143.27988163315;5143;6187.752489900444;6194.752209911643;6210.875782484325;6212.937870621236;4877.414710234794;4907.190313598217;4911.50884911506;4916.385451818523;4932.926006109911;4335.349697545394;4352.651787856964;4358.302671572596;4378.715383500126;4379.0585024219945;5700.315962084576;5733.713314334266;5777.711114444345;5777.94222057774;5856.941430585724;6203.286622038523;6210.627362358183;6219.222597175353;6225.564210505221;6239.157713708682;5540.750666220029;5590.496855283044;5771;5780.797672081457;5814.04068328721;5327.200919862052;5340;5342.946570534323;5345.67925924438;5349.5720342372515;6198.721057552421;6211.751529938751;6235.438810507076;6243.625382477066;6328.46208072319;6195.597286176384;6213.1922850029205;6217.595856269328;6217.937820621736;6219.40915613016;6120.7551697931585;6299.905501417391;6301.243850737941;6313.337099604659;6331.620102793847;6016.067509536029;6076.483498902643;6087.726052327567;6091.482224011009;6165.84585385369;6005.549583781147;6193.1329613853195;6228.190335256388;6228.875422491434;6234.688265586793;6007.420873073083;6076.240469941257;6095.872263631242;6098.359672234529;6112.083187521907;5945.762169513171;5975.970120149372;5996.700164991646;6060.545459090497;6069.302030266399;4994.350734404504;5868.149118377726;5931.288245410578;5935.792247271324;5993.61041532299;6049.364816694184;6063.605865618721;6064.969675151596;6067.514598832171;6077.301110372364;5708.4862362387585;5815.4184581543195;5913.91129133072;5929.229200203946;5942.494887934401 08:57:26 INFO - PROCESS | 1638 | |1;ext.html;498.6384870968548;512.848709630659;520.1755217979502;527.609568919;586.1091141464976;29961.550576741367;38539.80730096349;39752.99999999993;39815.203695926066;41735.58264417355;40942;41364.96587585312;41444.37833432493;41475.792621036926;41575.58424415755;9264.861027084598;9407.717768466922;9414.435133891955;9423.104805043544;9440.81118377632;9404;9460.668876589321;9507.857382139273;9518.714438566854;9519.762005949871;9446;9512.809743805119;9525.380850244746;9553.61785528578;9559.235261179088;8127.471714338608;9406.200472959807;9501.42991420517;9516.333856630039;9519.809603807886;9255.814883702289;9342.299327550461;9343.859842102374;9353.298502612332;9379.718608441757;31882.362352753047;32093.679063209536;32378;32390;32391;3164.810111393324;3202.9199270018203;3615.4757560153894;3789.3936970084656;3861.1891502784447;28607.57088643672;29957.25106872324;29959.089063010706;30340.63467143984;30623.234419139477;3036.832974186419;3127.874885004597;3146.480830662938;3172.032530078325;3208.374366998436;469407;469628;472700;473827;474794;32602;59209.11186332208;59687.40312596905;59763.10355344673;59875.10187347193;33444.16389590231;34893.9531814046;34927.30145397078;34929.1267718304;34972.65027349745;13933.233672147926;14035.035095086696;14045.929770351082;14063.437462501386;14069.155850648995;11961.940190298992;12071.275723456622;12080.335581542924;12088.637340879788;12119.515219391302;7670.42471814605;7683.308502234826;7743.922560774433;7763;7782.299593036654;3154.069549482908;3155.794873333226;3194.712475877182;3195.3609278144463;3228.9838550807567;825.7605294464659;863.3956230638578;921.3320342751451;956.5456408206186;987.086944576264;29065;29122.417551648847;29130.563041554393;29823.570289416562;30004.399912002074;1017.7811770469236;1021.2851004297022;1031.185114199;1101.24014430043;1173.8650055243586;12300.753984920431;14956.700865982619;15101.39594416233;15385.307661155275;15432.691346173013;673349;681218;682182;682362;683682;56874.43125568774;57468;57481.85036299334;57549.84900302054;57563.13655295174;1363.5841068474012;1365.6722386627337;1390.7913812927939;1393.3033483258168;1394.3585950462698;28168.577471337536;28713.856430718548;28745.281367965967;29186.854065729534;29251.561226582045;53465.732671336395;55268;55345;58539.4146058551;58703.70648146732;529436.7056329541;605823;612788;619659.9017004886;620295;40171.994431977815;40839.38740918829;41343.7932810334;41433.58566414297;41644.791776040925;44975.550244497135;45702;45824;45888;46127.53872461232;37280.254394912496;37460.2507949834;37615;37788.43317350297;38860;37678;37759.16806239488;37940.62059379371;38294.80852595719;38922.02694932649;36122.81938590395;36652;37340;37518.624813751514;37725.62274377331;32481.512777307886;34044.58836716901;34417.31165376728;34662.65337346695;34734.131646708025;25206.24381268565;25264.368390790376;25396.746032540177;25529.23412297634;25687 08:57:26 INFO - PROCESS | 1638 | |2;jquery.html;348.2460473075791;373.2274192421687;374.974444893217;383.42869125003745;405.78898972534284;13527.79708304375;14748.77876831847;15642.765358519602;20164.697529537032;20583.382498525032;19263.903680481577;19705.211791528323;20356.796432035677;20464.590708185828;20481.897590512064;5512.751926163332;5611.270534830466;5916.733746981375;5933.050711886099;5942.138389933457;5299.364076310848;5744.79893203738;5784.710764461781;5811.099279611667;5814.912776308338;5230.666180124063;5495.780168793263;5505.981393442206;5755.136729490589;5775.104858746901;5702.857428564298;5812.709364531756;5835.474807267324;5836.037053886103;5838;5561.499465048165;5660.094384898438;5661.122526008476;5933.851653708649;6026.6986650667295;13337.866621333857;13413.530526431528;13432.731345373135;13629.795553066711;13662.11196272249;2321.1527792355837;2334.498082912182;2352.188494969233;2400.8319417640773;2412.613981762927;8303.750887473385;9619.855702164474;10254.384736915808;10267.178625709925;10281.126104281146;1808.638272345536;1856.58226898948;1860.7767067951797;1890.1399863062275;1926.8651194416395;95458.52270738671;117364;117383;124155;126482.30829612598;11573.652790416301;11623.476943537393;11696;11717.355545444912;11887.16789824704;14777.778333325008;14800;14802.111873287637;14821.481248156262;14824.851751482347;8251.752447426587;8504.107068757692;8529;8566.057733649293;8625.654973801104;7010.579365238102;8386.329093672492;8408.915910840935;8414.579271036546;8435.072142064368;3799;4612.723236605814;4615.469221039556;4666.113438446752;4691.319758635047;1603.5189443167003;1860.2001139510141;1899.135893168605;1909.131345237941;1910.388675623787;720.2293545905935;864.0840708848641;874.230677004245;909.5543183840003;930.8464103422859;16993.320267189174;17379.655086228442;19893.905835179205;21298;21421.357359279245;773.6982576795054;888.8755574219614;906.2795077913075;917.9357444978788;919.9816003679889;9869.506524673881;11089.889101109047;11100.44497775108;11156.665300041012;11175.944120279346;619091;621262;627313;635945;638395.8080209569;129197;132071.33964330118;136832;138234;141983;950.805084957582;959.5394210778866;986.6645340584236;994.2741798487;1021.918246540275;18173;18500.0749962504;18654.160562774978;18712.719309210646;18932.905335473235;54598.727006364716;55623.443765561824;56259;57077.85844283174;57948.710256448445;76586.23413765791;80716.19283807321;82745.75881361665;83097.58451207705;84888.30223395622;5347.465253474621;6544.345565443608;7576.848463030598;8122.187781221831;8321.375896807642;11956;12514.624561263177;12536.498540058295;12663.746725065263;12725;10772.084372828398;10887.618933337295;11072.446377680923;11345.432728363714;11407.885921140682;10681.359118452918;10901.945490272497;10942.890571094506;11002.889971100507;11114;10910.345379277269;11170.385628790495;11346;11493.252938558968;11561.537538498365;7868.72459463916;8065.596720164086;8283.50298982063;8359.37304702162;8440.113788052166;8366.372522060748;9059.68291109808;9310.906890931004;9434.952825236105;9551.283653725859 08:57:26 INFO - PROCESS | 1638 | |3;mootools.html;1258.3833921378528;1444.8844092472602;1488.799012133362;1616.2645996071788;1803.5040363899925;7435.996140521035;7828.138904720477;8121.147279535645;8385.664573417056;8393.91606083939;8244.793880153;8339.33285337173;8349.457285276452;8351.83296334073;8354.206350396702;2296.4258935266143;2343.7070366204225;2351.988240058797;2354.4349356154485;2365.3495288795634;2320.6054970654945;2367.112332875172;2371.5494056129282;2371.8695471749047;2379.940501487468;2315.837891347598;2316.895739691718;2341.531693661266;2345.9765402346015;2350.0129945422964;2133.797289257518;2138.32642717545;2299.466036023987;2301.137073597401;2324.418895276181;2326.988365058181;2350.4828937633692;2352.7059117610297;2354.7409784923643;2362.787349138586;8103.594820258963;8226.177382261785;8426.199511046441;8443;8485.0666426693;4487.39420178275;4957.231629097496;5185.637005409623;5197.038547868657;5232.92150617741;3418.435958066916;3493.598236202844;3529.523514325559;3578.499010138583;3580.1228698968657;1057.1648397765755;1082.2532452607675;1084.078533246742;1091.612477570459;1106.80630889594;10792.838107428395;10819.83770243447;10889.727756806064;10890.074343680797;10891.564337426415;4122.134351786159;4370.409994650745;4462.732236065846;4464.241079016575;4470.2177119004045;8615.353848461391;8635.740927772176;8651.091635378321;8656.78804967305;8671.349648776368;5090.974545127325;5120.231965205249;5123.2827404163445;5124.795008199705;5129.410117836422;4052.5542190359038;4324.394584758136;4449.087936972913;4472;4803.375561177095;3610.368185567515;3649.7810131392202;3718.200586873835;3725.5343082114737;3732.0669832541867;1139.1342579639534;1141.7431078007382;1142.7771584540935;1159.1306520109918;1160.8955194032578;836.7029704454831;840.6843290250738;854.9145085491401;900.6037343568809;925.2181906289175;5230.402147437536;5233.215017747369;5302.602304827154;5506.697131657797;5540.722963851791;753.6420200404764;823.7652269103277;874.3355050161923;874.5670892908051;886.0873300500494;3391.796492210475;3411.9488207676904;3545.804980726033;3563.679268865763;3628.401313783249;9686.70939871805;10137.189024877993;10274.972502749815;10291.94854025725;10307.587696492057;9977.650782222732;10126.848097278547;10337.431441270803;10377.636782712569;10379.688609341732;7804.804879878048;7824.765257042298;7835.8525709206715;7917.683292668229;7988.242586630932;5197.064528384776;5214.2960700304975;5232.843014709565;5248.212768084665;5261.894762104813;9270.814583708154;9371.484568348806;9416.764580885532;9484.336096473457;9549.952250238704;9336.159745622926;9575.23398128134;9617.807643847224;9630.47032413196;9674.274429417681;6661.4004739573675;6732.899006514808;6754;6820.897686534805;6836.179658441019;7813.882791758242;7838.725644602411;7873.448858580074;7927.881081783893;7935.40484463656;7042.753503627348;7155;7176;7222.458315626244;7304.780856574312;6982.860342793014;7009.894851577128;7010.193827709879;7030.824229394306;7082.893756593552;6630.53586248958;6659.2008958925235;6669.966650166718;6731.966340168464;6736.8652626946205;4680.4149481314835;4691.906161876812;4739.739314337745;4766.404199475066;4797.472278049481;4813;4862.635302352267;4905.632077594266;4966.801327946841;5036.322507996884 08:57:26 INFO - PROCESS | 1638 | |4;prototype.html;258.9197348821865;297.87489254513105;302.2835878966849;311.6618468961177;314.7953830010492;4248.044190057236;4670.743109128996;4978.502149785019;5219.973900130499;5235.319408476902;4530.388397566336;4585.908281834361;4842.612590992721;4962.503749625036;5047.495250474951;3660.9200285915717;3808.2961097620723;3897.49332586764;3920.8435360551725;3953.794092801694;3052.923676908073;3784.3566593679;4000.5799391063956;4013.514999450193;4021.2962731521866;3619.348517266891;3872.9473379108977;3930.4693866328107;3935.0752573145287;3953.1303113315025;3295.555100061485;3732.898794855524;3846.38457846746;3909.061825161955;3938.822752976123;2822.8447435391045;3269.591301087364;3325.6009278886445;3416.24842534642;3447.1037530242065;4413.3821265022925;4937.580305674022;4987.650864439491;5006.849794506171;5100.489951004907;3731.589525152231;3881.4565960765517;4238.978805105986;4332.740035597874;4500.054988452429;4437.622802061828;4461.643068554507;4896.412430508326;5348.064088784447;5370.812021579265;3004.459197344477;3724;3730.4404339349044;3740.7942563159017;3744.9625503744887;5537;5623.738231825531;5657.8019769307875;5669.489745922887;5673;3083.6607973122937;3585.4442561403025;3758.8308526115843;3790.65884070435;3798.8860334190017;3693.261347730465;3778.414345776354;3839.2897313997;3849.942250866239;3872.6058618897173;3870.5161854768153;4151.709380343407;4449.1536012554425;4450.065486247924;4502.279635258343;5141.434442211354;5328.081890519487;5389.595780316492;5391.7304134793885;5488.588355873246;1164.8660404053473;1205.7287110400089;1209.9715242044192;1221.3221661977689;1223.7858374784378;810.4367464612038;831.3556993330096;836.8702851058096;846.9407141500159;851.1360968616859;4187.706860519735;4403.864125898936;4616.884577885513;4817.278237795635;4864.586510146606;4459.034741896602;4715.905681886343;5015.3730783652045;5083.186690129562;5238.659487133325;4635.8841028973875;4755.7159566917435;4794.808207671724;4806.750244936272;4842.353599776093;2374.6820514614556;2425.6361545767923;2541.5727979779267;2630.2898217481174;2746.945061098767;4344.9137715571105;5126.743662816844;5352.759125839347;5360;5460.481254280837;4888.413390393175;5358.223057656696;5374;5379.515843574019;5380.596455265871;4505.7521836298665;5413.945860541423;5431.321084864392;5443.428440013741;5505.623594101475;4821.95178048215;5052.898942021213;5058.924116138334;5212.791488340576;5219.269302297757;4911.484294149206;4912.214045752806;4965.900681986413;5003.749812509287;5018.623603229846;4667.463241727245;5002.774875130701;5389.676619402849;5459.727013649381;5495.835124946258;3103.9224019399694;3577.8032208228797;3578.481120237603;3578.964210357863;3581.1020159315603;5122.668106292316;5195.584053415029;5251.763670634754;5267.20837955884;5280.339957505312;4643.558861908114;4896.4124305083615;5013.24801279811;5511.984094474009;5520.199571062254;5457.197666053848;5474.91787623178;5484.73851014261;5484.890302193854;5503.449655034465;5194.68831870089;5291;5333.893112220729;5351.5451186648015;5412.350517937873;5497.312835895513;5512.6692398456225;5522.392536821027;5535.948169847716;5551.389347171888;4319.935200971925;5201.401838788588;5393.8921221574565;5409.864753381197;5432.592555558428 08:57:26 INFO - PROCESS | 1638 | |5;yui.html;593.2910172344049;768.9269519395657;769.2499812682635;769.2807225244397;786.8504984053033;12353.691157721061;12970.610881673565;13913.582592522214;14685.77971330431;14688.559343219707;14191.71616567668;14675.412983480648;14760.557183284518;14849.331780069895;15101.244937753123;812.3947658994043;825.63671984327;835.5947365527744;841.6128580852784;843.6541018182546;652.2596852572341;671.9193696756396;800.519688187089;811.9472234304751;830.8961379827522;783.3224261014238;874.3136637739376;875.6628697951303;876.4522173641474;877.1360210192955;872.9519876406795;875.24728733289;876.9210771030638;877.4822854515802;879.9428037177563;649.7693318871779;651.8012006338065;652.8531080506896;653.8823011857863;654.4731491149622;13753.312334383241;13761.243131627756;13792.034557580973;13817.309134543233;13849.584512464642;12663.430145643468;13117.60647180586;13159.802602960963;13231.073824832265;13488.258145801978;11037.227394082418;11191.776164476665;11432.256903301259;11476.311421314747;11491.138164637685;3503.211777350076;3533.0460775590705;3598.2623562169692;3610.5847827499647;3726.7018638508853;77021;91179.99999999933;91455;92155.50794589684;93479.53260233723;10250.487475626189;10261.640842570474;10289.176865850714;10309.513084884748;10339.276250662382;19476.51308717265;19857.702134467996;19860.50348741293;19951.902645354647;20078.598428031357;6999.965000174967;7532.246775322534;7533.510321829063;7627.618619069024;7627.656755446018;4103.117829666636;4166.520850102277;4236.406903033578;4310.116426132635;4371.715838470489;3354.5135955286346;3435.6736110069505;3457.4122399192197;3463.7748546344405;3506.579210494706;635.8092572228313;643.0161852365887;645.3159650770199;645.6029541831833;661.2329697550817;584.7310237290894;617.6109051297653;621.4127649371301;621.6052806467835;673.6059405247887;8498.54125800322;8883;8908.910910890809;8984.640614375483;9177.77055573616;547.4361407750024;553.0459956574877;587.7384563869123;610.0635524469917;644.111161440937;4292.59220374064;4403.603675669206;4409.272470042407;4433;4463.709858859163;72582;97607.51196243973;106200;106628;112067;89991;90062.09937900538;92246.0775392251;93287;94291.52854235822;84951.57524212339;85055.14944850597;86859.56570217108;87693.56153219193;88527;8551.401401901807;8579.270761985052;8720.520371379635;8783.868241976248;8812.787883907198;53744;55026.17460738172;55874.72062639661;56670.716646416506;58869.82260354854;75864.62067689626;76937.61531192309;79669.80495292459;80988;83068.58465707632;11025.283356581796;11156.888431115909;11221.495032723711;11377.146713996317;11493.597724079616;10056.748581285527;12093.758124837277;12190.878091218974;12248.387580620754;12490.375481226085;11263.09895208365;11598.362090085126;11807.409629518317;11986;12262.570810021607;10795.460226988462;11663.59177428786;11803.114766392384;11882.28706277626;12365.887070163728;11352.602658906899;11587.536498540301;11973.940130299292;12434.937825310815;12501.06242031833;9847.556859941176;10026.949865250626;10036.297459177787;10313.690589282334;10443.582256709646;9728.418720244299;9867.654632087842;9877.703668889944;9896.802063958825;9970.750731231486 08:57:26 INFO - PROCESS | 1638 | __end_tp_report 08:57:26 INFO - PROCESS | 1638 | __start_cc_report 08:57:26 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,1499 08:57:26 INFO - PROCESS | 1638 | __end_cc_report 08:57:26 INFO - PROCESS | 1638 | __startTimestamp1481389046727__endTimestamp 08:57:26 INFO - PROCESS | 1638 | 08:57:26 INFO - PROCESS | 1638 | ------- Summary: start ------- 08:57:26 INFO - PROCESS | 1638 | Number of tests: 6 08:57:26 INFO - PROCESS | 1638 | 08:57:26 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5692.70 Median:5931.29 stddev:645.41 (10.9%) stddev-sans-first:608.65 08:57:26 INFO - PROCESS | 1638 | Values: 2885.3 3311.1 3351.8 3360.7 3379.3 5578.4 5654.5 5667.8 5693.1 5699.7 5633.0 5694.1 5715.8 5718.3 5761.5 5159.1 5183.2 5190.9 5203.9 5217.8 5112.0 5130.1 5136.6 5269.2 5319.7 5141.7 5202.3 5210.1 5231.5 5240.5 5152.5 5173.9 5180.2 5185.1 5239.2 5057.3 5161.9 5165.5 5175.8 5219.7 5408.9 5451.7 5459.6 5552.0 5650.4 6136.5 6186.7 6211.2 6214.4 6224.6 6185.0 6205.4 6206.2 6218.6 6237.4 5638.8 5706.1 5706.9 5809.6 5856.6 6131.4 6161.4 6163.4 6246.9 6247.6 6131.2 6142.0 6142.3 6156.9 6160.6 6088.8 6134.3 6137.6 6201.0 6204.0 6092.9 6093.0 6130.3 6139.4 6143.3 5143.0 6187.8 6194.8 6210.9 6212.9 4877.4 4907.2 4911.5 4916.4 4932.9 4335.3 4352.7 4358.3 4378.7 4379.1 5700.3 5733.7 5777.7 5777.9 5856.9 6203.3 6210.6 6219.2 6225.6 6239.2 5540.8 5590.5 5771.0 5780.8 5814.0 5327.2 5340.0 5342.9 5345.7 5349.6 6198.7 6211.8 6235.4 6243.6 6328.5 6195.6 6213.2 6217.6 6217.9 6219.4 6120.8 6299.9 6301.2 6313.3 6331.6 6016.1 6076.5 6087.7 6091.5 6165.8 6005.5 6193.1 6228.2 6228.9 6234.7 6007.4 6076.2 6095.9 6098.4 6112.1 5945.8 5976.0 5996.7 6060.5 6069.3 4994.4 5868.1 5931.3 5935.8 5993.6 6049.4 6063.6 6065.0 6067.5 6077.3 5708.5 5815.4 5913.9 5929.2 5942.5 08:57:26 INFO - PROCESS | 1638 | 08:57:26 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:70023.28 Median:21360.59 stddev:158227.28 (740.7%) stddev-sans-first:158585.04 08:57:26 INFO - PROCESS | 1638 | Values: 498.6 512.8 520.2 527.6 586.1 29961.6 38539.8 39753.0 39815.2 41735.6 40942.0 41365.0 41444.4 41475.8 41575.6 9264.9 9407.7 9414.4 9423.1 9440.8 9404.0 9460.7 9507.9 9518.7 9519.8 9446.0 9512.8 9525.4 9553.6 9559.2 8127.5 9406.2 9501.4 9516.3 9519.8 9255.8 9342.3 9343.9 9353.3 9379.7 31882.4 32093.7 32378.0 32390.0 32391.0 3164.8 3202.9 3615.5 3789.4 3861.2 28607.6 29957.3 29959.1 30340.6 30623.2 3036.8 3127.9 3146.5 3172.0 3208.4 469407.0 469628.0 472700.0 473827.0 474794.0 32602.0 59209.1 59687.4 59763.1 59875.1 33444.2 34894.0 34927.3 34929.1 34972.7 13933.2 14035.0 14045.9 14063.4 14069.2 11961.9 12071.3 12080.3 12088.6 12119.5 7670.4 7683.3 7743.9 7763.0 7782.3 3154.1 3155.8 3194.7 3195.4 3229.0 825.8 863.4 921.3 956.5 987.1 29065.0 29122.4 29130.6 29823.6 30004.4 1017.8 1021.3 1031.2 1101.2 1173.9 12300.8 14956.7 15101.4 15385.3 15432.7 673349.0 681218.0 682182.0 682362.0 683682.0 56874.4 57468.0 57481.9 57549.8 57563.1 1363.6 1365.7 1390.8 1393.3 1394.4 28168.6 28713.9 28745.3 29186.9 29251.6 53465.7 55268.0 55345.0 58539.4 58703.7 529436.7 605823.0 612788.0 619659.9 620295.0 40172.0 40839.4 41343.8 41433.6 41644.8 44975.6 45702.0 45824.0 45888.0 46127.5 37280.3 37460.3 37615.0 37788.4 38860.0 37678.0 37759.2 37940.6 38294.8 38922.0 36122.8 36652.0 37340.0 37518.6 37725.6 32481.5 34044.6 34417.3 34662.7 34734.1 25206.2 25264.4 25396.7 25529.2 25687.0 08:57:26 INFO - PROCESS | 1638 | 08:57:26 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:35637.53 Median:2091.21 stddev:104953.97 (5018.8%) stddev-sans-first:105214.95 08:57:26 INFO - PROCESS | 1638 | Values: 348.2 373.2 375.0 383.4 405.8 13527.8 14748.8 15642.8 20164.7 20583.4 19263.9 19705.2 20356.8 20464.6 20481.9 5512.8 5611.3 5916.7 5933.1 5942.1 5299.4 5744.8 5784.7 5811.1 5814.9 5230.7 5495.8 5506.0 5755.1 5775.1 5702.9 5812.7 5835.5 5836.0 5838.0 5561.5 5660.1 5661.1 5933.9 6026.7 13337.9 13413.5 13432.7 13629.8 13662.1 2321.2 2334.5 2352.2 2400.8 2412.6 8303.8 9619.9 10254.4 10267.2 10281.1 1808.6 1856.6 1860.8 1890.1 1926.9 95458.5 117364.0 117383.0 124155.0 126482.3 11573.7 11623.5 11696.0 11717.4 11887.2 14777.8 14800.0 14802.1 14821.5 14824.9 8251.8 8504.1 8529.0 8566.1 8625.7 7010.6 8386.3 8408.9 8414.6 8435.1 3799.0 4612.7 4615.5 4666.1 4691.3 1603.5 1860.2 1899.1 1909.1 1910.4 720.2 864.1 874.2 909.6 930.8 16993.3 17379.7 19893.9 21298.0 21421.4 773.7 888.9 906.3 917.9 920.0 9869.5 11089.9 11100.4 11156.7 11175.9 619091.0 621262.0 627313.0 635945.0 638395.8 129197.0 132071.3 136832.0 138234.0 141983.0 950.8 959.5 986.7 994.3 1021.9 18173.0 18500.1 18654.2 18712.7 18932.9 54598.7 55623.4 56259.0 57077.9 57948.7 76586.2 80716.2 82745.8 83097.6 84888.3 5347.5 6544.3 7576.8 8122.2 8321.4 11956.0 12514.6 12536.5 12663.7 12725.0 10772.1 10887.6 11072.4 11345.4 11407.9 10681.4 10901.9 10942.9 11002.9 11114.0 10910.3 11170.4 11346.0 11493.3 11561.5 7868.7 8065.6 8283.5 8359.4 8440.1 8366.4 9059.7 9310.9 9435.0 9551.3 08:57:26 INFO - PROCESS | 1638 | 08:57:26 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5387.62 Median:5105.60 stddev:2986.02 (58.5%) stddev-sans-first:2978.27 08:57:26 INFO - PROCESS | 1638 | Values: 1258.4 1444.9 1488.8 1616.3 1803.5 7436.0 7828.1 8121.1 8385.7 8393.9 8244.8 8339.3 8349.5 8351.8 8354.2 2296.4 2343.7 2352.0 2354.4 2365.3 2320.6 2367.1 2371.5 2371.9 2379.9 2315.8 2316.9 2341.5 2346.0 2350.0 2133.8 2138.3 2299.5 2301.1 2324.4 2327.0 2350.5 2352.7 2354.7 2362.8 8103.6 8226.2 8426.2 8443.0 8485.1 4487.4 4957.2 5185.6 5197.0 5232.9 3418.4 3493.6 3529.5 3578.5 3580.1 1057.2 1082.3 1084.1 1091.6 1106.8 10792.8 10819.8 10889.7 10890.1 10891.6 4122.1 4370.4 4462.7 4464.2 4470.2 8615.4 8635.7 8651.1 8656.8 8671.3 5091.0 5120.2 5123.3 5124.8 5129.4 4052.6 4324.4 4449.1 4472.0 4803.4 3610.4 3649.8 3718.2 3725.5 3732.1 1139.1 1141.7 1142.8 1159.1 1160.9 836.7 840.7 854.9 900.6 925.2 5230.4 5233.2 5302.6 5506.7 5540.7 753.6 823.8 874.3 874.6 886.1 3391.8 3411.9 3545.8 3563.7 3628.4 9686.7 10137.2 10275.0 10291.9 10307.6 9977.7 10126.8 10337.4 10377.6 10379.7 7804.8 7824.8 7835.9 7917.7 7988.2 5197.1 5214.3 5232.8 5248.2 5261.9 9270.8 9371.5 9416.8 9484.3 9550.0 9336.2 9575.2 9617.8 9630.5 9674.3 6661.4 6732.9 6754.0 6820.9 6836.2 7813.9 7838.7 7873.4 7927.9 7935.4 7042.8 7155.0 7176.0 7222.5 7304.8 6982.9 7009.9 7010.2 7030.8 7082.9 6630.5 6659.2 6670.0 6732.0 6736.9 4680.4 4691.9 4739.7 4766.4 4797.5 4813.0 4862.6 4905.6 4966.8 5036.3 08:57:26 INFO - PROCESS | 1638 | 08:57:26 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4268.72 Median:4812.01 stddev:1316.29 (27.4%) stddev-sans-first:1285.12 08:57:26 INFO - PROCESS | 1638 | Values: 258.9 297.9 302.3 311.7 314.8 4248.0 4670.7 4978.5 5220.0 5235.3 4530.4 4585.9 4842.6 4962.5 5047.5 3660.9 3808.3 3897.5 3920.8 3953.8 3052.9 3784.4 4000.6 4013.5 4021.3 3619.3 3872.9 3930.5 3935.1 3953.1 3295.6 3732.9 3846.4 3909.1 3938.8 2822.8 3269.6 3325.6 3416.2 3447.1 4413.4 4937.6 4987.7 5006.8 5100.5 3731.6 3881.5 4239.0 4332.7 4500.1 4437.6 4461.6 4896.4 5348.1 5370.8 3004.5 3724.0 3730.4 3740.8 3745.0 5537.0 5623.7 5657.8 5669.5 5673.0 3083.7 3585.4 3758.8 3790.7 3798.9 3693.3 3778.4 3839.3 3849.9 3872.6 3870.5 4151.7 4449.2 4450.1 4502.3 5141.4 5328.1 5389.6 5391.7 5488.6 1164.9 1205.7 1210.0 1221.3 1223.8 810.4 831.4 836.9 846.9 851.1 4187.7 4403.9 4616.9 4817.3 4864.6 4459.0 4715.9 5015.4 5083.2 5238.7 4635.9 4755.7 4794.8 4806.8 4842.4 2374.7 2425.6 2541.6 2630.3 2746.9 4344.9 5126.7 5352.8 5360.0 5460.5 4888.4 5358.2 5374.0 5379.5 5380.6 4505.8 5413.9 5431.3 5443.4 5505.6 4822.0 5052.9 5058.9 5212.8 5219.3 4911.5 4912.2 4965.9 5003.7 5018.6 4667.5 5002.8 5389.7 5459.7 5495.8 3103.9 3577.8 3578.5 3579.0 3581.1 5122.7 5195.6 5251.8 5267.2 5280.3 4643.6 4896.4 5013.2 5512.0 5520.2 5457.2 5474.9 5484.7 5484.9 5503.4 5194.7 5291.0 5333.9 5351.5 5412.4 5497.3 5512.7 5522.4 5535.9 5551.4 4319.9 5201.4 5393.9 5409.9 5432.6 08:57:26 INFO - PROCESS | 1638 | 08:57:26 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:20129.25 Median:28213.88 stddev:29591.92 (104.9%) stddev-sans-first:29638.57 08:57:26 INFO - PROCESS | 1638 | Values: 593.3 768.9 769.2 769.3 786.9 12353.7 12970.6 13913.6 14685.8 14688.6 14191.7 14675.4 14760.6 14849.3 15101.2 812.4 825.6 835.6 841.6 843.7 652.3 671.9 800.5 811.9 830.9 783.3 874.3 875.7 876.5 877.1 873.0 875.2 876.9 877.5 879.9 649.8 651.8 652.9 653.9 654.5 13753.3 13761.2 13792.0 13817.3 13849.6 12663.4 13117.6 13159.8 13231.1 13488.3 11037.2 11191.8 11432.3 11476.3 11491.1 3503.2 3533.0 3598.3 3610.6 3726.7 77021.0 91180.0 91455.0 92155.5 93479.5 10250.5 10261.6 10289.2 10309.5 10339.3 19476.5 19857.7 19860.5 19951.9 20078.6 7000.0 7532.2 7533.5 7627.6 7627.7 4103.1 4166.5 4236.4 4310.1 4371.7 3354.5 3435.7 3457.4 3463.8 3506.6 635.8 643.0 645.3 645.6 661.2 584.7 617.6 621.4 621.6 673.6 8498.5 8883.0 8908.9 8984.6 9177.8 547.4 553.0 587.7 610.1 644.1 4292.6 4403.6 4409.3 4433.0 4463.7 72582.0 97607.5 106200.0 106628.0 112067.0 89991.0 90062.1 92246.1 93287.0 94291.5 84951.6 85055.1 86859.6 87693.6 88527.0 8551.4 8579.3 8720.5 8783.9 8812.8 53744.0 55026.2 55874.7 56670.7 58869.8 75864.6 76937.6 79669.8 80988.0 83068.6 11025.3 11156.9 11221.5 11377.1 11493.6 10056.7 12093.8 12190.9 12248.4 12490.4 11263.1 11598.4 11807.4 11986.0 12262.6 10795.5 11663.6 11803.1 11882.3 12365.9 11352.6 11587.5 11973.9 12434.9 12501.1 9847.6 10026.9 10036.3 10313.7 10443.6 9728.4 9867.7 9877.7 9896.8 9970.8 08:57:26 INFO - PROCESS | 1638 | -------- Summary: end -------- 08:57:26 INFO - PROCESS | 1638 | 08:57:27 INFO - TEST-INFO | 1638: exit 0 08:57:27 INFO - TEST-OK | dromaeo_css | took 1119069ms 08:57:27 INFO - TEST-START | kraken 08:57:27 INFO - operating with platform_type : mac_ 08:57:27 INFO - Initialising browser for kraken test... 08:57:27 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/tmpjN0gjD/profile http://localhost:49248/getInfo.html) 08:57:29 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 08:57:29 INFO - PROCESS | 1643 | colorDepth:24 08:57:29 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 08:57:29 INFO - PROCESS | 1643 | __metrics 08:57:29 INFO - PROCESS | 1643 | 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:29 INFO - PROCESS | 1643 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:57:30 INFO - TEST-INFO | 1643: exit 0 08:57:30 INFO - Browser initialized. 08:57:30 INFO - Running cycle 1/1 for kraken test... 08:57:30 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/tmpjN0gjD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:57:43 INFO - PROCESS | 1644 | RSS: Main: 223064064 08:57:43 INFO - PROCESS | 1644 | 08:57:45 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection) 08:57:46 INFO - PROCESS | 1644 | RSS: Main: 270258176 08:57:46 INFO - PROCESS | 1644 | 08:57:49 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-dft) 08:57:49 INFO - PROCESS | 1644 | RSS: Main: 284094464 08:57:49 INFO - PROCESS | 1644 | 08:57:53 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-fft) 08:57:53 INFO - PROCESS | 1644 | RSS: Main: 380563456 08:57:53 INFO - PROCESS | 1644 | 08:57:55 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator) 08:57:56 INFO - PROCESS | 1644 | RSS: Main: 285253632 08:57:56 INFO - PROCESS | 1644 | 08:57:58 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:57:58 INFO - PROCESS | 1644 | RSS: Main: 287379456 08:57:58 INFO - PROCESS | 1644 | 08:58:01 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom) 08:58:02 INFO - PROCESS | 1644 | RSS: Main: 326512640 08:58:02 INFO - PROCESS | 1644 | 08:58:05 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate) 08:58:05 INFO - PROCESS | 1644 | RSS: Main: 326885376 08:58:05 INFO - PROCESS | 1644 | 08:58:08 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial) 08:58:08 INFO - PROCESS | 1644 | RSS: Main: 324460544 08:58:08 INFO - PROCESS | 1644 | 08:58:10 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:58:11 INFO - PROCESS | 1644 | RSS: Main: 300339200 08:58:11 INFO - PROCESS | 1644 | 08:58:13 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:58:13 INFO - PROCESS | 1644 | RSS: Main: 300384256 08:58:13 INFO - PROCESS | 1644 | 08:58:16 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:58:16 INFO - PROCESS | 1644 | RSS: Main: 302223360 08:58:16 INFO - PROCESS | 1644 | 08:58:19 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:58:20 INFO - PROCESS | 1644 | RSS: Main: 320876544 08:58:20 INFO - PROCESS | 1644 | 08:58:23 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:58:24 INFO - PROCESS | 1644 | RSS: Main: 314404864 08:58:24 INFO - PROCESS | 1644 | 08:58:25 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49248/tests/kraken/driver.html?testName=ai-astar) 08:58:26 INFO - PROCESS | 1644 | RSS: Main: 358395904 08:58:26 INFO - PROCESS | 1644 | 08:58:26 INFO - PROCESS | 1644 | __start_tp_report 08:58:26 INFO - PROCESS | 1644 | _x_x_mozilla_page_load 08:58:26 INFO - PROCESS | 1644 | _x_x_mozilla_page_load_details 08:58:26 INFO - PROCESS | 1644 | |i|pagename|runs| 08:58:26 INFO - PROCESS | 1644 | |0;ai-astar;104;115;113;113;115;116;113;111;115;114 08:58:26 INFO - PROCESS | 1644 | |1;audio-beat-detection;151;113;115;149;116;118;115;115;145;112 08:58:26 INFO - PROCESS | 1644 | |2;audio-dft;184;182;183;187;183;183;184;185;184;184 08:58:26 INFO - PROCESS | 1644 | |3;audio-fft;80;59;59;89;60;58;61;58;81;58 08:58:26 INFO - PROCESS | 1644 | |4;audio-oscillator;87;70;94;69;69;70;90;68;69;92 08:58:26 INFO - PROCESS | 1644 | |5;imaging-gaussian-blur;87;86;88;86;88;85;89;86;87;84 08:58:26 INFO - PROCESS | 1644 | |6;imaging-darkroom;97;98;96;97;97;98;96;97;96;95 08:58:26 INFO - PROCESS | 1644 | |7;imaging-desaturate;81;81;80;79;82;81;83;84;83;84 08:58:26 INFO - PROCESS | 1644 | |8;json-parse-financial;55;52;52;54;56;59;56;57;79;87 08:58:26 INFO - PROCESS | 1644 | |9;json-stringify-tinderbox;65;68;73;80;75;73;69;70;70;70 08:58:26 INFO - PROCESS | 1644 | |10;stanford-crypto-aes;85;82;82;79;84;85;85;84;101;104 08:58:26 INFO - PROCESS | 1644 | |11;stanford-crypto-ccm;164;162;147;147;146;151;160;155;198;163 08:58:26 INFO - PROCESS | 1644 | |12;stanford-crypto-pbkdf2;167;168;169;166;168;167;202;178;170;165 08:58:26 INFO - PROCESS | 1644 | |13;stanford-crypto-sha256-iterative;68;69;69;68;86;85;73;69;67;68 08:58:26 INFO - PROCESS | 1644 | __end_tp_report 08:58:26 INFO - PROCESS | 1644 | __start_cc_report 08:58:26 INFO - PROCESS | 1644 | _x_x_mozilla_cycle_collect,2036 08:58:26 INFO - PROCESS | 1644 | __end_cc_report 08:58:26 INFO - PROCESS | 1644 | __startTimestamp1481389106055__endTimestamp 08:58:26 INFO - PROCESS | 1644 | 08:58:26 INFO - PROCESS | 1644 | ------- Summary: start ------- 08:58:26 INFO - PROCESS | 1644 | Number of tests: 14 08:58:26 INFO - PROCESS | 1644 | 08:58:26 INFO - PROCESS | 1644 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.50 stddev:3.45 (3.0%) stddev-sans-first:1.54 08:58:26 INFO - PROCESS | 1644 | Values: 104.0 115.0 113.0 113.0 115.0 116.0 113.0 111.0 115.0 114.0 08:58:26 INFO - PROCESS | 1644 | 08:58:26 INFO - PROCESS | 1644 | [#1] audio-beat-detection Cycles:10 Average:124.90 Median:117.00 stddev:16.31 (13.9%) stddev-sans-first:14.31 08:58:26 INFO - PROCESS | 1644 | Values: 151.0 113.0 115.0 149.0 116.0 118.0 115.0 115.0 145.0 112.0 08:58:26 INFO - PROCESS | 1644 | 08:58:26 INFO - PROCESS | 1644 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.00 stddev:1.37 (0.7%) stddev-sans-first:1.45 08:58:26 INFO - PROCESS | 1644 | Values: 184.0 182.0 183.0 187.0 183.0 183.0 184.0 185.0 184.0 184.0 08:58:26 INFO - PROCESS | 1644 | 08:58:26 INFO - PROCESS | 1644 | [#3] audio-fft Cycles:10 Average:66.30 Median:60.50 stddev:12.02 (19.9%) stddev-sans-first:11.68 08:58:26 INFO - PROCESS | 1644 | Values: 80.0 59.0 59.0 89.0 60.0 58.0 61.0 58.0 81.0 58.0 08:58:26 INFO - PROCESS | 1644 | 08:58:26 INFO - PROCESS | 1644 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:78.50 stddev:11.29 (14.4%) stddev-sans-first:11.48 08:58:26 INFO - PROCESS | 1644 | Values: 87.0 70.0 94.0 69.0 69.0 70.0 90.0 68.0 69.0 92.0 08:58:26 INFO - PROCESS | 1644 | 08:58:26 INFO - PROCESS | 1644 | [#5] imaging-gaussian-blur Cycles:10 Average:86.60 Median:87.00 stddev:1.51 (1.7%) stddev-sans-first:1.59 08:58:26 INFO - PROCESS | 1644 | Values: 87.0 86.0 88.0 86.0 88.0 85.0 89.0 86.0 87.0 84.0 08:58:26 INFO - PROCESS | 1644 | 08:58:26 INFO - PROCESS | 1644 | [#6] imaging-darkroom Cycles:10 Average:96.70 Median:97.00 stddev:0.95 (1.0%) stddev-sans-first:1.00 08:58:26 INFO - PROCESS | 1644 | Values: 97.0 98.0 96.0 97.0 97.0 98.0 96.0 97.0 96.0 95.0 08:58:26 INFO - PROCESS | 1644 | 08:58:26 INFO - PROCESS | 1644 | [#7] imaging-desaturate Cycles:10 Average:81.80 Median:82.50 stddev:1.69 (2.0%) stddev-sans-first:1.76 08:58:26 INFO - PROCESS | 1644 | Values: 81.0 81.0 80.0 79.0 82.0 81.0 83.0 84.0 83.0 84.0 08:58:26 INFO - PROCESS | 1644 | 08:58:26 INFO - PROCESS | 1644 | [#8] json-parse-financial Cycles:10 Average:60.70 Median:56.50 stddev:12.09 (21.4%) stddev-sans-first:12.65 08:58:26 INFO - PROCESS | 1644 | Values: 55.0 52.0 52.0 54.0 56.0 59.0 56.0 57.0 79.0 87.0 08:58:26 INFO - PROCESS | 1644 | 08:58:26 INFO - PROCESS | 1644 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:71.50 stddev:4.16 (5.8%) stddev-sans-first:3.74 08:58:26 INFO - PROCESS | 1644 | Values: 65.0 68.0 73.0 80.0 75.0 73.0 69.0 70.0 70.0 70.0 08:58:26 INFO - PROCESS | 1644 | 08:58:26 INFO - PROCESS | 1644 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:84.00 stddev:8.36 (10.0%) stddev-sans-first:8.83 08:58:26 INFO - PROCESS | 1644 | Values: 85.0 82.0 82.0 79.0 84.0 85.0 85.0 84.0 101.0 104.0 08:58:26 INFO - PROCESS | 1644 | 08:58:26 INFO - PROCESS | 1644 | [#11] stanford-crypto-ccm Cycles:10 Average:159.30 Median:161.00 stddev:15.30 (9.5%) stddev-sans-first:16.14 08:58:26 INFO - PROCESS | 1644 | Values: 164.0 162.0 147.0 147.0 146.0 151.0 160.0 155.0 198.0 163.0 08:58:26 INFO - PROCESS | 1644 | 08:58:26 INFO - PROCESS | 1644 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.00 Median:168.50 stddev:11.14 (6.6%) stddev-sans-first:11.66 08:58:26 INFO - PROCESS | 1644 | Values: 167.0 168.0 169.0 166.0 168.0 167.0 202.0 178.0 170.0 165.0 08:58:26 INFO - PROCESS | 1644 | 08:58:26 INFO - PROCESS | 1644 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.20 Median:69.00 stddev:7.19 (10.4%) stddev-sans-first:7.47 08:58:26 INFO - PROCESS | 1644 | Values: 68.0 69.0 69.0 68.0 86.0 85.0 73.0 69.0 67.0 68.0 08:58:26 INFO - PROCESS | 1644 | -------- Summary: end -------- 08:58:26 INFO - PROCESS | 1644 | 08:58:27 INFO - TEST-INFO | 1644: exit 0 08:58:27 INFO - TEST-OK | kraken | took 59721ms 08:58:27 INFO - SUITE-END | took 1178s 08:58:27 INFO - Completed test suite (00:19:38) 08:58:27 INFO - javascript benchmark 08:58:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2885.3075261937133, 3311.0563489405517, 3351.8324083795806, 3360.6639336066382, 3379.3410284994434, 5578.4142665020145, 5654.46282603153, 5667.773289068437, 5693.146028095788, 5699.68651724155, 5632.986062508747, 5694.060480020791, 5715.799947001856, 5718.285214348207, 5761.452661997114, 5159.071367153911, 5183.196604526304, 5190.896182076356, 5203.9219411708855, 5217.843464696065, 5112.003159383921, 5130.07658621448, 5136.563392111675, 5269.156934890419, 5319.654222475546, 5141.717205553693, 5202.271681964528, 5210.140326846066, 5231.450697676746, 5240.528352448279, 5152.51051150142, 5173.870653233662, 5180.222966555009, 5185.066687996159, 5239.16173412256, 5057.266696329012, 5161.870953226162, 5165.483451654842, 5175.844724658228, 5219.739013049332, 5408.91886621701, 5451.672899626035, 5459.563234941234, 5552.0, 5650.378458369576, 6136.500946189515, 6186.690665466754, 6211.161493198406, 6214.40963108504, 6224.62652240867, 6185.0, 6205.441510264098, 6206.193194884636, 6218.564700470969, 6237.407446292595, 5638.802641907513, 5706.087026075808, 5706.914396284059, 5809.622374545641, 5856.560757943086, 6131.418907120749, 6161.383861613893, 6163.3528479509005, 6246.906296405557, 6247.5939063960695, 6131.202943617302, 6142.017277235621, 6142.293636231801, 6156.938430615726, 6160.630362178284, 6088.786892458743, 6134.294556126013, 6137.60105593135, 6201.007838745779, 6203.96898015507, 6092.939070609237, 6093.025115981422, 6130.275842464154, 6139.386061393914, 6143.27988163315, 5143.0, 6187.752489900444, 6194.752209911643, 6210.875782484325, 6212.937870621236, 4877.414710234794, 4907.190313598217, 4911.50884911506, 4916.385451818523, 4932.926006109911, 4335.349697545394, 4352.651787856964, 4358.302671572596, 4378.715383500126, 4379.0585024219945, 5700.315962084576, 5733.713314334266, 5777.711114444345, 5777.94222057774, 5856.941430585724, 6203.286622038523, 6210.627362358183, 6219.222597175353, 6225.564210505221, 6239.157713708682, 5540.750666220029, 5590.496855283044, 5771.0, 5780.797672081457, 5814.04068328721, 5327.200919862052, 5340.0, 5342.946570534323, 5345.67925924438, 5349.5720342372515, 6198.721057552421, 6211.751529938751, 6235.438810507076, 6243.625382477066, 6328.46208072319, 6195.597286176384, 6213.1922850029205, 6217.595856269328, 6217.937820621736, 6219.40915613016, 6120.7551697931585, 6299.905501417391, 6301.243850737941, 6313.337099604659, 6331.620102793847, 6016.067509536029, 6076.483498902643, 6087.726052327567, 6091.482224011009, 6165.84585385369, 6005.549583781147, 6193.1329613853195, 6228.190335256388, 6228.875422491434, 6234.688265586793, 6007.420873073083, 6076.240469941257, 6095.872263631242, 6098.359672234529, 6112.083187521907, 5945.762169513171, 5975.970120149372, 5996.700164991646, 6060.545459090497, 6069.302030266399, 4994.350734404504, 5868.149118377726, 5931.288245410578, 5935.792247271324, 5993.61041532299, 6049.364816694184, 6063.605865618721, 6064.969675151596, 6067.514598832171, 6077.301110372364, 5708.4862362387585, 5815.4184581543195, 5913.91129133072, 5929.229200203946, 5942.494887934401], "value": 5650.136693250563, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.6384870968548, 512.848709630659, 520.1755217979502, 527.609568919, 586.1091141464976, 29961.550576741367, 38539.80730096349, 39752.99999999993, 39815.203695926066, 41735.58264417355, 40942.0, 41364.96587585312, 41444.37833432493, 41475.792621036926, 41575.58424415755, 9264.861027084598, 9407.717768466922, 9414.435133891955, 9423.104805043544, 9440.81118377632, 9404.0, 9460.668876589321, 9507.857382139273, 9518.714438566854, 9519.762005949871, 9446.0, 9512.809743805119, 9525.380850244746, 9553.61785528578, 9559.235261179088, 8127.471714338608, 9406.200472959807, 9501.42991420517, 9516.333856630039, 9519.809603807886, 9255.814883702289, 9342.299327550461, 9343.859842102374, 9353.298502612332, 9379.718608441757, 31882.362352753047, 32093.679063209536, 32378.0, 32390.0, 32391.0, 3164.810111393324, 3202.9199270018203, 3615.4757560153894, 3789.3936970084656, 3861.1891502784447, 28607.57088643672, 29957.25106872324, 29959.089063010706, 30340.63467143984, 30623.234419139477, 3036.832974186419, 3127.874885004597, 3146.480830662938, 3172.032530078325, 3208.374366998436, 469407.0, 469628.0, 472700.0, 473827.0, 474794.0, 32602.0, 59209.11186332208, 59687.40312596905, 59763.10355344673, 59875.10187347193, 33444.16389590231, 34893.9531814046, 34927.30145397078, 34929.1267718304, 34972.65027349745, 13933.233672147926, 14035.035095086696, 14045.929770351082, 14063.437462501386, 14069.155850648995, 11961.940190298992, 12071.275723456622, 12080.335581542924, 12088.637340879788, 12119.515219391302, 7670.42471814605, 7683.308502234826, 7743.922560774433, 7763.0, 7782.299593036654, 3154.069549482908, 3155.794873333226, 3194.712475877182, 3195.3609278144463, 3228.9838550807567, 825.7605294464659, 863.3956230638578, 921.3320342751451, 956.5456408206186, 987.086944576264, 29065.0, 29122.417551648847, 29130.563041554393, 29823.570289416562, 30004.399912002074, 1017.7811770469236, 1021.2851004297022, 1031.185114199, 1101.24014430043, 1173.8650055243586, 12300.753984920431, 14956.700865982619, 15101.39594416233, 15385.307661155275, 15432.691346173013, 673349.0, 681218.0, 682182.0, 682362.0, 683682.0, 56874.43125568774, 57468.0, 57481.85036299334, 57549.84900302054, 57563.13655295174, 1363.5841068474012, 1365.6722386627337, 1390.7913812927939, 1393.3033483258168, 1394.3585950462698, 28168.577471337536, 28713.856430718548, 28745.281367965967, 29186.854065729534, 29251.561226582045, 53465.732671336395, 55268.0, 55345.0, 58539.4146058551, 58703.70648146732, 529436.7056329541, 605823.0, 612788.0, 619659.9017004886, 620295.0, 40171.994431977815, 40839.38740918829, 41343.7932810334, 41433.58566414297, 41644.791776040925, 44975.550244497135, 45702.0, 45824.0, 45888.0, 46127.53872461232, 37280.254394912496, 37460.2507949834, 37615.0, 37788.43317350297, 38860.0, 37678.0, 37759.16806239488, 37940.62059379371, 38294.80852595719, 38922.02694932649, 36122.81938590395, 36652.0, 37340.0, 37518.624813751514, 37725.62274377331, 32481.512777307886, 34044.58836716901, 34417.31165376728, 34662.65337346695, 34734.131646708025, 25206.24381268565, 25264.368390790376, 25396.746032540177, 25529.23412297634, 25687.0], "value": 18549.05506404839, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.2460473075791, 373.2274192421687, 374.974444893217, 383.42869125003745, 405.78898972534284, 13527.79708304375, 14748.77876831847, 15642.765358519602, 20164.697529537032, 20583.382498525032, 19263.903680481577, 19705.211791528323, 20356.796432035677, 20464.590708185828, 20481.897590512064, 5512.751926163332, 5611.270534830466, 5916.733746981375, 5933.050711886099, 5942.138389933457, 5299.364076310848, 5744.79893203738, 5784.710764461781, 5811.099279611667, 5814.912776308338, 5230.666180124063, 5495.780168793263, 5505.981393442206, 5755.136729490589, 5775.104858746901, 5702.857428564298, 5812.709364531756, 5835.474807267324, 5836.037053886103, 5838.0, 5561.499465048165, 5660.094384898438, 5661.122526008476, 5933.851653708649, 6026.6986650667295, 13337.866621333857, 13413.530526431528, 13432.731345373135, 13629.795553066711, 13662.11196272249, 2321.1527792355837, 2334.498082912182, 2352.188494969233, 2400.8319417640773, 2412.613981762927, 8303.750887473385, 9619.855702164474, 10254.384736915808, 10267.178625709925, 10281.126104281146, 1808.638272345536, 1856.58226898948, 1860.7767067951797, 1890.1399863062275, 1926.8651194416395, 95458.52270738671, 117364.0, 117383.0, 124155.0, 126482.30829612598, 11573.652790416301, 11623.476943537393, 11696.0, 11717.355545444912, 11887.16789824704, 14777.778333325008, 14800.0, 14802.111873287637, 14821.481248156262, 14824.851751482347, 8251.752447426587, 8504.107068757692, 8529.0, 8566.057733649293, 8625.654973801104, 7010.579365238102, 8386.329093672492, 8408.915910840935, 8414.579271036546, 8435.072142064368, 3799.0, 4612.723236605814, 4615.469221039556, 4666.113438446752, 4691.319758635047, 1603.5189443167003, 1860.2001139510141, 1899.135893168605, 1909.131345237941, 1910.388675623787, 720.2293545905935, 864.0840708848641, 874.230677004245, 909.5543183840003, 930.8464103422859, 16993.320267189174, 17379.655086228442, 19893.905835179205, 21298.0, 21421.357359279245, 773.6982576795054, 888.8755574219614, 906.2795077913075, 917.9357444978788, 919.9816003679889, 9869.506524673881, 11089.889101109047, 11100.44497775108, 11156.665300041012, 11175.944120279346, 619091.0, 621262.0, 627313.0, 635945.0, 638395.8080209569, 129197.0, 132071.33964330118, 136832.0, 138234.0, 141983.0, 950.805084957582, 959.5394210778866, 986.6645340584236, 994.2741798487, 1021.918246540275, 18173.0, 18500.0749962504, 18654.160562774978, 18712.719309210646, 18932.905335473235, 54598.727006364716, 55623.443765561824, 56259.0, 57077.85844283174, 57948.710256448445, 76586.23413765791, 80716.19283807321, 82745.75881361665, 83097.58451207705, 84888.30223395622, 5347.465253474621, 6544.345565443608, 7576.848463030598, 8122.187781221831, 8321.375896807642, 11956.0, 12514.624561263177, 12536.498540058295, 12663.746725065263, 12725.0, 10772.084372828398, 10887.618933337295, 11072.446377680923, 11345.432728363714, 11407.885921140682, 10681.359118452918, 10901.945490272497, 10942.890571094506, 11002.889971100507, 11114.0, 10910.345379277269, 11170.385628790495, 11346.0, 11493.252938558968, 11561.537538498365, 7868.72459463916, 8065.596720164086, 8283.50298982063, 8359.37304702162, 8440.113788052166, 8366.372522060748, 9059.68291109808, 9310.906890931004, 9434.952825236105, 9551.283653725859], "value": 9226.8799581882, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1258.3833921378528, 1444.8844092472602, 1488.799012133362, 1616.2645996071788, 1803.5040363899925, 7435.996140521035, 7828.138904720477, 8121.147279535645, 8385.664573417056, 8393.91606083939, 8244.793880153, 8339.33285337173, 8349.457285276452, 8351.83296334073, 8354.206350396702, 2296.4258935266143, 2343.7070366204225, 2351.988240058797, 2354.4349356154485, 2365.3495288795634, 2320.6054970654945, 2367.112332875172, 2371.5494056129282, 2371.8695471749047, 2379.940501487468, 2315.837891347598, 2316.895739691718, 2341.531693661266, 2345.9765402346015, 2350.0129945422964, 2133.797289257518, 2138.32642717545, 2299.466036023987, 2301.137073597401, 2324.418895276181, 2326.988365058181, 2350.4828937633692, 2352.7059117610297, 2354.7409784923643, 2362.787349138586, 8103.594820258963, 8226.177382261785, 8426.199511046441, 8443.0, 8485.0666426693, 4487.39420178275, 4957.231629097496, 5185.637005409623, 5197.038547868657, 5232.92150617741, 3418.435958066916, 3493.598236202844, 3529.523514325559, 3578.499010138583, 3580.1228698968657, 1057.1648397765755, 1082.2532452607675, 1084.078533246742, 1091.612477570459, 1106.80630889594, 10792.838107428395, 10819.83770243447, 10889.727756806064, 10890.074343680797, 10891.564337426415, 4122.134351786159, 4370.409994650745, 4462.732236065846, 4464.241079016575, 4470.2177119004045, 8615.353848461391, 8635.740927772176, 8651.091635378321, 8656.78804967305, 8671.349648776368, 5090.974545127325, 5120.231965205249, 5123.2827404163445, 5124.795008199705, 5129.410117836422, 4052.5542190359038, 4324.394584758136, 4449.087936972913, 4472.0, 4803.375561177095, 3610.368185567515, 3649.7810131392202, 3718.200586873835, 3725.5343082114737, 3732.0669832541867, 1139.1342579639534, 1141.7431078007382, 1142.7771584540935, 1159.1306520109918, 1160.8955194032578, 836.7029704454831, 840.6843290250738, 854.9145085491401, 900.6037343568809, 925.2181906289175, 5230.402147437536, 5233.215017747369, 5302.602304827154, 5506.697131657797, 5540.722963851791, 753.6420200404764, 823.7652269103277, 874.3355050161923, 874.5670892908051, 886.0873300500494, 3391.796492210475, 3411.9488207676904, 3545.804980726033, 3563.679268865763, 3628.401313783249, 9686.70939871805, 10137.189024877993, 10274.972502749815, 10291.94854025725, 10307.587696492057, 9977.650782222732, 10126.848097278547, 10337.431441270803, 10377.636782712569, 10379.688609341732, 7804.804879878048, 7824.765257042298, 7835.8525709206715, 7917.683292668229, 7988.242586630932, 5197.064528384776, 5214.2960700304975, 5232.843014709565, 5248.212768084665, 5261.894762104813, 9270.814583708154, 9371.484568348806, 9416.764580885532, 9484.336096473457, 9549.952250238704, 9336.159745622926, 9575.23398128134, 9617.807643847224, 9630.47032413196, 9674.274429417681, 6661.4004739573675, 6732.899006514808, 6754.0, 6820.897686534805, 6836.179658441019, 7813.882791758242, 7838.725644602411, 7873.448858580074, 7927.881081783893, 7935.40484463656, 7042.753503627348, 7155.0, 7176.0, 7222.458315626244, 7304.780856574312, 6982.860342793014, 7009.894851577128, 7010.193827709879, 7030.824229394306, 7082.893756593552, 6630.53586248958, 6659.2008958925235, 6669.966650166718, 6731.966340168464, 6736.8652626946205, 4680.4149481314835, 4691.906161876812, 4739.739314337745, 4766.404199475066, 4797.472278049481, 4813.0, 4862.635302352267, 4905.632077594266, 4966.801327946841, 5036.322507996884], "value": 4350.3613442979795, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [258.9197348821865, 297.87489254513105, 302.2835878966849, 311.6618468961177, 314.7953830010492, 4248.044190057236, 4670.743109128996, 4978.502149785019, 5219.973900130499, 5235.319408476902, 4530.388397566336, 4585.908281834361, 4842.612590992721, 4962.503749625036, 5047.495250474951, 3660.9200285915717, 3808.2961097620723, 3897.49332586764, 3920.8435360551725, 3953.794092801694, 3052.923676908073, 3784.3566593679, 4000.5799391063956, 4013.514999450193, 4021.2962731521866, 3619.348517266891, 3872.9473379108977, 3930.4693866328107, 3935.0752573145287, 3953.1303113315025, 3295.555100061485, 3732.898794855524, 3846.38457846746, 3909.061825161955, 3938.822752976123, 2822.8447435391045, 3269.591301087364, 3325.6009278886445, 3416.24842534642, 3447.1037530242065, 4413.3821265022925, 4937.580305674022, 4987.650864439491, 5006.849794506171, 5100.489951004907, 3731.589525152231, 3881.4565960765517, 4238.978805105986, 4332.740035597874, 4500.054988452429, 4437.622802061828, 4461.643068554507, 4896.412430508326, 5348.064088784447, 5370.812021579265, 3004.459197344477, 3724.0, 3730.4404339349044, 3740.7942563159017, 3744.9625503744887, 5537.0, 5623.738231825531, 5657.8019769307875, 5669.489745922887, 5673.0, 3083.6607973122937, 3585.4442561403025, 3758.8308526115843, 3790.65884070435, 3798.8860334190017, 3693.261347730465, 3778.414345776354, 3839.2897313997, 3849.942250866239, 3872.6058618897173, 3870.5161854768153, 4151.709380343407, 4449.1536012554425, 4450.065486247924, 4502.279635258343, 5141.434442211354, 5328.081890519487, 5389.595780316492, 5391.7304134793885, 5488.588355873246, 1164.8660404053473, 1205.7287110400089, 1209.9715242044192, 1221.3221661977689, 1223.7858374784378, 810.4367464612038, 831.3556993330096, 836.8702851058096, 846.9407141500159, 851.1360968616859, 4187.706860519735, 4403.864125898936, 4616.884577885513, 4817.278237795635, 4864.586510146606, 4459.034741896602, 4715.905681886343, 5015.3730783652045, 5083.186690129562, 5238.659487133325, 4635.8841028973875, 4755.7159566917435, 4794.808207671724, 4806.750244936272, 4842.353599776093, 2374.6820514614556, 2425.6361545767923, 2541.5727979779267, 2630.2898217481174, 2746.945061098767, 4344.9137715571105, 5126.743662816844, 5352.759125839347, 5360.0, 5460.481254280837, 4888.413390393175, 5358.223057656696, 5374.0, 5379.515843574019, 5380.596455265871, 4505.7521836298665, 5413.945860541423, 5431.321084864392, 5443.428440013741, 5505.623594101475, 4821.95178048215, 5052.898942021213, 5058.924116138334, 5212.791488340576, 5219.269302297757, 4911.484294149206, 4912.214045752806, 4965.900681986413, 5003.749812509287, 5018.623603229846, 4667.463241727245, 5002.774875130701, 5389.676619402849, 5459.727013649381, 5495.835124946258, 3103.9224019399694, 3577.8032208228797, 3578.481120237603, 3578.964210357863, 3581.1020159315603, 5122.668106292316, 5195.584053415029, 5251.763670634754, 5267.20837955884, 5280.339957505312, 4643.558861908114, 4896.4124305083615, 5013.24801279811, 5511.984094474009, 5520.199571062254, 5457.197666053848, 5474.91787623178, 5484.73851014261, 5484.890302193854, 5503.449655034465, 5194.68831870089, 5291.0, 5333.893112220729, 5351.5451186648015, 5412.350517937873, 5497.312835895513, 5512.6692398456225, 5522.392536821027, 5535.948169847716, 5551.389347171888, 4319.935200971925, 5201.401838788588, 5393.8921221574565, 5409.864753381197, 5432.592555558428], "value": 3849.1723176619435, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.2910172344049, 768.9269519395657, 769.2499812682635, 769.2807225244397, 786.8504984053033, 12353.691157721061, 12970.610881673565, 13913.582592522214, 14685.77971330431, 14688.559343219707, 14191.71616567668, 14675.412983480648, 14760.557183284518, 14849.331780069895, 15101.244937753123, 812.3947658994043, 825.63671984327, 835.5947365527744, 841.6128580852784, 843.6541018182546, 652.2596852572341, 671.9193696756396, 800.519688187089, 811.9472234304751, 830.8961379827522, 783.3224261014238, 874.3136637739376, 875.6628697951303, 876.4522173641474, 877.1360210192955, 872.9519876406795, 875.24728733289, 876.9210771030638, 877.4822854515802, 879.9428037177563, 649.7693318871779, 651.8012006338065, 652.8531080506896, 653.8823011857863, 654.4731491149622, 13753.312334383241, 13761.243131627756, 13792.034557580973, 13817.309134543233, 13849.584512464642, 12663.430145643468, 13117.60647180586, 13159.802602960963, 13231.073824832265, 13488.258145801978, 11037.227394082418, 11191.776164476665, 11432.256903301259, 11476.311421314747, 11491.138164637685, 3503.211777350076, 3533.0460775590705, 3598.2623562169692, 3610.5847827499647, 3726.7018638508853, 77021.0, 91179.99999999933, 91455.0, 92155.50794589684, 93479.53260233723, 10250.487475626189, 10261.640842570474, 10289.176865850714, 10309.513084884748, 10339.276250662382, 19476.51308717265, 19857.702134467996, 19860.50348741293, 19951.902645354647, 20078.598428031357, 6999.965000174967, 7532.246775322534, 7533.510321829063, 7627.618619069024, 7627.656755446018, 4103.117829666636, 4166.520850102277, 4236.406903033578, 4310.116426132635, 4371.715838470489, 3354.5135955286346, 3435.6736110069505, 3457.4122399192197, 3463.7748546344405, 3506.579210494706, 635.8092572228313, 643.0161852365887, 645.3159650770199, 645.6029541831833, 661.2329697550817, 584.7310237290894, 617.6109051297653, 621.4127649371301, 621.6052806467835, 673.6059405247887, 8498.54125800322, 8883.0, 8908.910910890809, 8984.640614375483, 9177.77055573616, 547.4361407750024, 553.0459956574877, 587.7384563869123, 610.0635524469917, 644.111161440937, 4292.59220374064, 4403.603675669206, 4409.272470042407, 4433.0, 4463.709858859163, 72582.0, 97607.51196243973, 106200.0, 106628.0, 112067.0, 89991.0, 90062.09937900538, 92246.0775392251, 93287.0, 94291.52854235822, 84951.57524212339, 85055.14944850597, 86859.56570217108, 87693.56153219193, 88527.0, 8551.401401901807, 8579.270761985052, 8720.520371379635, 8783.868241976248, 8812.787883907198, 53744.0, 55026.17460738172, 55874.72062639661, 56670.716646416506, 58869.82260354854, 75864.62067689626, 76937.61531192309, 79669.80495292459, 80988.0, 83068.58465707632, 11025.283356581796, 11156.888431115909, 11221.495032723711, 11377.146713996317, 11493.597724079616, 10056.748581285527, 12093.758124837277, 12190.878091218974, 12248.387580620754, 12490.375481226085, 11263.09895208365, 11598.362090085126, 11807.409629518317, 11986.0, 12262.570810021607, 10795.460226988462, 11663.59177428786, 11803.114766392384, 11882.28706277626, 12365.887070163728, 11352.602658906899, 11587.536498540301, 11973.940130299292, 12434.937825310815, 12501.06242031833, 9847.556859941176, 10026.949865250626, 10036.297459177787, 10313.690589282334, 10443.582256709646, 9728.418720244299, 9867.654632087842, 9877.703668889944, 9896.802063958825, 9970.750731231486], "value": 7089.598368342925, "unit": "score"}], "name": "dromaeo_css", "value": 6971.60707840682, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 113.0, 113.0, 115.0, 116.0, 113.0, 111.0, 115.0, 114.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 113.0, 115.0, 149.0, 116.0, 118.0, 115.0, 115.0, 145.0, 112.0], "value": 124.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 182.0, 183.0, 187.0, 183.0, 183.0, 184.0, 185.0, 184.0, 184.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 59.0, 89.0, 60.0, 58.0, 61.0, 58.0, 81.0, 58.0], "value": 66.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 94.0, 69.0, 69.0, 70.0, 90.0, 68.0, 69.0, 92.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 88.0, 86.0, 88.0, 85.0, 89.0, 86.0, 87.0, 84.0], "value": 86.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 96.0, 97.0, 97.0, 98.0, 96.0, 97.0, 96.0, 95.0], "value": 96.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 80.0, 79.0, 82.0, 81.0, 83.0, 84.0, 83.0, 84.0], "value": 81.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 52.0, 54.0, 56.0, 59.0, 56.0, 57.0, 79.0, 87.0], "value": 60.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 73.0, 80.0, 75.0, 73.0, 69.0, 70.0, 70.0, 70.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 82.0, 79.0, 84.0, 85.0, 85.0, 84.0, 101.0, 104.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 147.0, 147.0, 146.0, 151.0, 160.0, 155.0, 198.0, 163.0], "value": 159.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 168.0, 169.0, 166.0, 168.0, 167.0, 202.0, 178.0, 170.0, 165.0], "value": 172.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 68.0, 86.0, 85.0, 73.0, 69.0, 67.0, 68.0], "value": 72.2, "unit": "score"}], "name": "kraken", "value": 1453.5, "alertThreshold": 2.0}]} 08:58:27 INFO - Return code: 0 08:58:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:58:27 INFO - # TBPL SUCCESS # 08:58:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:58:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:58:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:58:27 INFO - 2016-12-10 08:58:27.391 screenresolution[1648:10553] starting screenresolution argv=screenresolution get 08:58:27 INFO - 2016-12-10 08:58:27.394 screenresolution[1648:10553] Display 0: 1600x1200x32@60 08:58:27 INFO - 2016-12-10 08:58:27.400 screenresolution[1649:10556] starting screenresolution argv=screenresolution list 08:58:27 INFO - Available Modes on Display 0 08:58:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:58:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:58:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:58:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:58:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:58:27 INFO - Intel Iris: 08:58:27 INFO - Chipset Model: Intel Iris 08:58:27 INFO - Type: GPU 08:58:27 INFO - Bus: Built-In 08:58:27 INFO - VRAM (Dynamic, Max): 1536 MB 08:58:27 INFO - Vendor: Intel (0x8086) 08:58:27 INFO - Device ID: 0x0a2e 08:58:27 INFO - Revision ID: 0x0009 08:58:27 INFO - Displays: 08:58:27 INFO - Display: 08:58:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:58:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:58:27 INFO - Display Serial Number: 1600x1200 60 08:58:27 INFO - Main Display: Yes 08:58:27 INFO - Mirror: Off 08:58:27 INFO - Online: Yes 08:58:27 INFO - Rotation: Supported 08:58:27 INFO - Return code: 0 08:58:27 INFO - Running post-action listener: _resource_record_post_action 08:58:27 INFO - [mozharness: 2016-12-10 16:58:27.642238Z] Finished run-tests step (success) 08:58:27 INFO - Running post-run listener: _resource_record_post_run 08:58:27 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 32955392; Write bytes: 654653952; Read time: 307; Write time: 1837 08:58:27 INFO - TinderboxPrint: CPU usage
53.5% 08:58:27 INFO - TinderboxPrint: I/O read bytes / time
32,955,392 / 307 08:58:27 INFO - TinderboxPrint: I/O write bytes / time
654,653,952 / 1,837 08:58:27 INFO - TinderboxPrint: CPU idle
2,249.9 (46.5%) 08:58:27 INFO - TinderboxPrint: CPU system
966.8 (20.0%) 08:58:27 INFO - TinderboxPrint: CPU user
1,624.9 (33.6%) 08:58:27 INFO - TinderboxPrint: Swap in / out
377,413,632 / 0 08:58:27 INFO - install - Wall time: 31s; CPU: 55.0%; Read bytes: 345874944; Write bytes: 347030528; Read time: 26758; Write time: 682 08:58:27 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 30972928; Write bytes: 300639744; Read time: 287; Write time: 1126 08:58:28 INFO - Running post-run listener: _upload_blobber_files 08:58:28 INFO - Blob upload gear active. 08:58:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:58:28 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:58:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:58:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:58:28 INFO - (blobuploader) - INFO - Open directory for files ... 08:58:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:58:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:58:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:58:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:58:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:58:29 INFO - (blobuploader) - INFO - Done attempting. 08:58:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:58:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:58:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:58:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:58:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:58:30 INFO - (blobuploader) - INFO - Done attempting. 08:58:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:58:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:58:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:58:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:58:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:58:33 INFO - (blobuploader) - INFO - Done attempting. 08:58:33 INFO - (blobuploader) - INFO - Iteration through files over. 08:58:33 INFO - Return code: 0 08:58:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:58:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:58:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/081062f58deb3ebcee72f4b13a7bfd251b3639d8b90ef2401b3f118886ca968f38b51d9712938cc86419b7224a6230ffb55fc74b1771265e03490249fbf909d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/539551bea236884bb180468ffb1c27008d14e55aff1cde9eeb20b9fbf0eeed6b842b17435178f527f38cf3b9275349b6cad450ad14d2fbee94e5f19f12bf17dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5198249f122122dc4c00bf51cd12c8361d73eb7133085f231d6db956098324f306b46a9ce848fe330a4b868d8d3a52a3bbee1c2ad6a316187476c8eaf7b4bcc"} 08:58:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:58:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:58:33 INFO - Contents: 08:58:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/081062f58deb3ebcee72f4b13a7bfd251b3639d8b90ef2401b3f118886ca968f38b51d9712938cc86419b7224a6230ffb55fc74b1771265e03490249fbf909d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/539551bea236884bb180468ffb1c27008d14e55aff1cde9eeb20b9fbf0eeed6b842b17435178f527f38cf3b9275349b6cad450ad14d2fbee94e5f19f12bf17dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5198249f122122dc4c00bf51cd12c8361d73eb7133085f231d6db956098324f306b46a9ce848fe330a4b868d8d3a52a3bbee1c2ad6a316187476c8eaf7b4bcc"} 08:58:33 INFO - Running post-run listener: copy_logs_to_upload_dir 08:58:33 INFO - Copying logs to upload dir... 08:58:33 INFO - mkdir: /builds/slave/test/build/upload/logs 08:58:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.419589 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-12-10 08:58:33.121414) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-10 08:58:33.125246) ========= 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.166LJAyEcM/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.49WCBtit4m/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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/081062f58deb3ebcee72f4b13a7bfd251b3639d8b90ef2401b3f118886ca968f38b51d9712938cc86419b7224a6230ffb55fc74b1771265e03490249fbf909d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/539551bea236884bb180468ffb1c27008d14e55aff1cde9eeb20b9fbf0eeed6b842b17435178f527f38cf3b9275349b6cad450ad14d2fbee94e5f19f12bf17dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5198249f122122dc4c00bf51cd12c8361d73eb7133085f231d6db956098324f306b46a9ce848fe330a4b868d8d3a52a3bbee1c2ad6a316187476c8eaf7b4bcc"} build_url:https://queue.taskcluster.net/v1/task/Jilm3JjLSsiooJi7dMFeCw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011077 build_url: 'https://queue.taskcluster.net/v1/task/Jilm3JjLSsiooJi7dMFeCw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/081062f58deb3ebcee72f4b13a7bfd251b3639d8b90ef2401b3f118886ca968f38b51d9712938cc86419b7224a6230ffb55fc74b1771265e03490249fbf909d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/539551bea236884bb180468ffb1c27008d14e55aff1cde9eeb20b9fbf0eeed6b842b17435178f527f38cf3b9275349b6cad450ad14d2fbee94e5f19f12bf17dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5198249f122122dc4c00bf51cd12c8361d73eb7133085f231d6db956098324f306b46a9ce848fe330a4b868d8d3a52a3bbee1c2ad6a316187476c8eaf7b4bcc"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-10 08:58:33.164679) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 08:58:33.165022) ========= 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.166LJAyEcM/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.49WCBtit4m/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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.005114 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 08:58:33.213307) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-10 08:58:33.213629) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-10 08:58:33.214037) ========= ========= Total master_lag: 0.19 =========