builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0320 starttime: 1485913286.24 results: success (0) buildid: 20170131151409 builduid: e6f30b2277eb48038f3141a8217db3ad revision: c16a0fc964a5790de244fc3ea3bb5c3d3c18d071 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-31 17:41:26.243309) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-31 17:41:26.243730) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-31 17:41:26.244004) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-31 17:41:26.285133) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 17:41:26.285445) ========= 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.dWiFKcz6U3/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.DTXwZU4QJw/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-31 17:41:26-- 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% 37.8M=0s 2017-01-31 17:41:26 (37.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125101 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 17:41:26.442493) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 17:41:26.442773) ========= 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.dWiFKcz6U3/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.DTXwZU4QJw/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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.025790 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 17:41:26.492973) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-31 17:41:26.496364) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c16a0fc964a5790de244fc3ea3bb5c3d3c18d071 --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-beta --rev c16a0fc964a5790de244fc3ea3bb5c3d3c18d071 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dWiFKcz6U3/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.DTXwZU4QJw/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-31 17:41:26,604 truncating revision to first 12 chars 2017-01-31 17:41:26,604 Setting DEBUG logging. 2017-01-31 17:41:26,605 attempt 1/10 2017-01-31 17:41:26,605 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/c16a0fc964a5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-31 17:41:27,861 unpacking tar archive at: mozilla-beta-c16a0fc964a5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.511277 ========= master_lag: 0.16 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-31 17:41:28.170158) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-31 17:41:28.170471) ========= script_repo_revision: c16a0fc964a5790de244fc3ea3bb5c3d3c18d071 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-31 17:41:28.170845) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-31 17:41:28.171105) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-31 17:41:28.193565) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-01-31 17:41:28.193875) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dWiFKcz6U3/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.DTXwZU4QJw/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 17:41:28 INFO - MultiFileLogger online at 20170131 17:41:28 in /builds/slave/test 17:41:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 17:41:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:41:28 INFO - {'append_to_log': False, 17:41:28 INFO - 'base_work_dir': '/builds/slave/test', 17:41:28 INFO - 'blob_upload_branch': 'Mozilla-Beta', 17:41:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:41:28 INFO - 'branch': 'Mozilla-Beta', 17:41:28 INFO - 'buildbot_json_path': 'buildprops.json', 17:41:28 INFO - 'config_files': ('talos/mac_config.py',), 17:41:28 INFO - 'default_actions': ('clobber', 17:41:28 INFO - 'read-buildbot-config', 17:41:28 INFO - 'download-and-extract', 17:41:28 INFO - 'populate-webroot', 17:41:28 INFO - 'create-virtualenv', 17:41:28 INFO - 'install', 17:41:28 INFO - 'run-tests'), 17:41:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:41:28 INFO - 'download_minidump_stackwalk': True, 17:41:28 INFO - 'download_symbols': 'ondemand', 17:41:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:41:28 INFO - 'tooltool.py': '/tools/tooltool.py', 17:41:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:41:28 INFO - '/tools/misc-python/virtualenv.py')}, 17:41:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:41:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:41:28 INFO - 'installer_path': 'installer.exe', 17:41:28 INFO - 'log_level': 'info', 17:41:28 INFO - 'log_name': 'talos', 17:41:28 INFO - 'log_to_console': True, 17:41:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:41:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:41:28 INFO - 'opt_config_files': (), 17:41:28 INFO - 'pip_index': False, 17:41:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:41:28 INFO - 'cmd': ('bash', 17:41:28 INFO - '-c', 17:41:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:41:28 INFO - 'enabled': True, 17:41:28 INFO - 'halt_on_failure': False, 17:41:28 INFO - 'name': 'check_screen_resolution'},), 17:41:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:41:28 INFO - 'cmd': ('bash', 17:41:28 INFO - '-c', 17:41:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:41:28 INFO - 'enabled': True, 17:41:28 INFO - 'halt_on_failure': False, 17:41:28 INFO - 'name': 'check_screen_resolution'},), 17:41:28 INFO - 'run_cmd_checks_enabled': True, 17:41:28 INFO - 'sps_profile': False, 17:41:28 INFO - 'sps_profile_interval': 0, 17:41:28 INFO - 'suite': 'dromaeojs', 17:41:28 INFO - 'system_bits': '32', 17:41:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:41:28 INFO - 'title': 't-yosemite-r7-0320', 17:41:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:41:28 INFO - 'use_talos_json': True, 17:41:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:41:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:41:28 INFO - 'work_dir': 'build'} 17:41:28 INFO - [mozharness: 2017-02-01 01:41:28.413993Z] Running clobber step. 17:41:28 INFO - Running pre-action listener: _resource_record_pre_action 17:41:28 INFO - Running main action method: clobber 17:41:28 INFO - rmtree: /builds/slave/test/build 17:41:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:41:30 INFO - Running post-action listener: _resource_record_post_action 17:41:30 INFO - [mozharness: 2017-02-01 01:41:30.891792Z] Finished clobber step (success) 17:41:30 INFO - [mozharness: 2017-02-01 01:41:30.892043Z] Running read-buildbot-config step. 17:41:30 INFO - Running pre-action listener: _resource_record_pre_action 17:41:30 INFO - Running main action method: read_buildbot_config 17:41:30 INFO - Using buildbot properties: 17:41:30 INFO - { 17:41:30 INFO - "project": "", 17:41:30 INFO - "product": "firefox", 17:41:30 INFO - "script_repo_revision": "production", 17:41:30 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 17:41:30 INFO - "repository": "", 17:41:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 17:41:30 INFO - "buildid": "20170131151409", 17:41:30 INFO - "pgo_build": "False", 17:41:30 INFO - "basedir": "/builds/slave/test", 17:41:30 INFO - "buildnumber": 25, 17:41:30 INFO - "slavename": "t-yosemite-r7-0320", 17:41:30 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 17:41:30 INFO - "platform": "yosemite_r7", 17:41:30 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 17:41:30 INFO - "branch": "mozilla-beta", 17:41:30 INFO - "repo_path": "releases/mozilla-beta", 17:41:30 INFO - "revision": "c16a0fc964a5790de244fc3ea3bb5c3d3c18d071", 17:41:30 INFO - "stage_platform": "macosx64", 17:41:30 INFO - "builduid": "e6f30b2277eb48038f3141a8217db3ad", 17:41:30 INFO - "slavebuilddir": "test" 17:41:30 INFO - } 17:41:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/JkHUPF80REmRGFiJhpALmQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 17:41:30 INFO - Running post-action listener: _resource_record_post_action 17:41:30 INFO - [mozharness: 2017-02-01 01:41:30.897697Z] Finished read-buildbot-config step (success) 17:41:30 INFO - [mozharness: 2017-02-01 01:41:30.897924Z] Running download-and-extract step. 17:41:30 INFO - Running pre-action listener: _resource_record_pre_action 17:41:30 INFO - Running main action method: download_and_extract 17:41:30 INFO - mkdir: /builds/slave/test/build/tests 17:41:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:30 INFO - trying https://queue.taskcluster.net/v1/task/JkHUPF80REmRGFiJhpALmQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 17:41:30 INFO - Downloading https://queue.taskcluster.net/v1/task/JkHUPF80REmRGFiJhpALmQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 17:41:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JkHUPF80REmRGFiJhpALmQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 17:41:31 INFO - Downloaded 1165 bytes. 17:41:31 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 17:41:31 INFO - Using the following test package requirements: 17:41:31 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 17:41:31 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 17:41:31 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 17:41:31 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 17:41:31 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 17:41:31 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 17:41:31 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 17:41:31 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 17:41:31 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 17:41:31 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 17:41:31 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 17:41:31 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 17:41:31 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 17:41:31 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 17:41:31 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 17:41:31 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 17:41:31 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 17:41:31 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 17:41:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JkHUPF80REmRGFiJhpALmQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 17:41:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JkHUPF80REmRGFiJhpALmQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 17:41:31 INFO - Fetch https://queue.taskcluster.net/v1/task/JkHUPF80REmRGFiJhpALmQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 17:41:32 INFO - Http code: 200 17:41:32 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 17:41:32 INFO - x-amz-cf-id: rgzYf4Ih21nXDimSTVL9j0uUDJZFkE5LaImqrbNYsVh28Z7BTvUDTA== 17:41:32 INFO - x-amz-version-id: Ksp6f0GNU8kkJ4GPq6MzyzQyigMA80GR 17:41:32 INFO - Expected file size: 16090567 17:41:32 INFO - Obtained file size: 16090567 17:41:39 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 17:41:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JkHUPF80REmRGFiJhpALmQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 17:41:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JkHUPF80REmRGFiJhpALmQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 17:41:39 INFO - Fetch https://queue.taskcluster.net/v1/task/JkHUPF80REmRGFiJhpALmQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 17:41:40 INFO - Http code: 200 17:41:40 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 17:41:40 INFO - x-amz-cf-id: y2a8WQp8MbANadjdDx-LayRsSFYoAZfPm3qchNEjoI8DKtqBpdeZIw== 17:41:40 INFO - x-amz-version-id: Ksp6f0GNU8kkJ4GPq6MzyzQyigMA80GR 17:41:40 INFO - Expected file size: 16090567 17:41:40 INFO - Obtained file size: 16090567 17:41:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JkHUPF80REmRGFiJhpALmQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 17:41:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JkHUPF80REmRGFiJhpALmQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 17:41:46 INFO - Fetch https://queue.taskcluster.net/v1/task/JkHUPF80REmRGFiJhpALmQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 17:41:47 INFO - Http code: 200 17:41:47 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 17:41:47 INFO - x-amz-cf-id: t64avnCL8t0iylnvHbNcQbT2oTEepfHR_KyA_gkewb_aPebrbpVK4g== 17:41:47 INFO - x-amz-version-id: 8k.16kOignBDGyizWsQeRYLM7.NtXNe2 17:41:47 INFO - Expected file size: 14403005 17:41:47 INFO - Obtained file size: 14403005 17:41: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')]} 17:41:48 INFO - trying https://queue.taskcluster.net/v1/task/JkHUPF80REmRGFiJhpALmQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 17:41:48 INFO - Downloading https://queue.taskcluster.net/v1/task/JkHUPF80REmRGFiJhpALmQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 17:41:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JkHUPF80REmRGFiJhpALmQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 17:41:50 INFO - Downloaded 82143100 bytes. 17:41:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JkHUPF80REmRGFiJhpALmQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 17:41:50 INFO - mkdir: /builds/slave/test/properties 17:41:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:41:50 INFO - Writing to file /builds/slave/test/properties/build_url 17:41:50 INFO - Contents: 17:41:50 INFO - build_url:https://queue.taskcluster.net/v1/task/JkHUPF80REmRGFiJhpALmQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 17:41:51 INFO - Running post-action listener: _resource_record_post_action 17:41:51 INFO - Running post-action listener: set_extra_try_arguments 17:41:51 INFO - [mozharness: 2017-02-01 01:41:51.405654Z] Finished download-and-extract step (success) 17:41:51 INFO - [mozharness: 2017-02-01 01:41:51.405794Z] Running populate-webroot step. 17:41:51 INFO - Running pre-action listener: _resource_record_pre_action 17:41:51 INFO - Running main action method: populate_webroot 17:41:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:41:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:41:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:41:51 INFO - '--tppagecycles', 17:41:51 INFO - '7'], 17:41:51 INFO - 'tests': ['tsvgm']}}, 17:41:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:41:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:41:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:41:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:41:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:41:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:41:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:51 INFO - 'talos_options': ['--disable-e10s'], 17:41:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:41:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:41:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:51 INFO - 'talos_options': ['--disable-e10s'], 17:41:51 INFO - 'tests': ['damp', 'tps']}, 17:41:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:51 INFO - 'tests': ['damp', 'tps']}, 17:41:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:41:51 INFO - 'tests': ['dromaeo_dom']}, 17:41:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:41:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:41:51 INFO - 'tests': ['basic_compositor_video']}, 17:41:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:41:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:41:51 INFO - 'tests': ['a11yr', 17:41:51 INFO - 'ts_paint', 17:41:51 INFO - 'tpaint', 17:41:51 INFO - 'sessionrestore', 17:41:51 INFO - 'sessionrestore_no_auto_restore', 17:41:51 INFO - 'tabpaint']}, 17:41:51 INFO - 'other-e10s': {'tests': ['a11yr', 17:41:51 INFO - 'ts_paint', 17:41:51 INFO - 'tpaint', 17:41:51 INFO - 'sessionrestore', 17:41:51 INFO - 'sessionrestore_no_auto_restore', 17:41:51 INFO - 'tabpaint']}, 17:41:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:41:51 INFO - 'ts_paint', 17:41:51 INFO - 'tpaint', 17:41:51 INFO - 'sessionrestore', 17:41:51 INFO - 'sessionrestore_no_auto_restore', 17:41:51 INFO - 'tabpaint']}, 17:41:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:41:51 INFO - 'ts_paint', 17:41:51 INFO - 'tpaint', 17:41:51 INFO - 'sessionrestore', 17:41:51 INFO - 'sessionrestore_no_auto_restore', 17:41:51 INFO - 'tabpaint']}, 17:41:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:41:51 INFO - 'tests': ['a11yr', 17:41:51 INFO - 'ts_paint', 17:41:51 INFO - 'tpaint', 17:41:51 INFO - 'sessionrestore', 17:41:51 INFO - 'sessionrestore_no_auto_restore', 17:41:51 INFO - 'tabpaint']}, 17:41:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:41:51 INFO - 'tests': ['a11yr', 17:41:51 INFO - 'ts_paint', 17:41:51 INFO - 'tpaint', 17:41:51 INFO - 'sessionrestore', 17:41:51 INFO - 'sessionrestore_no_auto_restore', 17:41:51 INFO - 'tabpaint']}, 17:41:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:41:51 INFO - 'tests': ['tsvgx', 17:41:51 INFO - 'tsvgr_opacity', 17:41:51 INFO - 'tart', 17:41:51 INFO - 'tscrollx', 17:41:51 INFO - 'cart']}, 17:41:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:41:51 INFO - 'tsvgr_opacity', 17:41:51 INFO - 'tart', 17:41:51 INFO - 'tscrollx', 17:41:51 INFO - 'cart']}, 17:41:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:51 INFO - 'talos_options': ['--disable-e10s'], 17:41:51 INFO - 'tests': ['tp5o']}, 17:41:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:51 INFO - 'tests': ['tp5o']}, 17:41:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:51 INFO - 'talos_options': ['--disable-e10s', 17:41:51 INFO - '--xperf_path', 17:41:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:41:51 INFO - 'tests': ['tp5n']}, 17:41:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:51 INFO - 'talos_options': ['--xperf_path', 17:41:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:41:51 INFO - 'tests': ['tp5n']}}, 17:41:51 INFO - 'talos.zip': {'path': '', 17:41:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:41:51 INFO - Running post-action listener: _resource_record_post_action 17:41:51 INFO - [mozharness: 2017-02-01 01:41:51.424432Z] Finished populate-webroot step (success) 17:41:51 INFO - [mozharness: 2017-02-01 01:41:51.424560Z] Running create-virtualenv step. 17:41:51 INFO - Running pre-action listener: _resource_record_pre_action 17:41:51 INFO - Running main action method: create_virtualenv 17:41:51 INFO - Creating virtualenv /builds/slave/test/build/venv 17:41:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:41:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:41:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:41:51 INFO - Using real prefix '/tools/python27' 17:41:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:41:52 INFO - Installing distribute.............................................................................................................................................................................................done. 17:41:55 INFO - Installing pip.................done. 17:41:55 INFO - Return code: 0 17:41:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:41:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:41:55 INFO - Reading from file tmpfile_stdout 17:41:55 INFO - Output received: 17:41:55 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 17:41:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10988b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109801570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9caa4b2f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10969fd30>, '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 0x109505db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109697b20>, '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.dWiFKcz6U3/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.DTXwZU4QJw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:41:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:41:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:41:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dWiFKcz6U3/Render', 17:41:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:41:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:41:55 INFO - 'HOME': '/Users/cltbld', 17:41:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:41:55 INFO - 'LOGNAME': 'cltbld', 17:41:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:55 INFO - 'MOZ_NO_REMOTE': '1', 17:41:55 INFO - 'NO_EM_RESTART': '1', 17:41:55 INFO - 'PAGER': '/bin/cat', 17:41:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:41:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:55 INFO - 'PWD': '/builds/slave/test', 17:41:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:41:55 INFO - 'SHELL': '/bin/bash', 17:41:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DTXwZU4QJw/Listeners', 17:41:55 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 17:41:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:41:55 INFO - 'USER': 'cltbld', 17:41:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:41:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:41:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:55 INFO - 'XPC_FLAGS': '0x0', 17:41:55 INFO - 'XPC_SERVICE_NAME': '0', 17:41:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:41:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:41:55 INFO - Cleaning up... 17:41:55 INFO - Return code: 0 17:41:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10988b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109801570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9caa4b2f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10969fd30>, '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 0x109505db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109697b20>, '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.dWiFKcz6U3/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.DTXwZU4QJw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:41:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:41:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:41:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dWiFKcz6U3/Render', 17:41:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:41:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:41:55 INFO - 'HOME': '/Users/cltbld', 17:41:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:41:55 INFO - 'LOGNAME': 'cltbld', 17:41:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:55 INFO - 'MOZ_NO_REMOTE': '1', 17:41:55 INFO - 'NO_EM_RESTART': '1', 17:41:55 INFO - 'PAGER': '/bin/cat', 17:41:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:41:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:55 INFO - 'PWD': '/builds/slave/test', 17:41:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:41:55 INFO - 'SHELL': '/bin/bash', 17:41:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DTXwZU4QJw/Listeners', 17:41:55 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 17:41:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:41:55 INFO - 'USER': 'cltbld', 17:41:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:41:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:41:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:55 INFO - 'XPC_FLAGS': '0x0', 17:41:55 INFO - 'XPC_SERVICE_NAME': '0', 17:41:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:41:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:55 INFO - Downloading/unpacking psutil>=3.1.1 17:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:41:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:41:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:41:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:41:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:41:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:41:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:41:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:41:59 INFO - Installing collected packages: psutil 17:41:59 INFO - Running setup.py install for psutil 17:41:59 INFO - building 'psutil._psutil_osx' extension 17:41:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 17:42:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 17:42:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 17:42:00 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 17:42:00 INFO - building 'psutil._psutil_posix' extension 17:42:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 17:42:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:42:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:42:00 INFO - ^ 17:42:00 INFO - 1 warning generated. 17:42:00 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 17:42:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:42:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:42:00 INFO - Successfully installed psutil 17:42:00 INFO - Cleaning up... 17:42:00 INFO - Return code: 0 17:42:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:42: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')]} 17:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42: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')]} 17:42:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10988b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109801570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9caa4b2f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10969fd30>, '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 0x109505db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109697b20>, '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.dWiFKcz6U3/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.DTXwZU4QJw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:42: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:42: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 mozsystemmonitor==0.3 17:42:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dWiFKcz6U3/Render', 17:42:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:42:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:42:00 INFO - 'HOME': '/Users/cltbld', 17:42:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:42:00 INFO - 'LOGNAME': 'cltbld', 17:42:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:00 INFO - 'MOZ_NO_REMOTE': '1', 17:42:00 INFO - 'NO_EM_RESTART': '1', 17:42:00 INFO - 'PAGER': '/bin/cat', 17:42:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:42:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:00 INFO - 'PWD': '/builds/slave/test', 17:42:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:42:00 INFO - 'SHELL': '/bin/bash', 17:42:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DTXwZU4QJw/Listeners', 17:42:00 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 17:42:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:42:00 INFO - 'USER': 'cltbld', 17:42:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:42:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:42:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:00 INFO - 'XPC_FLAGS': '0x0', 17:42:00 INFO - 'XPC_SERVICE_NAME': '0', 17:42:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:42:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:42: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 17:42: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 17:42: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 17:42: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 17:42: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 17:42: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 17:42:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:42:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:42:03 INFO - Installing collected packages: mozsystemmonitor 17:42:03 INFO - Running setup.py install for mozsystemmonitor 17:42:03 INFO - Successfully installed mozsystemmonitor 17:42:03 INFO - Cleaning up... 17:42:03 INFO - Return code: 0 17:42:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:42:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10988b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109801570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9caa4b2f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10969fd30>, '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 0x109505db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109697b20>, '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.dWiFKcz6U3/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.DTXwZU4QJw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:42:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:42:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:42:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dWiFKcz6U3/Render', 17:42:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:42:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:42:03 INFO - 'HOME': '/Users/cltbld', 17:42:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:42:03 INFO - 'LOGNAME': 'cltbld', 17:42:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:03 INFO - 'MOZ_NO_REMOTE': '1', 17:42:03 INFO - 'NO_EM_RESTART': '1', 17:42:03 INFO - 'PAGER': '/bin/cat', 17:42:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:42:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:03 INFO - 'PWD': '/builds/slave/test', 17:42:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:42:03 INFO - 'SHELL': '/bin/bash', 17:42:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DTXwZU4QJw/Listeners', 17:42:03 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 17:42:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:42:03 INFO - 'USER': 'cltbld', 17:42:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:42:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:42:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:03 INFO - 'XPC_FLAGS': '0x0', 17:42:03 INFO - 'XPC_SERVICE_NAME': '0', 17:42:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:42:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:04 INFO - Downloading/unpacking jsonschema==2.5.1 17:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:42:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:07 INFO - Downloading functools32-3.2.3-2.tar.gz 17:42:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:42:07 INFO - warning: no files found matching '*.txt' 17:42:07 INFO - no previously-included directories found matching 'build' 17:42:07 INFO - no previously-included directories found matching 'dist' 17:42:07 INFO - no previously-included directories found matching '.git*' 17:42:07 INFO - Installing collected packages: jsonschema, functools32 17:42:07 INFO - Running setup.py install for functools32 17:42:07 INFO - warning: no files found matching '*.txt' 17:42:07 INFO - no previously-included directories found matching 'build' 17:42:07 INFO - no previously-included directories found matching 'dist' 17:42:07 INFO - no previously-included directories found matching '.git*' 17:42:07 INFO - Successfully installed jsonschema functools32 17:42:07 INFO - Cleaning up... 17:42:07 INFO - Return code: 0 17:42:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:42:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:07 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 0x10988b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109801570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9caa4b2f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10969fd30>, '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 0x109505db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109697b20>, '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.dWiFKcz6U3/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.DTXwZU4QJw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:42:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:42:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:42:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dWiFKcz6U3/Render', 17:42:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:42:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:42:07 INFO - 'HOME': '/Users/cltbld', 17:42:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:42:07 INFO - 'LOGNAME': 'cltbld', 17:42:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:07 INFO - 'MOZ_NO_REMOTE': '1', 17:42:07 INFO - 'NO_EM_RESTART': '1', 17:42:07 INFO - 'PAGER': '/bin/cat', 17:42:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:42:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:07 INFO - 'PWD': '/builds/slave/test', 17:42:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:42:07 INFO - 'SHELL': '/bin/bash', 17:42:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DTXwZU4QJw/Listeners', 17:42:07 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 17:42:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:42:07 INFO - 'USER': 'cltbld', 17:42:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:42:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:42:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:07 INFO - 'XPC_FLAGS': '0x0', 17:42:07 INFO - 'XPC_SERVICE_NAME': '0', 17:42:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:42:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:42:07 INFO - Cleaning up... 17:42:07 INFO - Return code: 0 17:42:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:42:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:07 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 0x10988b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109801570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9caa4b2f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10969fd30>, '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 0x109505db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109697b20>, '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.dWiFKcz6U3/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.DTXwZU4QJw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:42:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:42:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:42:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dWiFKcz6U3/Render', 17:42:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:42:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:42:07 INFO - 'HOME': '/Users/cltbld', 17:42:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:42:07 INFO - 'LOGNAME': 'cltbld', 17:42:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:07 INFO - 'MOZ_NO_REMOTE': '1', 17:42:07 INFO - 'NO_EM_RESTART': '1', 17:42:07 INFO - 'PAGER': '/bin/cat', 17:42:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:42:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:07 INFO - 'PWD': '/builds/slave/test', 17:42:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:42:07 INFO - 'SHELL': '/bin/bash', 17:42:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DTXwZU4QJw/Listeners', 17:42:07 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 17:42:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:42:07 INFO - 'USER': 'cltbld', 17:42:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:42:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:42:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:07 INFO - 'XPC_FLAGS': '0x0', 17:42:07 INFO - 'XPC_SERVICE_NAME': '0', 17:42:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:42:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:08 INFO - Downloading/unpacking blobuploader==1.2.4 17:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:11 INFO - Downloading blobuploader-1.2.4.tar.gz 17:42:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:42:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:42:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:42: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 17:42: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 17:42: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 17:42: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 17:42: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 17:42: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 17:42:13 INFO - Downloading docopt-0.6.1.tar.gz 17:42:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:42:13 INFO - Installing collected packages: blobuploader, requests, docopt 17:42:13 INFO - Running setup.py install for blobuploader 17:42:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:42:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:42:13 INFO - Running setup.py install for requests 17:42:13 INFO - Running setup.py install for docopt 17:42:13 INFO - Successfully installed blobuploader requests docopt 17:42:13 INFO - Cleaning up... 17:42:14 INFO - Return code: 0 17:42:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:14 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 0x10988b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109801570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9caa4b2f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10969fd30>, '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 0x109505db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109697b20>, '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.dWiFKcz6U3/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.DTXwZU4QJw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:42:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:42:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:42:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dWiFKcz6U3/Render', 17:42:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:42:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:42:14 INFO - 'HOME': '/Users/cltbld', 17:42:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:42:14 INFO - 'LOGNAME': 'cltbld', 17:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:14 INFO - 'MOZ_NO_REMOTE': '1', 17:42:14 INFO - 'NO_EM_RESTART': '1', 17:42:14 INFO - 'PAGER': '/bin/cat', 17:42:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:14 INFO - 'PWD': '/builds/slave/test', 17:42:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:42:14 INFO - 'SHELL': '/bin/bash', 17:42:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DTXwZU4QJw/Listeners', 17:42:14 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 17:42:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:42:14 INFO - 'USER': 'cltbld', 17:42:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:42:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:14 INFO - 'XPC_FLAGS': '0x0', 17:42:14 INFO - 'XPC_SERVICE_NAME': '0', 17:42:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:42:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:42:14 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-CzGZUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:42:14 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-Sx3fvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:42:14 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-aYSqnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:42:14 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-vPPMpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:42:14 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-6WjaQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:42:14 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-knzWyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:42:14 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-zEC1hw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:42:15 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-ajI2Yz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:42:15 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-7lJkXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:42:15 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-IHgR9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:42:15 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-Exygz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:42:15 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-BYl89K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:42:15 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-rLXCSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:42:15 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-bGxQGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:42:15 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-eyzw9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:42:15 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-jPDrbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:42:15 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-5U5h6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:42:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:42:16 INFO - Running setup.py install for manifestparser 17:42:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:42:16 INFO - Running setup.py install for mozcrash 17:42:16 INFO - Running setup.py install for mozdebug 17:42:16 INFO - Running setup.py install for mozdevice 17:42:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:42:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:42:16 INFO - Running setup.py install for mozfile 17:42:16 INFO - Running setup.py install for mozhttpd 17:42:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:42:16 INFO - Running setup.py install for mozinfo 17:42:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:42:17 INFO - Running setup.py install for mozInstall 17:42:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:42:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:42:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:42:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:42:17 INFO - Running setup.py install for mozleak 17:42:17 INFO - Running setup.py install for mozlog 17:42:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:42:17 INFO - Running setup.py install for moznetwork 17:42:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:42:17 INFO - Running setup.py install for mozprocess 17:42:17 INFO - Running setup.py install for mozprofile 17:42:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:42:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:42:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:42:18 INFO - Running setup.py install for mozrunner 17:42:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:42:18 INFO - Running setup.py install for mozscreenshot 17:42:18 INFO - Running setup.py install for moztest 17:42:18 INFO - Running setup.py install for mozversion 17:42:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:42:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:42:18 INFO - Cleaning up... 17:42:18 INFO - Return code: 0 17:42:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:42:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:19 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 0x10988b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109801570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9caa4b2f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10969fd30>, '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 0x109505db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109697b20>, '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.dWiFKcz6U3/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.DTXwZU4QJw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:42:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:42:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:42:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dWiFKcz6U3/Render', 17:42:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:42:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:42:19 INFO - 'HOME': '/Users/cltbld', 17:42:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:42:19 INFO - 'LOGNAME': 'cltbld', 17:42:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:19 INFO - 'MOZ_NO_REMOTE': '1', 17:42:19 INFO - 'NO_EM_RESTART': '1', 17:42:19 INFO - 'PAGER': '/bin/cat', 17:42:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:42:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:19 INFO - 'PWD': '/builds/slave/test', 17:42:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:42:19 INFO - 'SHELL': '/bin/bash', 17:42:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DTXwZU4QJw/Listeners', 17:42:19 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 17:42:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:42:19 INFO - 'USER': 'cltbld', 17:42:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:42:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:42:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:19 INFO - 'XPC_FLAGS': '0x0', 17:42:19 INFO - 'XPC_SERVICE_NAME': '0', 17:42:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:42:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:42:19 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-KLf1me-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:42:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:42:19 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-yn1u1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:42:19 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)) 17:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:42:19 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-xvzGSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:42:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:42:19 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-IcSUhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:42:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:42:20 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-XtKK8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:42:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:42:20 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-2yvnkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:42:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:42:20 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-pt1xKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:42:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:42:20 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-1WLxPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:42:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:42:20 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-Lm9jp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:42:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:42:20 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-yhvMEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:42:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:42:20 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-xQY1qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:42:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:42:20 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-CsHYUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:42:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:42:20 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-8XAEMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:42:21 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-qYu39e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:42:21 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)) 17:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:42:21 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-QVoncZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:42:21 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-6ujE17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:42:21 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-K6Uc8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:42:21 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)) 17:42:21 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)) 17:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:42:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:24 INFO - Downloading blessings-1.6.tar.gz 17:42:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:42:24 INFO - Installing collected packages: blessings 17:42:24 INFO - Running setup.py install for blessings 17:42:24 INFO - Successfully installed blessings 17:42:24 INFO - Cleaning up... 17:42:24 INFO - Return code: 0 17:42:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:42:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:42:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:42:25 INFO - Reading from file tmpfile_stdout 17:42:25 INFO - Current package versions: 17:42:25 INFO - blessings == 1.6 17:42:25 INFO - blobuploader == 1.2.4 17:42:25 INFO - docopt == 0.6.1 17:42:25 INFO - functools32 == 3.2.3-2 17:42:25 INFO - jsonschema == 2.5.1 17:42:25 INFO - manifestparser == 1.1 17:42:25 INFO - mozInstall == 1.12 17:42:25 INFO - mozcrash == 1.0 17:42:25 INFO - mozdebug == 0.1 17:42:25 INFO - mozdevice == 0.48 17:42:25 INFO - mozfile == 1.2 17:42:25 INFO - mozhttpd == 0.7 17:42:25 INFO - mozinfo == 0.9 17:42:25 INFO - mozleak == 0.1 17:42:25 INFO - mozlog == 3.4 17:42:25 INFO - moznetwork == 0.27 17:42:25 INFO - mozprocess == 0.23 17:42:25 INFO - mozprofile == 0.28 17:42:25 INFO - mozrunner == 6.13 17:42:25 INFO - mozscreenshot == 0.1 17:42:25 INFO - mozsystemmonitor == 0.3 17:42:25 INFO - moztest == 0.8 17:42:25 INFO - mozversion == 1.4 17:42:25 INFO - psutil == 3.1.1 17:42:25 INFO - requests == 1.2.3 17:42:25 INFO - wsgiref == 0.1.2 17:42:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:42:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:25 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 0x10988b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109801570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9caa4b2f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10969fd30>, '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 0x109505db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109697b20>, '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.dWiFKcz6U3/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.DTXwZU4QJw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:42:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:42:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:42:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dWiFKcz6U3/Render', 17:42:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:42:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:42:25 INFO - 'HOME': '/Users/cltbld', 17:42:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:42:25 INFO - 'LOGNAME': 'cltbld', 17:42:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:25 INFO - 'MOZ_NO_REMOTE': '1', 17:42:25 INFO - 'NO_EM_RESTART': '1', 17:42:25 INFO - 'PAGER': '/bin/cat', 17:42:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:42:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:25 INFO - 'PWD': '/builds/slave/test', 17:42:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:42:25 INFO - 'SHELL': '/bin/bash', 17:42:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DTXwZU4QJw/Listeners', 17:42:25 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 17:42:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:42:25 INFO - 'USER': 'cltbld', 17:42:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:42:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:42:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:25 INFO - 'XPC_FLAGS': '0x0', 17:42:25 INFO - 'XPC_SERVICE_NAME': '0', 17:42:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:42:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:42:25 INFO - Cleaning up... 17:42:25 INFO - Return code: 0 17:42:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:42:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10988b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109801570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9caa4b2f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10969fd30>, '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 0x109505db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109697b20>, '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.dWiFKcz6U3/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.DTXwZU4QJw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:42:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:42:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:42:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dWiFKcz6U3/Render', 17:42:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:42:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:42:25 INFO - 'HOME': '/Users/cltbld', 17:42:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:42:25 INFO - 'LOGNAME': 'cltbld', 17:42:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:25 INFO - 'MOZ_NO_REMOTE': '1', 17:42:25 INFO - 'NO_EM_RESTART': '1', 17:42:25 INFO - 'PAGER': '/bin/cat', 17:42:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:42:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:25 INFO - 'PWD': '/builds/slave/test', 17:42:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:42:25 INFO - 'SHELL': '/bin/bash', 17:42:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DTXwZU4QJw/Listeners', 17:42:25 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 17:42:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:42:25 INFO - 'USER': 'cltbld', 17:42:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:42:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:42:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:25 INFO - 'XPC_FLAGS': '0x0', 17:42:25 INFO - 'XPC_SERVICE_NAME': '0', 17:42:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:42:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:42:25 INFO - Cleaning up... 17:42:25 INFO - Return code: 0 17:42:25 INFO - Running post-action listener: _resource_record_post_action 17:42:25 INFO - Running post-action listener: _start_resource_monitoring 17:42:25 INFO - Starting resource monitoring. 17:42:25 INFO - [mozharness: 2017-02-01 01:42:25.746418Z] Finished create-virtualenv step (success) 17:42:25 INFO - [mozharness: 2017-02-01 01:42:25.747469Z] Running install step. 17:42:25 INFO - Running pre-action listener: _resource_record_pre_action 17:42:25 INFO - Running main action method: install 17:42:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:42:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:42:26 INFO - Reading from file tmpfile_stdout 17:42:26 INFO - Detecting whether we're running mozinstall >=1.0... 17:42:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:42:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:42:26 INFO - Reading from file tmpfile_stdout 17:42:26 INFO - Output received: 17:42:26 INFO - Usage: mozinstall [options] installer 17:42:26 INFO - Options: 17:42:26 INFO - -h, --help show this help message and exit 17:42:26 INFO - -d DEST, --destination=DEST 17:42:26 INFO - Directory to install application into. [default: 17:42:26 INFO - "/builds/slave/test"] 17:42:26 INFO - --app=APP Application being installed. [default: firefox] 17:42:26 INFO - mkdir: /builds/slave/test/build/application 17:42:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:42:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 17:42:47 INFO - Reading from file tmpfile_stdout 17:42:47 INFO - Output received: 17:42:47 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 17:42:47 INFO - Running post-action listener: _resource_record_post_action 17:42:47 INFO - [mozharness: 2017-02-01 01:42:47.686665Z] Finished install step (success) 17:42:47 INFO - [mozharness: 2017-02-01 01:42:47.686806Z] Running run-tests step. 17:42:47 INFO - Running pre-action listener: _resource_record_pre_action 17:42:47 INFO - Running main action method: run_tests 17:42:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:42:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:42:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:42:47 INFO - 2017-01-31 17:42:47.701 screenresolution[1625:7596] starting screenresolution argv=screenresolution get 17:42:47 INFO - 2017-01-31 17:42:47.704 screenresolution[1625:7596] Display 0: 1600x1200x32@60 17:42:47 INFO - 2017-01-31 17:42:47.709 screenresolution[1626:7599] starting screenresolution argv=screenresolution list 17:42:47 INFO - Available Modes on Display 0 17:42:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:42:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:42:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:42:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:42:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:42:47 INFO - Intel Iris: 17:42:47 INFO - Chipset Model: Intel Iris 17:42:47 INFO - Type: GPU 17:42:47 INFO - Bus: Built-In 17:42:47 INFO - VRAM (Dynamic, Max): 1536 MB 17:42:47 INFO - Vendor: Intel (0x8086) 17:42:47 INFO - Device ID: 0x0a2e 17:42:47 INFO - Revision ID: 0x0009 17:42:47 INFO - Displays: 17:42:47 INFO - Display: 17:42:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:42:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:42:47 INFO - Display Serial Number: 1600x1200 60 17:42:47 INFO - Main Display: Yes 17:42:47 INFO - Mirror: Off 17:42:47 INFO - Online: Yes 17:42:47 INFO - Rotation: Supported 17:42:47 INFO - Return code: 0 17:42:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:42:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:42:47 INFO - Python 2.7.3 17:42:47 INFO - Return code: 0 17:42:47 INFO - grabbing minidump binary from tooltool 17:42: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')]} 17:42: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 0x10969fd30>, '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 0x109505db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109697b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:42: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 17:42: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 17:42: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 17:42:48 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:42:48 INFO - Return code: 0 17:42:48 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:42:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:42:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:42:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:42:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:42:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JkHUPF80REmRGFiJhpALmQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0320', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:42:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JkHUPF80REmRGFiJhpALmQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0320 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:42:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dWiFKcz6U3/Render', 17:42:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:42:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:42:48 INFO - 'HOME': '/Users/cltbld', 17:42:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:42:48 INFO - 'LOGNAME': 'cltbld', 17:42:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:42:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:42:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:48 INFO - 'MOZ_NO_REMOTE': '1', 17:42:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:42:48 INFO - 'NO_EM_RESTART': '1', 17:42:48 INFO - 'PAGER': '/bin/cat', 17:42:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:42:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:48 INFO - 'PWD': '/builds/slave/test', 17:42:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:42:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:42:48 INFO - 'SHELL': '/bin/bash', 17:42:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DTXwZU4QJw/Listeners', 17:42:48 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 17:42:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:42:48 INFO - 'USER': 'cltbld', 17:42:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:42:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:42:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:48 INFO - 'XPC_FLAGS': '0x0', 17:42:48 INFO - 'XPC_SERVICE_NAME': '0', 17:42:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:42:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JkHUPF80REmRGFiJhpALmQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0320', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:42:48 INFO - mozversion application_buildid: 20170131151409 17:42:48 INFO - mozversion application_changeset: c16a0fc964a5790de244fc3ea3bb5c3d3c18d071 17:42:48 INFO - mozversion application_display_name: Firefox 17:42:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:42:48 INFO - mozversion application_name: Firefox 17:42:48 INFO - mozversion application_remotingname: firefox 17:42:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:42:48 INFO - mozversion application_vendor: Mozilla 17:42:48 INFO - mozversion application_version: 52.0 17:42:48 INFO - mozversion platform_buildid: 20170131151409 17:42:48 INFO - mozversion platform_changeset: c16a0fc964a5790de244fc3ea3bb5c3d3c18d071 17:42:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:42:48 INFO - mozversion platform_version: 52.0 17:42:48 INFO - using testdate: 1485913368 17:42:48 INFO - actual date: 1485913368 17:42:48 INFO - starting webserver on 'localhost:49243' 17:42:48 INFO - SUITE-START | Running 2 tests 17:42:48 INFO - TEST-START | dromaeo_css 17:42:48 INFO - operating with platform_type : mac_ 17:42:48 INFO - Initialising browser for dromaeo_css test... 17:42:48 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmpb1YbFP/profile http://localhost:49243/getInfo.html) 17:42:50 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 17:42:50 INFO - PROCESS | 1636 | colorDepth:24 17:42:50 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 17:42:50 INFO - PROCESS | 1636 | __metrics 17:42:50 INFO - PROCESS | 1636 | 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" 17:42:50 INFO - PROCESS | 1636 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:42:51 INFO - TEST-INFO | 1636: exit 0 17:42:51 INFO - Browser initialized. 17:42:51 INFO - Running cycle 1/1 for dromaeo_css test... 17:42:51 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmpb1YbFP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:43:03 INFO - PROCESS | 1639 | RSS: Main: 168230912 17:43:03 INFO - PROCESS | 1639 | 17:46:06 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 17:46:08 INFO - PROCESS | 1639 | RSS: Main: 324796416 17:46:08 INFO - PROCESS | 1639 | 17:49:11 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 17:49:11 INFO - PROCESS | 1639 | RSS: Main: 297193472 17:49:11 INFO - PROCESS | 1639 | 17:52:14 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 17:52:15 INFO - PROCESS | 1639 | RSS: Main: 266043392 17:52:15 INFO - PROCESS | 1639 | 17:55:17 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 17:55:17 INFO - PROCESS | 1639 | RSS: Main: 269496320 17:55:17 INFO - PROCESS | 1639 | 17:58:21 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 17:58:21 INFO - PROCESS | 1639 | RSS: Main: 259391488 17:58:21 INFO - PROCESS | 1639 | 18:01:24 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 18:01:25 INFO - PROCESS | 1639 | RSS: Main: 326877184 18:01:25 INFO - PROCESS | 1639 | 18:01:25 INFO - PROCESS | 1639 | __start_tp_report 18:01:25 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 18:01:25 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 18:01:25 INFO - PROCESS | 1639 | |i|pagename|runs| 18:01:25 INFO - PROCESS | 1639 | |0;dojo.html;3476.5132881396603;3518.155642645766;3531.5232443620102;3532.7173826093913;3592.9281414371712;5878.941210587898;5949.70251487425;5956.404359564041;5997.13041608967;6006.549508786842;4297.957020429795;5371;5803.216565763621;5833.970830145854;5921.703914804253;4399.318105693623;5181.1192097343355;5262;5300.204969254604;5321;5233.18885572735;5242.895142097156;5262.7631756571045;5286.154215325549;5363.436839131893;5297.258383826267;5368.436314187013;5382.6232163748555;5403.432639572848;5417.674939503623;5359.651622644516;5364.758585863646;5371.334886185295;5373.435789242112;5378.46215378463;5092.3125378073855;5204.687718736888;5316.627836051478;5339.385970613391;5382.67703937765;5727.570432217601;5763.3948435414095;5783.21926539916;5862.853428664317;5912.320083190445;6283.717232724538;6293.779717709858;6297.118403423525;6322.462590679797;6325.462335701471;6315.400036996478;6319.6208227506495;6320.273168585625;6321.715522801485;6331.778387756406;5734.627249228787;5861.589688721791;5939.287285525678;5967.075103358986;5992.370801065826;6391.1371964785085;6426.775062872871;6435.324290949477;6442.967785161044;6449;6314.431701146918;6326.715297811609;6346.619202847844;6346.746130154835;6361;6251.874962500725;6260.593061450991;6308.621482711052;6322.430981211713;6330.145430366933;6325.5255855811;6331.620102793847;6349.269833969152;6351.523635727339;6361.840953976188;6251.812445626639;6269.7492100316385;6328.71520781566;6338.176037115238;6342.651154186564;4921.704697718148;4996.800127994839;4998.300237966688;5048.621353398436;5084.618653600995;4421.867343979686;4486.170058539181;4494.1461122386645;4510.0528888933695;4570.063137056895;6031.09533569968;6046.939530604637;6063.484603808637;6080.361562035922;6118.969405152946;5077.365329333833;6278.183836101369;6304.779332723333;6335.524835637346;6340.556161068681;5996.2504686914135;6050.667213303311;6052.364501727343;6128.1114238435175;6131.693415329305;5524.723763811874;5573.386927437979;5581.6371935824045;5598.3282006159525;5602.411746766531;6308.243010838729;6575.44108750752;6577.50668699859;6578.506612004215;6584.012398140318;6218.5647004711045;6227.595206311576;6250.843728906813;6316.399942005502;6341.682915854281;6407.9038814418755;6565.376289252514;6597.80206593803;6599.934000660124;6615.834604134935;6259.906101408392;6260.029695397221;6323.9683801580695;6331.176946996861;6332.30344662096;6189.938100618936;6249.843778900918;6364.713587888464;6370.458511026614;6381.680915954276;6170.475509581735;6179.474744646755;6240.344763799917;6282.497400207881;6288.308286088618;6217.316095229611;6249.125122482947;6262.843428914131;6268.404501572526;6269.12232287471;5935.080062590306;6188.164597779422;6204.007358822747;6206.286277078013;6231.158793562992;6153.72308246139;6157.692115394302;6196.659183744938;6197.4732147767945;6300.054991751274;5944.970275148597;6146.938530614637;6147.938520614736;6151.907721384272;6174.845628859135 18:01:25 INFO - PROCESS | 1639 | |1;ext.html;484.36064394998607;497.36834220539913;517.7049082023249;529.2907503944715;564.4722184757252;28398;32491;32525.349493010126;39582.20835583287;40537.797311013404;42326;42634.78682606583;42770;42805.35791963123;42828.78585607067;9571.234301255918;9735.17251033663;9754.219662426989;9762.560684769202;9776.560054797552;8849.513276769776;9062.773430664252;9659.806803863954;11501.252418592765;11730.472128754227;11837.467313970848;11869.991050760696;11883.821742673867;11896.167268291223;11901.345426001566;11749.588764393247;11821.34982575958;11826.467808948575;11827.290362578273;11827.526898924032;11522.42387880611;11595.072394208442;11634.243774154653;11636.883631163664;11673.649790506213;39341.40987885184;39572;39592.60407395918;39627.60372396268;39667;2795.4828356754065;3605.369060414443;3652.196516766307;3666.834992425347;3766.472693822867;29011.984580539578;30353.937612183687;31088.533671994937;31141.37717245665;31982.840085799653;3162.383335249627;3286.6877646623534;3311.602607687069;3319.9834000830083;3416.79499230047;515269;527114;527383;527444;529765;34967.30065398678;35846.28307433837;35862.46206306908;36835.81582092126;36976.81511592425;37377;37455.25089498249;37461.81269093637;37504.43743343852;37585.62414375876;15439.382424702886;15535.223238838013;15580.987235829634;15596.220188990505;15631.374745010073;12091.27452352844;13049.412776425084;13151.408186631434;13170.60488185356;13317.00122490817;7724.227577242344;8064;8295.087540370554;8307.543085130255;8333.16668333174;3409.505621684842;3427.3145370925417;3436.226848959014;3444.7244220462303;3460.3079384123275;991.682661548312;996.3175224970918;1036.984445233322;1040.7190058684264;1083.7886612110563;29765.702342976725;29922.850385748367;30193.849030755144;30445;30636;926.7219834049893;1042.1402343067;1129.6836885672026;1146.696125526736;1156.4275683536703;15287;15462;15629.765553516707;15846.683066338608;15935;591854;594772;596120;600877;602910;58677.70661146667;59337.703311483165;59358.70320648369;59396;59407.702961484916;1360.7346567419258;1381.3162484570203;1406.5569345656086;1407.1697698357814;1412.3503188533389;23920.88039559791;29235.561466577594;29701.851490743273;30007.549886752153;30618.08145755631;50929.490705092474;51359;51384;51388.715282118246;51597.7420112897;604914;609726;610142;610337;611668;27307.72692273052;27577.17268481949;27889.581656274768;27941.161765147077;27996.160115196577;47486.52513474821;47523.76238118787;47944.520554794006;47994.040119196725;48320;34294.828525857214;38736;39472;39671.60328396795;39862.00344991399;37757.81121094377;38695.03262418462;38943;39827;40090.599094008685;36434.63565364313;38879.41680874732;39058.804705977425;39146.41280380853;39330;24480.755192447847;30147.69852301449;32651.836740816143;34287.31425371528;34431.827840860635;24849.1302804401;25056.749432505443;25220.117295894557;25431.87284063568;25499.490010200065 18:01:25 INFO - PROCESS | 1639 | |2;jquery.html;363.6563447542074;365.18927979884654;386.66939766499644;395.7684754418665;415.08266730525537;15857.207139643015;15984.920075399621;18777.15502802372;20500.897495512538;20513.282035128774;19875.80124198761;20464;20822;21408;21422.464438389048;4642.280446530776;5239.711815850127;5330.680159190441;5519;5521.475459831309;4094.877153685379;5418.051840927842;5473.261109750172;5476.959377718241;5502.889942201154;4278.6363159131515;7477.588732619731;7939.325157361631;7964.60176991151;7971.920280797176;7688.308052275294;7860.449768516206;7926.445148839583;7990.1610330915;7992.960035199787;7422.7773166804545;7629.427792915553;7705.267999540035;7726.420518461138;7736.729214477523;27940.58089128665;28103.71896281052;28153.57769633457;28455;28847.42305153885;2616.3328351270493;2642.775364094054;2727.386338073937;2941.1911724275997;3468.3756923753713;16456.920622257632;16735.414260500824;16986.830131698647;17514.824851751448;17708.468745937644;2031.8316967743458;2032.298856894369;2037.4906273431643;2080.4382816639422;2108.4307237046064;129907;131376;133511.33244333812;133636.33181834125;133851.6614833849;19917.701234481494;20905.37283881486;21826.345209643736;22040.559188816133;22090.44773880666;31566.842165789025;35819.82090089533;36071.4589281161;36545.634543654225;36616.08459788527;10729.248952573245;11058.170637202242;11239.438028098562;11247.100231981422;11433.314001159957;9141.177294043568;9163.083691630916;9248.21390181842;9334.253259739204;9355.158035776813;7898.921010789819;9841.834796344792;9929.2056635469;9930.652427165014;9964.402135871871;3218.3241519280746;3794.905127371838;3800.2779471900803;3804.410316400962;3815.4849095372324;833.4874052457695;932.9673461428953;939.6429356844492;965.8502932045544;967.1247520993512;20042.599148016958;21185.68221476679;21240.468988275417;21244;21330.360089197347;926.9930848104187;938.4979036215592;954.5895265035962;977.237754551451;1045.1586472889246;10384.792304153874;11131.888681113247;11155.498002589902;11171.994520493196;11179.161562882817;603349;604259;611146;613719;613904;119695;131049.03426448611;132803;133877.3306133463;136196.6380336184;844.3582877013514;980.9117179453883;1033.3128469567803;1049.7900419916048;1050.7583255851198;15447.5365739028;18369.908150459163;20107.19571217135;20135.39593812188;20278.884661343767;51113.72215694637;53534;55947;58621;58855;80741.59629201816;85722;85822;86063;86323;5449.591280654046;5576.247206627216;6715.93284067153;8040.597970101355;8567.571621419029;10852.403117828595;12037.398130093636;12334.198277111958;12770.361481926053;13075.953923686273;10980.945095274472;10992.835107473555;11145.609903653332;11390.715232119263;11442.771144577227;11072.723181920517;11135.053520450852;11216;11349.262297950607;11457.59898403552;10905.236633435901;11206.327620342805;11326.980571748581;11351.205415620827;11615.30308181478;8184.959075204586;8281.337493000667;8284.337253019865;8365.163483651586;8574.78563035929;8252.174782521699;9223.907760922304;10818.390371761494;10820.673555185673;11072.723181920517 18:01:25 INFO - PROCESS | 1639 | |3;mootools.html;1352.6618345413647;1391.8538553451888;1483.4214656284043;1632.2002218912728;1835.752173456583;7536.660850261737;7947.086085100215;7962.721304754335;7973.362131029518;7978.48139870908;8037.437379383446;8315;8315.75052748417;8387.245147936685;8407;2359.315798418457;2392.83250172488;2393.162393162388;2396.077510158584;2396.113438027923;2056.650369437192;2384.523095380922;2422.467057247403;2424.284835973392;2439.9390015249674;2077.992173795708;2283.566122436732;2384.3919800450863;2391.485830546432;2405.807535397164;2340.8361414700976;2352.8235382346306;2373.9406514837096;2374.548835721225;2379.3337865397802;2368.0882860098814;2372.5492156490213;2390.032037025008;2403.122860156048;2409.4458274596764;8387.280607475454;8389.370797190235;8489.830203395959;8499.320054395634;8519.10549392311;4835.492273311322;5144.485551444863;5270.789168433258;5279.947200527984;5308.495692909168;3389.3729660012978;3471.7396195285455;3519.1202199450136;3592.946105808415;3599.982000090009;1039.7088815131776;1043.1133536493996;1080.9135269178446;1082.3722241100143;1088.9346639201674;9350.111739384747;10873.021428071432;10911.83632245517;10913.290636108706;10995.175361847894;4051.7034548944644;4257.40396344512;4334.609885110292;4483.865484035484;4486.057927835126;8486.151384861589;8502.829943401097;8503.14968503157;8507.829843403097;8508.978922529212;5089.821856235014;5093.847184584469;5095.337606111256;5099.69401835891;5106.106431374495;4418.160549495586;4559.703619264804;4730.503297153749;4798.184308667535;4842.128416884994;3676.540432445944;3717.126475278307;3769.547654281449;3807.3527500325013;3809.371453710107;1155.5493357590547;1155.9653210403533;1160.785254727878;1167.8832116788253;1171.2562522798085;773.1649818196335;873.2187981279644;897.1880448194395;912.4342907397456;917.2982668258787;5527.143292789624;5538.335399752055;5567.387587365387;5780.684802537023;5823.1847541343395;937.8218138553653;949.3971328206638;951.0727041134976;956.9377990430617;986.9753256168653;3645.671889529955;3651.707863370924;3722.3858063419775;3896.883093507143;3903.9159064338855;9799.510024498746;10035.24735644815;10091.344062635904;10135.493225338703;10140.239482038729;9600.519974001272;10004.649837255662;10021.949890250502;10022.498875056219;10023.949880250551;7634.541927484369;7870.6851725931465;7874.291313781787;7877.7636670899965;7885.605719713992;5452.890942181213;5509.917351239655;5533;5779.508741756998;5779.913301300399;9375.765605859908;9387.483688397204;9491.335606507755;9532.666356677482;9536.66621668266;9345.579448924951;9558.56986435626;9622.855657165288;9721.562529686322;9733.415995040037;7144.928550714426;7252.5648461092505;7296.7810965671115;7343.008693826265;7392.519486233377;7828.960855195687;7938.404619653665;7942.44402891792;7949.642266097924;7951.602419879098;6964;7175.748848790476;7205.819854503469;7230.927690723025;7251.166115896739;6714.764983225564;6759.594424334556;6895.241523432519;7026.19198792125;7118.715251389886;6143.600665956698;6349.714262858275;6673.099131617169;6676.83307917306;6791.0153027811675;4863.586595139312;4892.633052521146;4902.8774280643265;4915.8033678652455;4932.457429682804;4274.316109422478;4833.637477189295;4839.661223714306;4868.2940973557925;5005.174146265826 18:01:25 INFO - PROCESS | 1639 | |4;prototype.html;304.73792538416967;308.85483822603385;312.206994234644;320.93260415312784;322.29256781364916;4340.696151269412;5053.5451809337155;5089.770960306786;5147.897042059161;5201.141811601081;4203.801916453811;4818.542238487338;4915.729634870089;4948.38145231846;4998.925016124761;3240.95138572921;3910.608939106095;3981.183857309259;3988.421678856564;3994.9800250998705;3339.34882697874;3956.3867600521967;3971.642552170304;3973.602639736018;3983.8207280672295;3101.34871676947;3443.7933723976516;3923.7253392262555;3939.606039396066;3954.5847685992844;3972.344563147077;3981.721279510421;3993.821822562351;3996.760194388317;4005.5193376794678;2917.7811664125275;3023.8811639693236;3057.495513240313;3121.4693502104697;3527.030066731669;5029.522195391469;5049.924251136236;5051.19180931053;5058.418281897592;5069.645124841262;4267.274563324211;4354.281543545311;4532.206863798822;4591.6556258280425;4596;5387.676739395649;5407.918881216785;5413.188021796723;5420.34955805302;5424.891502169974;3516.40221162403;3668.0201980850807;3890.280298144852;3905.824237909301;3909.8465952544066;4978.775955081994;5623.8594035149035;5635.295588051494;5642.037930086737;5678.933375976968;3929.390944403622;3937.8818635440985;3938.212357528506;3944.3097457944746;3962.0293028208275;3968.0675041365257;3992.5208974923194;3994.8801535953967;3998.5801490843623;4000.1999600079516;3943.6253555912144;4244.87265382039;4398.23030969579;4549.840755573605;4590.88522786933;5394.973025134927;5433.538149257279;5437.564994800407;5443.183522471581;5459.754311056012;1101.7190616392768;1275.2539764238024;1293.518920835638;1296.786030305008;1302.856685764565;831.1314676163423;846.7629063862129;853.470848074198;858.4334339336008;880.9735707928772;4292;4865.9756701216975;4883.755812209375;4884.194107972145;4906.632002599819;4459.754713490789;4651.581267713313;5064.822731204464;5172.27588137661;5256.896051829082;4337.652987760972;4451.354553589711;4581.266997280419;4779.832705855279;4833.806647734052;2266.580682573729;2704.0806125917284;2705.8094438447415;2712.782977361846;2757.277675138547;4985.875353116128;5152.562032227228;5383.407825139231;5423;5446.972765136228;4298.4412026436985;5168.1497284523275;5312.617090900023;5323.661216108859;5330.706811125426;4883.853484395474;4920.803167873388;5409.78360865561;5443.482869127427;5444.673319600836;5036.949630503648;5189.636725429184;5191.32512773337;5192.896142077062;5221.425643179171;4871.293662419001;4890.3836447501835;5091.236314552847;5168.793248270027;5197.350331208599;4638.8608341749805;5284.497972692588;5306.575473962151;5367.248585197997;5434.538064264424;3522.3659741245797;3686.668199861918;3700.481932529502;3712.2923455210907;3721.1999420124803;4841.322214889848;4915.311856340187;5127.923081153711;5150.579227762945;5163.251328557413;4434.534373890824;4763.7141771493825;4953.479884612208;5044.596432285335;5075.568576670877;4314.914835892352;4721.244600863845;5000.699958002531;5032.84901452957;5066.898662026665;4565.223911935045;4722.394385908808;4779;4991.50084991498;5359.551572195147;5211.296474975981;5292.311999440049;5368.624196306221;5470.480304371078;5484.725763711878;4412.867613971586;5318.361796584435;5336.012837625051;5357.866053348542;5376.1398176291605 18:01:25 INFO - PROCESS | 1639 | |5;yui.html;683.5181197255935;716.6094478509209;731.9780406587803;768.5427170833352;773.9822133893929;14377.784333234997;15402.768958465604;15420.922895385522;15454.1500217488;15455.768163477556;13887.236202008886;13925.860741392584;13938.303084845767;13950.441982320695;14016.369263383147;669.9665016749155;695.4714417043058;819.3936486999607;838.4508147163617;846.7205822078699;838.4843321357351;840.2647683277132;840.6931470013462;842.3640151685469;842.7134774176778;899.280575539569;900.0414558495214;900.522722956834;900.9909900900973;901.9052999435063;891.2513488669549;892.281713220857;893.5487578772678;896.3994123936945;896.7264984179856;665.1552528289094;665.7669815564562;666.6466772610524;667.4960404894322;668.19482523559;14052.946029047862;14201;14202.85797142036;14227.857721422757;14999;14021.808146307576;14409.85590144106;14478.782818257734;14509.709805803825;14765.852341476555;10613.363198208055;10986.780264394747;11533.942330288379;11785.528578856836;11819.172657913949;3177.22158071274;3743.794091324976;3804.5434547854156;3832.080300727805;3852.57621661617;79818;79828;85422.99999999937;86258;86581;10826.67519974402;11044.392558409203;11103.72240693989;11126.388048657402;11246.49390777417;21313.78686213118;21582.136714531556;21666.13335466595;21934.89032554827;21962.560748785254;7486.887696684554;7675.731349402744;7707.14055567957;7787.221277872168;8012;4307.56924307573;4387.166438376698;4422.646188304928;4484.035932274576;4579.267317229227;3268.084936217863;3351.715104216169;3370.9325813483592;3384.8138352390856;3387.2378714788974;550.7246376811594;629.3863483103937;658.6114192626374;689.1282527602586;701.2566679319938;547.2748608094291;639.4852144024012;647.3397134922353;655.672163918041;731.7804658602398;9025.277977761763;9180.17378435944;9334.486603236752;9542.809143817085;9688.46713430754;555.476076543223;638.4222278837659;643.0771842406162;700.5026431233779;701.9227884932653;4179.226843034048;4827.758612069382;5014.949850501448;5039.370078740158;5059.747012649353;109917;114886.85113148928;118789.40605296918;119742.40128799301;120828.3958580219;100948.49525752325;101754.98245017603;104725;105588;111877.70320656226;82553;88507.55746221228;89647.10352896518;95842;97549;9984.850227246452;9997.854109380454;10095.54570044335;10170.796584068425;10177.847332289874;51246.46260612187;56708.71645641745;57924;59578.808423830415;60643;81691;83563;83806.16193838227;84557;86841.56579217063;10329;10995.945020275167;12079.094067944763;12653;12673.302968336462;14219.50231741884;14673.706525869637;15000.249987500363;15071.383987397772;15155.621109471911;12605;13582.25297608641;13858.514951976633;14057.086289391156;14316.06945548536;13837.584872453843;13958.546379667112;14251.857481425053;14252.857471425154;14712.264386780833;13621.046526743034;13649.931750341184;13836.377363018488;14304.57086287413;14325.713485730435;11335.71660708456;11380;11529.308241505536;12024.579139730067;12138;11162.832557511481;11467.254628449124;11664.358460284766;11749;11768.52925882955 18:01:25 INFO - PROCESS | 1639 | __end_tp_report 18:01:25 INFO - PROCESS | 1639 | __start_cc_report 18:01:25 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,1738 18:01:25 INFO - PROCESS | 1639 | __end_cc_report 18:01:25 INFO - PROCESS | 1639 | __startTimestamp1485914485126__endTimestamp 18:01:25 INFO - PROCESS | 1639 | 18:01:25 INFO - PROCESS | 1639 | ------- Summary: start ------- 18:01:25 INFO - PROCESS | 1639 | Number of tests: 6 18:01:25 INFO - PROCESS | 1639 | 18:01:25 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5865.80 Median:6157.69 stddev:667.94 (10.8%) stddev-sans-first:643.15 18:01:25 INFO - PROCESS | 1639 | Values: 3476.5 3518.2 3531.5 3532.7 3592.9 5878.9 5949.7 5956.4 5997.1 6006.5 4298.0 5371.0 5803.2 5834.0 5921.7 4399.3 5181.1 5262.0 5300.2 5321.0 5233.2 5242.9 5262.8 5286.2 5363.4 5297.3 5368.4 5382.6 5403.4 5417.7 5359.7 5364.8 5371.3 5373.4 5378.5 5092.3 5204.7 5316.6 5339.4 5382.7 5727.6 5763.4 5783.2 5862.9 5912.3 6283.7 6293.8 6297.1 6322.5 6325.5 6315.4 6319.6 6320.3 6321.7 6331.8 5734.6 5861.6 5939.3 5967.1 5992.4 6391.1 6426.8 6435.3 6443.0 6449.0 6314.4 6326.7 6346.6 6346.7 6361.0 6251.9 6260.6 6308.6 6322.4 6330.1 6325.5 6331.6 6349.3 6351.5 6361.8 6251.8 6269.7 6328.7 6338.2 6342.7 4921.7 4996.8 4998.3 5048.6 5084.6 4421.9 4486.2 4494.1 4510.1 4570.1 6031.1 6046.9 6063.5 6080.4 6119.0 5077.4 6278.2 6304.8 6335.5 6340.6 5996.3 6050.7 6052.4 6128.1 6131.7 5524.7 5573.4 5581.6 5598.3 5602.4 6308.2 6575.4 6577.5 6578.5 6584.0 6218.6 6227.6 6250.8 6316.4 6341.7 6407.9 6565.4 6597.8 6599.9 6615.8 6259.9 6260.0 6324.0 6331.2 6332.3 6189.9 6249.8 6364.7 6370.5 6381.7 6170.5 6179.5 6240.3 6282.5 6288.3 6217.3 6249.1 6262.8 6268.4 6269.1 5935.1 6188.2 6204.0 6206.3 6231.2 6153.7 6157.7 6196.7 6197.5 6300.1 5945.0 6146.9 6147.9 6151.9 6174.8 18:01:25 INFO - PROCESS | 1639 | 18:01:25 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:69236.64 Median:35854.37 stddev:154838.92 (431.9%) stddev-sans-first:155187.23 18:01:25 INFO - PROCESS | 1639 | Values: 484.4 497.4 517.7 529.3 564.5 28398.0 32491.0 32525.3 39582.2 40537.8 42326.0 42634.8 42770.0 42805.4 42828.8 9571.2 9735.2 9754.2 9762.6 9776.6 8849.5 9062.8 9659.8 11501.3 11730.5 11837.5 11870.0 11883.8 11896.2 11901.3 11749.6 11821.3 11826.5 11827.3 11827.5 11522.4 11595.1 11634.2 11636.9 11673.6 39341.4 39572.0 39592.6 39627.6 39667.0 2795.5 3605.4 3652.2 3666.8 3766.5 29012.0 30353.9 31088.5 31141.4 31982.8 3162.4 3286.7 3311.6 3320.0 3416.8 515269.0 527114.0 527383.0 527444.0 529765.0 34967.3 35846.3 35862.5 36835.8 36976.8 37377.0 37455.3 37461.8 37504.4 37585.6 15439.4 15535.2 15581.0 15596.2 15631.4 12091.3 13049.4 13151.4 13170.6 13317.0 7724.2 8064.0 8295.1 8307.5 8333.2 3409.5 3427.3 3436.2 3444.7 3460.3 991.7 996.3 1037.0 1040.7 1083.8 29765.7 29922.9 30193.8 30445.0 30636.0 926.7 1042.1 1129.7 1146.7 1156.4 15287.0 15462.0 15629.8 15846.7 15935.0 591854.0 594772.0 596120.0 600877.0 602910.0 58677.7 59337.7 59358.7 59396.0 59407.7 1360.7 1381.3 1406.6 1407.2 1412.4 23920.9 29235.6 29701.9 30007.5 30618.1 50929.5 51359.0 51384.0 51388.7 51597.7 604914.0 609726.0 610142.0 610337.0 611668.0 27307.7 27577.2 27889.6 27941.2 27996.2 47486.5 47523.8 47944.5 47994.0 48320.0 34294.8 38736.0 39472.0 39671.6 39862.0 37757.8 38695.0 38943.0 39827.0 40090.6 36434.6 38879.4 39058.8 39146.4 39330.0 24480.8 30147.7 32651.8 34287.3 34431.8 24849.1 25056.7 25220.1 25431.9 25499.5 18:01:25 INFO - PROCESS | 1639 | 18:01:25 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:37532.09 Median:17254.02 stddev:101843.24 (590.3%) stddev-sans-first:102090.70 18:01:25 INFO - PROCESS | 1639 | Values: 363.7 365.2 386.7 395.8 415.1 15857.2 15984.9 18777.2 20500.9 20513.3 19875.8 20464.0 20822.0 21408.0 21422.5 4642.3 5239.7 5330.7 5519.0 5521.5 4094.9 5418.1 5473.3 5477.0 5502.9 4278.6 7477.6 7939.3 7964.6 7971.9 7688.3 7860.4 7926.4 7990.2 7993.0 7422.8 7629.4 7705.3 7726.4 7736.7 27940.6 28103.7 28153.6 28455.0 28847.4 2616.3 2642.8 2727.4 2941.2 3468.4 16456.9 16735.4 16986.8 17514.8 17708.5 2031.8 2032.3 2037.5 2080.4 2108.4 129907.0 131376.0 133511.3 133636.3 133851.7 19917.7 20905.4 21826.3 22040.6 22090.4 31566.8 35819.8 36071.5 36545.6 36616.1 10729.2 11058.2 11239.4 11247.1 11433.3 9141.2 9163.1 9248.2 9334.3 9355.2 7898.9 9841.8 9929.2 9930.7 9964.4 3218.3 3794.9 3800.3 3804.4 3815.5 833.5 933.0 939.6 965.9 967.1 20042.6 21185.7 21240.5 21244.0 21330.4 927.0 938.5 954.6 977.2 1045.2 10384.8 11131.9 11155.5 11172.0 11179.2 603349.0 604259.0 611146.0 613719.0 613904.0 119695.0 131049.0 132803.0 133877.3 136196.6 844.4 980.9 1033.3 1049.8 1050.8 15447.5 18369.9 20107.2 20135.4 20278.9 51113.7 53534.0 55947.0 58621.0 58855.0 80741.6 85722.0 85822.0 86063.0 86323.0 5449.6 5576.2 6715.9 8040.6 8567.6 10852.4 12037.4 12334.2 12770.4 13076.0 10980.9 10992.8 11145.6 11390.7 11442.8 11072.7 11135.1 11216.0 11349.3 11457.6 10905.2 11206.3 11327.0 11351.2 11615.3 8185.0 8281.3 8284.3 8365.2 8574.8 8252.2 9223.9 10818.4 10820.7 11072.7 18:01:25 INFO - PROCESS | 1639 | 18:01:25 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5417.17 Median:5097.52 stddev:2941.88 (57.7%) stddev-sans-first:2934.27 18:01:25 INFO - PROCESS | 1639 | Values: 1352.7 1391.9 1483.4 1632.2 1835.8 7536.7 7947.1 7962.7 7973.4 7978.5 8037.4 8315.0 8315.8 8387.2 8407.0 2359.3 2392.8 2393.2 2396.1 2396.1 2056.7 2384.5 2422.5 2424.3 2439.9 2078.0 2283.6 2384.4 2391.5 2405.8 2340.8 2352.8 2373.9 2374.5 2379.3 2368.1 2372.5 2390.0 2403.1 2409.4 8387.3 8389.4 8489.8 8499.3 8519.1 4835.5 5144.5 5270.8 5279.9 5308.5 3389.4 3471.7 3519.1 3592.9 3600.0 1039.7 1043.1 1080.9 1082.4 1088.9 9350.1 10873.0 10911.8 10913.3 10995.2 4051.7 4257.4 4334.6 4483.9 4486.1 8486.2 8502.8 8503.1 8507.8 8509.0 5089.8 5093.8 5095.3 5099.7 5106.1 4418.2 4559.7 4730.5 4798.2 4842.1 3676.5 3717.1 3769.5 3807.4 3809.4 1155.5 1156.0 1160.8 1167.9 1171.3 773.2 873.2 897.2 912.4 917.3 5527.1 5538.3 5567.4 5780.7 5823.2 937.8 949.4 951.1 956.9 987.0 3645.7 3651.7 3722.4 3896.9 3903.9 9799.5 10035.2 10091.3 10135.5 10140.2 9600.5 10004.6 10021.9 10022.5 10023.9 7634.5 7870.7 7874.3 7877.8 7885.6 5452.9 5509.9 5533.0 5779.5 5779.9 9375.8 9387.5 9491.3 9532.7 9536.7 9345.6 9558.6 9622.9 9721.6 9733.4 7144.9 7252.6 7296.8 7343.0 7392.5 7829.0 7938.4 7942.4 7949.6 7951.6 6964.0 7175.7 7205.8 7230.9 7251.2 6714.8 6759.6 6895.2 7026.2 7118.7 6143.6 6349.7 6673.1 6676.8 6791.0 4863.6 4892.6 4902.9 4915.8 4932.5 4274.3 4833.6 4839.7 4868.3 5005.2 18:01:25 INFO - PROCESS | 1639 | 18:01:25 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4285.40 Median:4837.56 stddev:1278.38 (26.4%) stddev-sans-first:1246.57 18:01:25 INFO - PROCESS | 1639 | Values: 304.7 308.9 312.2 320.9 322.3 4340.7 5053.5 5089.8 5147.9 5201.1 4203.8 4818.5 4915.7 4948.4 4998.9 3241.0 3910.6 3981.2 3988.4 3995.0 3339.3 3956.4 3971.6 3973.6 3983.8 3101.3 3443.8 3923.7 3939.6 3954.6 3972.3 3981.7 3993.8 3996.8 4005.5 2917.8 3023.9 3057.5 3121.5 3527.0 5029.5 5049.9 5051.2 5058.4 5069.6 4267.3 4354.3 4532.2 4591.7 4596.0 5387.7 5407.9 5413.2 5420.3 5424.9 3516.4 3668.0 3890.3 3905.8 3909.8 4978.8 5623.9 5635.3 5642.0 5678.9 3929.4 3937.9 3938.2 3944.3 3962.0 3968.1 3992.5 3994.9 3998.6 4000.2 3943.6 4244.9 4398.2 4549.8 4590.9 5395.0 5433.5 5437.6 5443.2 5459.8 1101.7 1275.3 1293.5 1296.8 1302.9 831.1 846.8 853.5 858.4 881.0 4292.0 4866.0 4883.8 4884.2 4906.6 4459.8 4651.6 5064.8 5172.3 5256.9 4337.7 4451.4 4581.3 4779.8 4833.8 2266.6 2704.1 2705.8 2712.8 2757.3 4985.9 5152.6 5383.4 5423.0 5447.0 4298.4 5168.1 5312.6 5323.7 5330.7 4883.9 4920.8 5409.8 5443.5 5444.7 5036.9 5189.6 5191.3 5192.9 5221.4 4871.3 4890.4 5091.2 5168.8 5197.4 4638.9 5284.5 5306.6 5367.2 5434.5 3522.4 3686.7 3700.5 3712.3 3721.2 4841.3 4915.3 5127.9 5150.6 5163.3 4434.5 4763.7 4953.5 5044.6 5075.6 4314.9 4721.2 5000.7 5032.8 5066.9 4565.2 4722.4 4779.0 4991.5 5359.6 5211.3 5292.3 5368.6 5470.5 5484.7 4412.9 5318.4 5336.0 5357.9 5376.1 18:01:25 INFO - PROCESS | 1639 | 18:01:25 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:21706.65 Median:3818.31 stddev:31916.75 (835.9%) stddev-sans-first:31967.25 18:01:25 INFO - PROCESS | 1639 | Values: 683.5 716.6 732.0 768.5 774.0 14377.8 15402.8 15420.9 15454.2 15455.8 13887.2 13925.9 13938.3 13950.4 14016.4 670.0 695.5 819.4 838.5 846.7 838.5 840.3 840.7 842.4 842.7 899.3 900.0 900.5 901.0 901.9 891.3 892.3 893.5 896.4 896.7 665.2 665.8 666.6 667.5 668.2 14052.9 14201.0 14202.9 14227.9 14999.0 14021.8 14409.9 14478.8 14509.7 14765.9 10613.4 10986.8 11533.9 11785.5 11819.2 3177.2 3743.8 3804.5 3832.1 3852.6 79818.0 79828.0 85423.0 86258.0 86581.0 10826.7 11044.4 11103.7 11126.4 11246.5 21313.8 21582.1 21666.1 21934.9 21962.6 7486.9 7675.7 7707.1 7787.2 8012.0 4307.6 4387.2 4422.6 4484.0 4579.3 3268.1 3351.7 3370.9 3384.8 3387.2 550.7 629.4 658.6 689.1 701.3 547.3 639.5 647.3 655.7 731.8 9025.3 9180.2 9334.5 9542.8 9688.5 555.5 638.4 643.1 700.5 701.9 4179.2 4827.8 5014.9 5039.4 5059.7 109917.0 114886.9 118789.4 119742.4 120828.4 100948.5 101755.0 104725.0 105588.0 111877.7 82553.0 88507.6 89647.1 95842.0 97549.0 9984.9 9997.9 10095.5 10170.8 10177.8 51246.5 56708.7 57924.0 59578.8 60643.0 81691.0 83563.0 83806.2 84557.0 86841.6 10329.0 10995.9 12079.1 12653.0 12673.3 14219.5 14673.7 15000.2 15071.4 15155.6 12605.0 13582.3 13858.5 14057.1 14316.1 13837.6 13958.5 14251.9 14252.9 14712.3 13621.0 13649.9 13836.4 14304.6 14325.7 11335.7 11380.0 11529.3 12024.6 12138.0 11162.8 11467.3 11664.4 11749.0 11768.5 18:01:25 INFO - PROCESS | 1639 | -------- Summary: end -------- 18:01:25 INFO - PROCESS | 1639 | 18:01:25 INFO - TEST-INFO | 1639: exit 0 18:01:25 INFO - TEST-OK | dromaeo_css | took 1117467ms 18:01:25 INFO - TEST-START | kraken 18:01:25 INFO - operating with platform_type : mac_ 18:01:25 INFO - Initialising browser for kraken test... 18:01:25 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmpOKdEfP/profile http://localhost:49243/getInfo.html) 18:01:28 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 18:01:28 INFO - PROCESS | 1649 | colorDepth:24 18:01:28 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 18:01:28 INFO - PROCESS | 1649 | __metrics 18:01:28 INFO - PROCESS | 1649 | 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" 18:01:28 INFO - PROCESS | 1649 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:01:29 INFO - TEST-INFO | 1649: exit 0 18:01:29 INFO - Browser initialized. 18:01:29 INFO - Running cycle 1/1 for kraken test... 18:01:29 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmpOKdEfP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:01:41 INFO - PROCESS | 1651 | RSS: Main: 172552192 18:01:41 INFO - PROCESS | 1651 | 18:01:44 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 18:01:44 INFO - PROCESS | 1651 | RSS: Main: 222187520 18:01:44 INFO - PROCESS | 1651 | 18:01:47 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 18:01:48 INFO - PROCESS | 1651 | RSS: Main: 233365504 18:01:48 INFO - PROCESS | 1651 | 18:01:51 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 18:01:51 INFO - PROCESS | 1651 | RSS: Main: 330530816 18:01:51 INFO - PROCESS | 1651 | 18:01:53 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 18:01:54 INFO - PROCESS | 1651 | RSS: Main: 232329216 18:01:54 INFO - PROCESS | 1651 | 18:01:56 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:01:57 INFO - PROCESS | 1651 | RSS: Main: 233656320 18:01:57 INFO - PROCESS | 1651 | 18:01:59 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 18:02:00 INFO - PROCESS | 1651 | RSS: Main: 272748544 18:02:00 INFO - PROCESS | 1651 | 18:02:03 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 18:02:03 INFO - PROCESS | 1651 | RSS: Main: 274673664 18:02:03 INFO - PROCESS | 1651 | 18:02:06 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 18:02:07 INFO - PROCESS | 1651 | RSS: Main: 272797696 18:02:07 INFO - PROCESS | 1651 | 18:02:08 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:02:09 INFO - PROCESS | 1651 | RSS: Main: 248942592 18:02:09 INFO - PROCESS | 1651 | 18:02:11 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:02:11 INFO - PROCESS | 1651 | RSS: Main: 251523072 18:02:11 INFO - PROCESS | 1651 | 18:02:14 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:02:14 INFO - PROCESS | 1651 | RSS: Main: 254590976 18:02:14 INFO - PROCESS | 1651 | 18:02:17 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:02:18 INFO - PROCESS | 1651 | RSS: Main: 267751424 18:02:18 INFO - PROCESS | 1651 | 18:02:21 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:02:21 INFO - PROCESS | 1651 | RSS: Main: 267399168 18:02:21 INFO - PROCESS | 1651 | 18:02:23 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 18:02:23 INFO - PROCESS | 1651 | RSS: Main: 311123968 18:02:23 INFO - PROCESS | 1651 | 18:02:23 INFO - PROCESS | 1651 | __start_tp_report 18:02:23 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 18:02:23 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 18:02:23 INFO - PROCESS | 1651 | |i|pagename|runs| 18:02:23 INFO - PROCESS | 1651 | |0;ai-astar;115;116;117;114;115;115;115;115;115;115 18:02:23 INFO - PROCESS | 1651 | |1;audio-beat-detection;141;110;116;174;112;110;110;109;137;109 18:02:23 INFO - PROCESS | 1651 | |2;audio-dft;182;184;187;183;181;181;183;182;186;182 18:02:23 INFO - PROCESS | 1651 | |3;audio-fft;81;59;59;89;62;59;59;59;83;58 18:02:23 INFO - PROCESS | 1651 | |4;audio-oscillator;84;70;93;71;69;69;89;69;68;93 18:02:23 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;91;88;91;89;91;88;92;89;92;129 18:02:23 INFO - PROCESS | 1651 | |6;imaging-darkroom;96;96;96;97;95;96;96;96;96;96 18:02:23 INFO - PROCESS | 1651 | |7;imaging-desaturate;83;81;79;80;83;81;86;86;83;82 18:02:23 INFO - PROCESS | 1651 | |8;json-parse-financial;55;54;53;55;56;56;57;57;56;56 18:02:23 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;64;72;67;76;73;67;70;69;69;70 18:02:23 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;83;83;83;82;82;83;84;82;85;83 18:02:23 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;162;126;138;149;146;148;138;142;177;136 18:02:23 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;161;163;163;164;167;205;158;162;162;161 18:02:23 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;68;67;67;67;66;67;66;69;66;66 18:02:23 INFO - PROCESS | 1651 | __end_tp_report 18:02:23 INFO - PROCESS | 1651 | __start_cc_report 18:02:23 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1895 18:02:23 INFO - PROCESS | 1651 | __end_cc_report 18:02:23 INFO - PROCESS | 1651 | __startTimestamp1485914543767__endTimestamp 18:02:23 INFO - PROCESS | 1651 | 18:02:23 INFO - PROCESS | 1651 | ------- Summary: start ------- 18:02:23 INFO - PROCESS | 1651 | Number of tests: 14 18:02:23 INFO - PROCESS | 1651 | 18:02:23 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:115.20 Median:115.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 18:02:23 INFO - PROCESS | 1651 | Values: 115.0 116.0 117.0 114.0 115.0 115.0 115.0 115.0 115.0 115.0 18:02:23 INFO - PROCESS | 1651 | 18:02:23 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:122.80 Median:114.00 stddev:21.58 (18.9%) stddev-sans-first:21.86 18:02:23 INFO - PROCESS | 1651 | Values: 141.0 110.0 116.0 174.0 112.0 110.0 110.0 109.0 137.0 109.0 18:02:23 INFO - PROCESS | 1651 | 18:02:23 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:183.10 Median:183.00 stddev:2.02 (1.1%) stddev-sans-first:2.11 18:02:23 INFO - PROCESS | 1651 | Values: 182.0 184.0 187.0 183.0 181.0 181.0 183.0 182.0 186.0 182.0 18:02:23 INFO - PROCESS | 1651 | 18:02:23 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:66.80 Median:60.50 stddev:12.30 (20.3%) stddev-sans-first:11.92 18:02:23 INFO - PROCESS | 1651 | Values: 81.0 59.0 59.0 89.0 62.0 59.0 59.0 59.0 83.0 58.0 18:02:23 INFO - PROCESS | 1651 | 18:02:23 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:77.50 stddev:10.86 (14.0%) stddev-sans-first:11.26 18:02:23 INFO - PROCESS | 1651 | Values: 84.0 70.0 93.0 71.0 69.0 69.0 89.0 69.0 68.0 93.0 18:02:23 INFO - PROCESS | 1651 | 18:02:23 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:94.00 Median:91.00 stddev:12.39 (13.6%) stddev-sans-first:13.10 18:02:23 INFO - PROCESS | 1651 | Values: 91.0 88.0 91.0 89.0 91.0 88.0 92.0 89.0 92.0 129.0 18:02:23 INFO - PROCESS | 1651 | 18:02:23 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 18:02:23 INFO - PROCESS | 1651 | Values: 96.0 96.0 96.0 97.0 95.0 96.0 96.0 96.0 96.0 96.0 18:02:23 INFO - PROCESS | 1651 | 18:02:23 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:82.40 Median:83.00 stddev:2.32 (2.8%) stddev-sans-first:2.45 18:02:23 INFO - PROCESS | 1651 | Values: 83.0 81.0 79.0 80.0 83.0 81.0 86.0 86.0 83.0 82.0 18:02:23 INFO - PROCESS | 1651 | 18:02:23 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:56.00 stddev:1.27 (2.3%) stddev-sans-first:1.33 18:02:23 INFO - PROCESS | 1651 | Values: 55.0 54.0 53.0 55.0 56.0 56.0 57.0 57.0 56.0 56.0 18:02:23 INFO - PROCESS | 1651 | 18:02:23 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:70.00 stddev:3.40 (4.9%) stddev-sans-first:2.92 18:02:23 INFO - PROCESS | 1651 | Values: 64.0 72.0 67.0 76.0 73.0 67.0 70.0 69.0 69.0 70.0 18:02:23 INFO - PROCESS | 1651 | 18:02:23 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:83.00 stddev:0.94 (1.1%) stddev-sans-first:1.00 18:02:23 INFO - PROCESS | 1651 | Values: 83.0 83.0 83.0 82.0 82.0 83.0 84.0 82.0 85.0 83.0 18:02:23 INFO - PROCESS | 1651 | 18:02:23 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:146.20 Median:147.00 stddev:14.43 (9.8%) stddev-sans-first:14.13 18:02:23 INFO - PROCESS | 1651 | Values: 162.0 126.0 138.0 149.0 146.0 148.0 138.0 142.0 177.0 136.0 18:02:23 INFO - PROCESS | 1651 | 18:02:23 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.60 Median:163.00 stddev:13.69 (8.4%) stddev-sans-first:14.37 18:02:23 INFO - PROCESS | 1651 | Values: 161.0 163.0 163.0 164.0 167.0 205.0 158.0 162.0 162.0 161.0 18:02:23 INFO - PROCESS | 1651 | 18:02:23 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:0.99 (1.5%) stddev-sans-first:0.97 18:02:23 INFO - PROCESS | 1651 | Values: 68.0 67.0 67.0 67.0 66.0 67.0 66.0 69.0 66.0 66.0 18:02:23 INFO - PROCESS | 1651 | -------- Summary: end -------- 18:02:23 INFO - PROCESS | 1651 | 18:02:24 INFO - TEST-INFO | 1651: exit 0 18:02:24 INFO - TEST-OK | kraken | took 59040ms 18:02:24 INFO - SUITE-END | took 1176s 18:02:24 INFO - Completed test suite (00:19:36) 18:02:24 INFO - javascript benchmark 18:02:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3476.5132881396603, 3518.155642645766, 3531.5232443620102, 3532.7173826093913, 3592.9281414371712, 5878.941210587898, 5949.70251487425, 5956.404359564041, 5997.13041608967, 6006.549508786842, 4297.957020429795, 5371.0, 5803.216565763621, 5833.970830145854, 5921.703914804253, 4399.318105693623, 5181.1192097343355, 5262.0, 5300.204969254604, 5321.0, 5233.18885572735, 5242.895142097156, 5262.7631756571045, 5286.154215325549, 5363.436839131893, 5297.258383826267, 5368.436314187013, 5382.6232163748555, 5403.432639572848, 5417.674939503623, 5359.651622644516, 5364.758585863646, 5371.334886185295, 5373.435789242112, 5378.46215378463, 5092.3125378073855, 5204.687718736888, 5316.627836051478, 5339.385970613391, 5382.67703937765, 5727.570432217601, 5763.3948435414095, 5783.21926539916, 5862.853428664317, 5912.320083190445, 6283.717232724538, 6293.779717709858, 6297.118403423525, 6322.462590679797, 6325.462335701471, 6315.400036996478, 6319.6208227506495, 6320.273168585625, 6321.715522801485, 6331.778387756406, 5734.627249228787, 5861.589688721791, 5939.287285525678, 5967.075103358986, 5992.370801065826, 6391.1371964785085, 6426.775062872871, 6435.324290949477, 6442.967785161044, 6449.0, 6314.431701146918, 6326.715297811609, 6346.619202847844, 6346.746130154835, 6361.0, 6251.874962500725, 6260.593061450991, 6308.621482711052, 6322.430981211713, 6330.145430366933, 6325.5255855811, 6331.620102793847, 6349.269833969152, 6351.523635727339, 6361.840953976188, 6251.812445626639, 6269.7492100316385, 6328.71520781566, 6338.176037115238, 6342.651154186564, 4921.704697718148, 4996.800127994839, 4998.300237966688, 5048.621353398436, 5084.618653600995, 4421.867343979686, 4486.170058539181, 4494.1461122386645, 4510.0528888933695, 4570.063137056895, 6031.09533569968, 6046.939530604637, 6063.484603808637, 6080.361562035922, 6118.969405152946, 5077.365329333833, 6278.183836101369, 6304.779332723333, 6335.524835637346, 6340.556161068681, 5996.2504686914135, 6050.667213303311, 6052.364501727343, 6128.1114238435175, 6131.693415329305, 5524.723763811874, 5573.386927437979, 5581.6371935824045, 5598.3282006159525, 5602.411746766531, 6308.243010838729, 6575.44108750752, 6577.50668699859, 6578.506612004215, 6584.012398140318, 6218.5647004711045, 6227.595206311576, 6250.843728906813, 6316.399942005502, 6341.682915854281, 6407.9038814418755, 6565.376289252514, 6597.80206593803, 6599.934000660124, 6615.834604134935, 6259.906101408392, 6260.029695397221, 6323.9683801580695, 6331.176946996861, 6332.30344662096, 6189.938100618936, 6249.843778900918, 6364.713587888464, 6370.458511026614, 6381.680915954276, 6170.475509581735, 6179.474744646755, 6240.344763799917, 6282.497400207881, 6288.308286088618, 6217.316095229611, 6249.125122482947, 6262.843428914131, 6268.404501572526, 6269.12232287471, 5935.080062590306, 6188.164597779422, 6204.007358822747, 6206.286277078013, 6231.158793562992, 6153.72308246139, 6157.692115394302, 6196.659183744938, 6197.4732147767945, 6300.054991751274, 5944.970275148597, 6146.938530614637, 6147.938520614736, 6151.907721384272, 6174.845628859135], "value": 5823.90219067349, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [484.36064394998607, 497.36834220539913, 517.7049082023249, 529.2907503944715, 564.4722184757252, 28398.0, 32491.0, 32525.349493010126, 39582.20835583287, 40537.797311013404, 42326.0, 42634.78682606583, 42770.0, 42805.35791963123, 42828.78585607067, 9571.234301255918, 9735.17251033663, 9754.219662426989, 9762.560684769202, 9776.560054797552, 8849.513276769776, 9062.773430664252, 9659.806803863954, 11501.252418592765, 11730.472128754227, 11837.467313970848, 11869.991050760696, 11883.821742673867, 11896.167268291223, 11901.345426001566, 11749.588764393247, 11821.34982575958, 11826.467808948575, 11827.290362578273, 11827.526898924032, 11522.42387880611, 11595.072394208442, 11634.243774154653, 11636.883631163664, 11673.649790506213, 39341.40987885184, 39572.0, 39592.60407395918, 39627.60372396268, 39667.0, 2795.4828356754065, 3605.369060414443, 3652.196516766307, 3666.834992425347, 3766.472693822867, 29011.984580539578, 30353.937612183687, 31088.533671994937, 31141.37717245665, 31982.840085799653, 3162.383335249627, 3286.6877646623534, 3311.602607687069, 3319.9834000830083, 3416.79499230047, 515269.0, 527114.0, 527383.0, 527444.0, 529765.0, 34967.30065398678, 35846.28307433837, 35862.46206306908, 36835.81582092126, 36976.81511592425, 37377.0, 37455.25089498249, 37461.81269093637, 37504.43743343852, 37585.62414375876, 15439.382424702886, 15535.223238838013, 15580.987235829634, 15596.220188990505, 15631.374745010073, 12091.27452352844, 13049.412776425084, 13151.408186631434, 13170.60488185356, 13317.00122490817, 7724.227577242344, 8064.0, 8295.087540370554, 8307.543085130255, 8333.16668333174, 3409.505621684842, 3427.3145370925417, 3436.226848959014, 3444.7244220462303, 3460.3079384123275, 991.682661548312, 996.3175224970918, 1036.984445233322, 1040.7190058684264, 1083.7886612110563, 29765.702342976725, 29922.850385748367, 30193.849030755144, 30445.0, 30636.0, 926.7219834049893, 1042.1402343067, 1129.6836885672026, 1146.696125526736, 1156.4275683536703, 15287.0, 15462.0, 15629.765553516707, 15846.683066338608, 15935.0, 591854.0, 594772.0, 596120.0, 600877.0, 602910.0, 58677.70661146667, 59337.703311483165, 59358.70320648369, 59396.0, 59407.702961484916, 1360.7346567419258, 1381.3162484570203, 1406.5569345656086, 1407.1697698357814, 1412.3503188533389, 23920.88039559791, 29235.561466577594, 29701.851490743273, 30007.549886752153, 30618.08145755631, 50929.490705092474, 51359.0, 51384.0, 51388.715282118246, 51597.7420112897, 604914.0, 609726.0, 610142.0, 610337.0, 611668.0, 27307.72692273052, 27577.17268481949, 27889.581656274768, 27941.161765147077, 27996.160115196577, 47486.52513474821, 47523.76238118787, 47944.520554794006, 47994.040119196725, 48320.0, 34294.828525857214, 38736.0, 39472.0, 39671.60328396795, 39862.00344991399, 37757.81121094377, 38695.03262418462, 38943.0, 39827.0, 40090.599094008685, 36434.63565364313, 38879.41680874732, 39058.804705977425, 39146.41280380853, 39330.0, 24480.755192447847, 30147.69852301449, 32651.836740816143, 34287.31425371528, 34431.827840860635, 24849.1302804401, 25056.749432505443, 25220.117295894557, 25431.87284063568, 25499.490010200065], "value": 18946.863163892816, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.6563447542074, 365.18927979884654, 386.66939766499644, 395.7684754418665, 415.08266730525537, 15857.207139643015, 15984.920075399621, 18777.15502802372, 20500.897495512538, 20513.282035128774, 19875.80124198761, 20464.0, 20822.0, 21408.0, 21422.464438389048, 4642.280446530776, 5239.711815850127, 5330.680159190441, 5519.0, 5521.475459831309, 4094.877153685379, 5418.051840927842, 5473.261109750172, 5476.959377718241, 5502.889942201154, 4278.6363159131515, 7477.588732619731, 7939.325157361631, 7964.60176991151, 7971.920280797176, 7688.308052275294, 7860.449768516206, 7926.445148839583, 7990.1610330915, 7992.960035199787, 7422.7773166804545, 7629.427792915553, 7705.267999540035, 7726.420518461138, 7736.729214477523, 27940.58089128665, 28103.71896281052, 28153.57769633457, 28455.0, 28847.42305153885, 2616.3328351270493, 2642.775364094054, 2727.386338073937, 2941.1911724275997, 3468.3756923753713, 16456.920622257632, 16735.414260500824, 16986.830131698647, 17514.824851751448, 17708.468745937644, 2031.8316967743458, 2032.298856894369, 2037.4906273431643, 2080.4382816639422, 2108.4307237046064, 129907.0, 131376.0, 133511.33244333812, 133636.33181834125, 133851.6614833849, 19917.701234481494, 20905.37283881486, 21826.345209643736, 22040.559188816133, 22090.44773880666, 31566.842165789025, 35819.82090089533, 36071.4589281161, 36545.634543654225, 36616.08459788527, 10729.248952573245, 11058.170637202242, 11239.438028098562, 11247.100231981422, 11433.314001159957, 9141.177294043568, 9163.083691630916, 9248.21390181842, 9334.253259739204, 9355.158035776813, 7898.921010789819, 9841.834796344792, 9929.2056635469, 9930.652427165014, 9964.402135871871, 3218.3241519280746, 3794.905127371838, 3800.2779471900803, 3804.410316400962, 3815.4849095372324, 833.4874052457695, 932.9673461428953, 939.6429356844492, 965.8502932045544, 967.1247520993512, 20042.599148016958, 21185.68221476679, 21240.468988275417, 21244.0, 21330.360089197347, 926.9930848104187, 938.4979036215592, 954.5895265035962, 977.237754551451, 1045.1586472889246, 10384.792304153874, 11131.888681113247, 11155.498002589902, 11171.994520493196, 11179.161562882817, 603349.0, 604259.0, 611146.0, 613719.0, 613904.0, 119695.0, 131049.03426448611, 132803.0, 133877.3306133463, 136196.6380336184, 844.3582877013514, 980.9117179453883, 1033.3128469567803, 1049.7900419916048, 1050.7583255851198, 15447.5365739028, 18369.908150459163, 20107.19571217135, 20135.39593812188, 20278.884661343767, 51113.72215694637, 53534.0, 55947.0, 58621.0, 58855.0, 80741.59629201816, 85722.0, 85822.0, 86063.0, 86323.0, 5449.591280654046, 5576.247206627216, 6715.93284067153, 8040.597970101355, 8567.571621419029, 10852.403117828595, 12037.398130093636, 12334.198277111958, 12770.361481926053, 13075.953923686273, 10980.945095274472, 10992.835107473555, 11145.609903653332, 11390.715232119263, 11442.771144577227, 11072.723181920517, 11135.053520450852, 11216.0, 11349.262297950607, 11457.59898403552, 10905.236633435901, 11206.327620342805, 11326.980571748581, 11351.205415620827, 11615.30308181478, 8184.959075204586, 8281.337493000667, 8284.337253019865, 8365.163483651586, 8574.78563035929, 8252.174782521699, 9223.907760922304, 10818.390371761494, 10820.673555185673, 11072.723181920517], "value": 10948.61323502307, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1352.6618345413647, 1391.8538553451888, 1483.4214656284043, 1632.2002218912728, 1835.752173456583, 7536.660850261737, 7947.086085100215, 7962.721304754335, 7973.362131029518, 7978.48139870908, 8037.437379383446, 8315.0, 8315.75052748417, 8387.245147936685, 8407.0, 2359.315798418457, 2392.83250172488, 2393.162393162388, 2396.077510158584, 2396.113438027923, 2056.650369437192, 2384.523095380922, 2422.467057247403, 2424.284835973392, 2439.9390015249674, 2077.992173795708, 2283.566122436732, 2384.3919800450863, 2391.485830546432, 2405.807535397164, 2340.8361414700976, 2352.8235382346306, 2373.9406514837096, 2374.548835721225, 2379.3337865397802, 2368.0882860098814, 2372.5492156490213, 2390.032037025008, 2403.122860156048, 2409.4458274596764, 8387.280607475454, 8389.370797190235, 8489.830203395959, 8499.320054395634, 8519.10549392311, 4835.492273311322, 5144.485551444863, 5270.789168433258, 5279.947200527984, 5308.495692909168, 3389.3729660012978, 3471.7396195285455, 3519.1202199450136, 3592.946105808415, 3599.982000090009, 1039.7088815131776, 1043.1133536493996, 1080.9135269178446, 1082.3722241100143, 1088.9346639201674, 9350.111739384747, 10873.021428071432, 10911.83632245517, 10913.290636108706, 10995.175361847894, 4051.7034548944644, 4257.40396344512, 4334.609885110292, 4483.865484035484, 4486.057927835126, 8486.151384861589, 8502.829943401097, 8503.14968503157, 8507.829843403097, 8508.978922529212, 5089.821856235014, 5093.847184584469, 5095.337606111256, 5099.69401835891, 5106.106431374495, 4418.160549495586, 4559.703619264804, 4730.503297153749, 4798.184308667535, 4842.128416884994, 3676.540432445944, 3717.126475278307, 3769.547654281449, 3807.3527500325013, 3809.371453710107, 1155.5493357590547, 1155.9653210403533, 1160.785254727878, 1167.8832116788253, 1171.2562522798085, 773.1649818196335, 873.2187981279644, 897.1880448194395, 912.4342907397456, 917.2982668258787, 5527.143292789624, 5538.335399752055, 5567.387587365387, 5780.684802537023, 5823.1847541343395, 937.8218138553653, 949.3971328206638, 951.0727041134976, 956.9377990430617, 986.9753256168653, 3645.671889529955, 3651.707863370924, 3722.3858063419775, 3896.883093507143, 3903.9159064338855, 9799.510024498746, 10035.24735644815, 10091.344062635904, 10135.493225338703, 10140.239482038729, 9600.519974001272, 10004.649837255662, 10021.949890250502, 10022.498875056219, 10023.949880250551, 7634.541927484369, 7870.6851725931465, 7874.291313781787, 7877.7636670899965, 7885.605719713992, 5452.890942181213, 5509.917351239655, 5533.0, 5779.508741756998, 5779.913301300399, 9375.765605859908, 9387.483688397204, 9491.335606507755, 9532.666356677482, 9536.66621668266, 9345.579448924951, 9558.56986435626, 9622.855657165288, 9721.562529686322, 9733.415995040037, 7144.928550714426, 7252.5648461092505, 7296.7810965671115, 7343.008693826265, 7392.519486233377, 7828.960855195687, 7938.404619653665, 7942.44402891792, 7949.642266097924, 7951.602419879098, 6964.0, 7175.748848790476, 7205.819854503469, 7230.927690723025, 7251.166115896739, 6714.764983225564, 6759.594424334556, 6895.241523432519, 7026.19198792125, 7118.715251389886, 6143.600665956698, 6349.714262858275, 6673.099131617169, 6676.83307917306, 6791.0153027811675, 4863.586595139312, 4892.633052521146, 4902.8774280643265, 4915.8033678652455, 4932.457429682804, 4274.316109422478, 4833.637477189295, 4839.661223714306, 4868.2940973557925, 5005.174146265826], "value": 4403.7859106691985, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.73792538416967, 308.85483822603385, 312.206994234644, 320.93260415312784, 322.29256781364916, 4340.696151269412, 5053.5451809337155, 5089.770960306786, 5147.897042059161, 5201.141811601081, 4203.801916453811, 4818.542238487338, 4915.729634870089, 4948.38145231846, 4998.925016124761, 3240.95138572921, 3910.608939106095, 3981.183857309259, 3988.421678856564, 3994.9800250998705, 3339.34882697874, 3956.3867600521967, 3971.642552170304, 3973.602639736018, 3983.8207280672295, 3101.34871676947, 3443.7933723976516, 3923.7253392262555, 3939.606039396066, 3954.5847685992844, 3972.344563147077, 3981.721279510421, 3993.821822562351, 3996.760194388317, 4005.5193376794678, 2917.7811664125275, 3023.8811639693236, 3057.495513240313, 3121.4693502104697, 3527.030066731669, 5029.522195391469, 5049.924251136236, 5051.19180931053, 5058.418281897592, 5069.645124841262, 4267.274563324211, 4354.281543545311, 4532.206863798822, 4591.6556258280425, 4596.0, 5387.676739395649, 5407.918881216785, 5413.188021796723, 5420.34955805302, 5424.891502169974, 3516.40221162403, 3668.0201980850807, 3890.280298144852, 3905.824237909301, 3909.8465952544066, 4978.775955081994, 5623.8594035149035, 5635.295588051494, 5642.037930086737, 5678.933375976968, 3929.390944403622, 3937.8818635440985, 3938.212357528506, 3944.3097457944746, 3962.0293028208275, 3968.0675041365257, 3992.5208974923194, 3994.8801535953967, 3998.5801490843623, 4000.1999600079516, 3943.6253555912144, 4244.87265382039, 4398.23030969579, 4549.840755573605, 4590.88522786933, 5394.973025134927, 5433.538149257279, 5437.564994800407, 5443.183522471581, 5459.754311056012, 1101.7190616392768, 1275.2539764238024, 1293.518920835638, 1296.786030305008, 1302.856685764565, 831.1314676163423, 846.7629063862129, 853.470848074198, 858.4334339336008, 880.9735707928772, 4292.0, 4865.9756701216975, 4883.755812209375, 4884.194107972145, 4906.632002599819, 4459.754713490789, 4651.581267713313, 5064.822731204464, 5172.27588137661, 5256.896051829082, 4337.652987760972, 4451.354553589711, 4581.266997280419, 4779.832705855279, 4833.806647734052, 2266.580682573729, 2704.0806125917284, 2705.8094438447415, 2712.782977361846, 2757.277675138547, 4985.875353116128, 5152.562032227228, 5383.407825139231, 5423.0, 5446.972765136228, 4298.4412026436985, 5168.1497284523275, 5312.617090900023, 5323.661216108859, 5330.706811125426, 4883.853484395474, 4920.803167873388, 5409.78360865561, 5443.482869127427, 5444.673319600836, 5036.949630503648, 5189.636725429184, 5191.32512773337, 5192.896142077062, 5221.425643179171, 4871.293662419001, 4890.3836447501835, 5091.236314552847, 5168.793248270027, 5197.350331208599, 4638.8608341749805, 5284.497972692588, 5306.575473962151, 5367.248585197997, 5434.538064264424, 3522.3659741245797, 3686.668199861918, 3700.481932529502, 3712.2923455210907, 3721.1999420124803, 4841.322214889848, 4915.311856340187, 5127.923081153711, 5150.579227762945, 5163.251328557413, 4434.534373890824, 4763.7141771493825, 4953.479884612208, 5044.596432285335, 5075.568576670877, 4314.914835892352, 4721.244600863845, 5000.699958002531, 5032.84901452957, 5066.898662026665, 4565.223911935045, 4722.394385908808, 4779.0, 4991.50084991498, 5359.551572195147, 5211.296474975981, 5292.311999440049, 5368.624196306221, 5470.480304371078, 5484.725763711878, 4412.867613971586, 5318.361796584435, 5336.012837625051, 5357.866053348542, 5376.1398176291605], "value": 3882.1772702963726, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [683.5181197255935, 716.6094478509209, 731.9780406587803, 768.5427170833352, 773.9822133893929, 14377.784333234997, 15402.768958465604, 15420.922895385522, 15454.1500217488, 15455.768163477556, 13887.236202008886, 13925.860741392584, 13938.303084845767, 13950.441982320695, 14016.369263383147, 669.9665016749155, 695.4714417043058, 819.3936486999607, 838.4508147163617, 846.7205822078699, 838.4843321357351, 840.2647683277132, 840.6931470013462, 842.3640151685469, 842.7134774176778, 899.280575539569, 900.0414558495214, 900.522722956834, 900.9909900900973, 901.9052999435063, 891.2513488669549, 892.281713220857, 893.5487578772678, 896.3994123936945, 896.7264984179856, 665.1552528289094, 665.7669815564562, 666.6466772610524, 667.4960404894322, 668.19482523559, 14052.946029047862, 14201.0, 14202.85797142036, 14227.857721422757, 14999.0, 14021.808146307576, 14409.85590144106, 14478.782818257734, 14509.709805803825, 14765.852341476555, 10613.363198208055, 10986.780264394747, 11533.942330288379, 11785.528578856836, 11819.172657913949, 3177.22158071274, 3743.794091324976, 3804.5434547854156, 3832.080300727805, 3852.57621661617, 79818.0, 79828.0, 85422.99999999937, 86258.0, 86581.0, 10826.67519974402, 11044.392558409203, 11103.72240693989, 11126.388048657402, 11246.49390777417, 21313.78686213118, 21582.136714531556, 21666.13335466595, 21934.89032554827, 21962.560748785254, 7486.887696684554, 7675.731349402744, 7707.14055567957, 7787.221277872168, 8012.0, 4307.56924307573, 4387.166438376698, 4422.646188304928, 4484.035932274576, 4579.267317229227, 3268.084936217863, 3351.715104216169, 3370.9325813483592, 3384.8138352390856, 3387.2378714788974, 550.7246376811594, 629.3863483103937, 658.6114192626374, 689.1282527602586, 701.2566679319938, 547.2748608094291, 639.4852144024012, 647.3397134922353, 655.672163918041, 731.7804658602398, 9025.277977761763, 9180.17378435944, 9334.486603236752, 9542.809143817085, 9688.46713430754, 555.476076543223, 638.4222278837659, 643.0771842406162, 700.5026431233779, 701.9227884932653, 4179.226843034048, 4827.758612069382, 5014.949850501448, 5039.370078740158, 5059.747012649353, 109917.0, 114886.85113148928, 118789.40605296918, 119742.40128799301, 120828.3958580219, 100948.49525752325, 101754.98245017603, 104725.0, 105588.0, 111877.70320656226, 82553.0, 88507.55746221228, 89647.10352896518, 95842.0, 97549.0, 9984.850227246452, 9997.854109380454, 10095.54570044335, 10170.796584068425, 10177.847332289874, 51246.46260612187, 56708.71645641745, 57924.0, 59578.808423830415, 60643.0, 81691.0, 83563.0, 83806.16193838227, 84557.0, 86841.56579217063, 10329.0, 10995.945020275167, 12079.094067944763, 12653.0, 12673.302968336462, 14219.50231741884, 14673.706525869637, 15000.249987500363, 15071.383987397772, 15155.621109471911, 12605.0, 13582.25297608641, 13858.514951976633, 14057.086289391156, 14316.06945548536, 13837.584872453843, 13958.546379667112, 14251.857481425053, 14252.857471425154, 14712.264386780833, 13621.046526743034, 13649.931750341184, 13836.377363018488, 14304.57086287413, 14325.713485730435, 11335.71660708456, 11380.0, 11529.308241505536, 12024.579139730067, 12138.0, 11162.832557511481, 11467.254628449124, 11664.358460284766, 11749.0, 11768.52925882955], "value": 7577.704136210352, "unit": "score"}], "name": "dromaeo_css", "value": 7341.192585295431, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 117.0, 114.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 110.0, 116.0, 174.0, 112.0, 110.0, 110.0, 109.0, 137.0, 109.0], "value": 122.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 187.0, 183.0, 181.0, 181.0, 183.0, 182.0, 186.0, 182.0], "value": 183.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 59.0, 89.0, 62.0, 59.0, 59.0, 59.0, 83.0, 58.0], "value": 66.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 70.0, 93.0, 71.0, 69.0, 69.0, 89.0, 69.0, 68.0, 93.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 91.0, 89.0, 91.0, 88.0, 92.0, 89.0, 92.0, 129.0], "value": 94.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 97.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 79.0, 80.0, 83.0, 81.0, 86.0, 86.0, 83.0, 82.0], "value": 82.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 55.0, 56.0, 56.0, 57.0, 57.0, 56.0, 56.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 72.0, 67.0, 76.0, 73.0, 67.0, 70.0, 69.0, 69.0, 70.0], "value": 69.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 82.0, 82.0, 83.0, 84.0, 82.0, 85.0, 83.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 126.0, 138.0, 149.0, 146.0, 148.0, 138.0, 142.0, 177.0, 136.0], "value": 146.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 163.0, 164.0, 167.0, 205.0, 158.0, 162.0, 162.0, 161.0], "value": 166.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 67.0, 66.0, 67.0, 66.0, 69.0, 66.0, 66.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1425.7, "alertThreshold": 2.0}]} 18:02:25 INFO - Return code: 0 18:02:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:02:25 INFO - # TBPL SUCCESS # 18:02:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:02:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:02:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:02:25 INFO - 2017-01-31 18:02:25.133 screenresolution[1655:10293] starting screenresolution argv=screenresolution get 18:02:25 INFO - 2017-01-31 18:02:25.137 screenresolution[1655:10293] Display 0: 1600x1200x32@60 18:02:25 INFO - 2017-01-31 18:02:25.143 screenresolution[1656:10297] starting screenresolution argv=screenresolution list 18:02:25 INFO - Available Modes on Display 0 18:02:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:02:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:02:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:02:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:02:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:02:25 INFO - Intel Iris: 18:02:25 INFO - Chipset Model: Intel Iris 18:02:25 INFO - Type: GPU 18:02:25 INFO - Bus: Built-In 18:02:25 INFO - VRAM (Dynamic, Max): 1536 MB 18:02:25 INFO - Vendor: Intel (0x8086) 18:02:25 INFO - Device ID: 0x0a2e 18:02:25 INFO - Revision ID: 0x0009 18:02:25 INFO - Displays: 18:02:25 INFO - Display: 18:02:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:02:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:02:25 INFO - Display Serial Number: 1600x1200 60 18:02:25 INFO - Main Display: Yes 18:02:25 INFO - Mirror: Off 18:02:25 INFO - Online: Yes 18:02:25 INFO - Rotation: Supported 18:02:25 INFO - Return code: 0 18:02:25 INFO - Running post-action listener: _resource_record_post_action 18:02:25 INFO - [mozharness: 2017-02-01 02:02:25.389227Z] Finished run-tests step (success) 18:02:25 INFO - Running post-run listener: _resource_record_post_run 18:02:25 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 37983232; Write bytes: 502496768; Read time: 239; Write time: 1634 18:02:25 INFO - TinderboxPrint: CPU usage
53.6% 18:02:25 INFO - TinderboxPrint: I/O read bytes / time
37,983,232 / 239 18:02:25 INFO - TinderboxPrint: I/O write bytes / time
502,496,768 / 1,634 18:02:25 INFO - TinderboxPrint: CPU idle
2,226.7 (46.4%) 18:02:25 INFO - TinderboxPrint: CPU system
964.4 (20.1%) 18:02:25 INFO - TinderboxPrint: CPU user
1,606.7 (33.5%) 18:02:25 INFO - TinderboxPrint: Swap in / out
229,609,472 / 0 18:02:25 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 176880128; Write bytes: 174505984; Read time: 16443; Write time: 374 18:02:25 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 37061632; Write bytes: 310259200; Read time: 229; Write time: 1204 18:02:25 INFO - Running post-run listener: _upload_blobber_files 18:02:25 INFO - Blob upload gear active. 18:02:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:02:25 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:02:25 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:02:25 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:02:26 INFO - (blobuploader) - INFO - Open directory for files ... 18:02:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:02:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:02:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:02:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:02:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:02:27 INFO - (blobuploader) - INFO - Done attempting. 18:02:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:02:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:02:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:02:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:02:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:02:28 INFO - (blobuploader) - INFO - Done attempting. 18:02:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:02:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:02:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:02:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:02:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:02:30 INFO - (blobuploader) - INFO - Done attempting. 18:02:30 INFO - (blobuploader) - INFO - Iteration through files over. 18:02:30 INFO - Return code: 0 18:02:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:02:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:02:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f901f0c2d233abefba30d817ce07771467c7cf528f8980eab24a7d32f7c89112fc303155416fb5b344c03fd5ab4f5a1da36b0b7f2373d44b3bd8c3cd739f29db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/393edd0f27789e8fcee40e8b13abd92ad16f80c472334411516c09c1bf3b7cd6b9c52870cb76c71c0134fadbf8b99cac3a0c1630c8370cd414ca5125a2f5a806", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/efcc22591cd5cba4aacaab0585d89c5c561b898ed39d983fba69281b4ce22ed4bca1b160792807ac222a5deb3e60a8ba63c105c27cea9198bce218579ffe4440"} 18:02:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:02:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:02:30 INFO - Contents: 18:02:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f901f0c2d233abefba30d817ce07771467c7cf528f8980eab24a7d32f7c89112fc303155416fb5b344c03fd5ab4f5a1da36b0b7f2373d44b3bd8c3cd739f29db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/393edd0f27789e8fcee40e8b13abd92ad16f80c472334411516c09c1bf3b7cd6b9c52870cb76c71c0134fadbf8b99cac3a0c1630c8370cd414ca5125a2f5a806", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/efcc22591cd5cba4aacaab0585d89c5c561b898ed39d983fba69281b4ce22ed4bca1b160792807ac222a5deb3e60a8ba63c105c27cea9198bce218579ffe4440"} 18:02:30 INFO - Running post-run listener: copy_logs_to_upload_dir 18:02:30 INFO - Copying logs to upload dir... 18:02:30 INFO - mkdir: /builds/slave/test/build/upload/logs 18:02:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.440149 ========= master_lag: 3.18 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-01-31 18:02:33.815231) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-31 18:02:33.819598) ========= 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.dWiFKcz6U3/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.DTXwZU4QJw/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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-Beta/sha512/f901f0c2d233abefba30d817ce07771467c7cf528f8980eab24a7d32f7c89112fc303155416fb5b344c03fd5ab4f5a1da36b0b7f2373d44b3bd8c3cd739f29db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/393edd0f27789e8fcee40e8b13abd92ad16f80c472334411516c09c1bf3b7cd6b9c52870cb76c71c0134fadbf8b99cac3a0c1630c8370cd414ca5125a2f5a806", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/efcc22591cd5cba4aacaab0585d89c5c561b898ed39d983fba69281b4ce22ed4bca1b160792807ac222a5deb3e60a8ba63c105c27cea9198bce218579ffe4440"} build_url:https://queue.taskcluster.net/v1/task/JkHUPF80REmRGFiJhpALmQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011221 build_url: 'https://queue.taskcluster.net/v1/task/JkHUPF80REmRGFiJhpALmQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f901f0c2d233abefba30d817ce07771467c7cf528f8980eab24a7d32f7c89112fc303155416fb5b344c03fd5ab4f5a1da36b0b7f2373d44b3bd8c3cd739f29db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/393edd0f27789e8fcee40e8b13abd92ad16f80c472334411516c09c1bf3b7cd6b9c52870cb76c71c0134fadbf8b99cac3a0c1630c8370cd414ca5125a2f5a806", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/efcc22591cd5cba4aacaab0585d89c5c561b898ed39d983fba69281b4ce22ed4bca1b160792807ac222a5deb3e60a8ba63c105c27cea9198bce218579ffe4440"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-31 18:02:33.866735) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 18:02:33.867072) ========= 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.dWiFKcz6U3/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.DTXwZU4QJw/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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.005155 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 18:02:33.915918) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-31 18:02:33.919284) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-31 18:02:33.919616) ========= ========= Total master_lag: 3.48 =========