builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0021 starttime: 1485577217.24 results: success (0) buildid: 20170127181720 builduid: 0f3cf512e7ff4ed7be7c7118bcb7e4e8 revision: eee47824f4687534a901cd9c28126041bd19d261 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-27 20:20:17.235418) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-27 20:20:17.235870) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-27 20:20:17.236142) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-27 20:20:17.261981) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 20:20:17.262350) ========= 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.6M1Ro5Obq6/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.uG0KC3p7su/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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-27 20:20:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 21.5M=0.001s 2017-01-27 20:20:17 (21.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.352656 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 20:20:17.639205) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 20:20:17.639517) ========= 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.6M1Ro5Obq6/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.uG0KC3p7su/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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.026988 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 20:20:17.688069) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-27 20:20:17.688414) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev eee47824f4687534a901cd9c28126041bd19d261 --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 eee47824f4687534a901cd9c28126041bd19d261 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6M1Ro5Obq6/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.uG0KC3p7su/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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-27 20:20:17,797 truncating revision to first 12 chars 2017-01-27 20:20:17,797 Setting DEBUG logging. 2017-01-27 20:20:17,797 attempt 1/10 2017-01-27 20:20:17,797 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/eee47824f468?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-27 20:20:19,485 unpacking tar archive at: mozilla-beta-eee47824f468/testing/mozharness/ program finished with exit code 0 elapsedTime=1.949433 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-27 20:20:19.661918) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-27 20:20:19.662234) ========= script_repo_revision: eee47824f4687534a901cd9c28126041bd19d261 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-27 20:20:19.662652) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-27 20:20:19.662929) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-27 20:20:19.733533) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-01-27 20:20:19.734102) ========= /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.6M1Ro5Obq6/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.uG0KC3p7su/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 20:20:19 INFO - MultiFileLogger online at 20170127 20:20:19 in /builds/slave/test 20:20:19 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 20:20:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:20:19 INFO - {'append_to_log': False, 20:20:19 INFO - 'base_work_dir': '/builds/slave/test', 20:20:19 INFO - 'blob_upload_branch': 'Mozilla-Beta', 20:20:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:20:19 INFO - 'branch': 'Mozilla-Beta', 20:20:19 INFO - 'buildbot_json_path': 'buildprops.json', 20:20:19 INFO - 'config_files': ('talos/mac_config.py',), 20:20:19 INFO - 'default_actions': ('clobber', 20:20:19 INFO - 'read-buildbot-config', 20:20:19 INFO - 'download-and-extract', 20:20:19 INFO - 'populate-webroot', 20:20:19 INFO - 'create-virtualenv', 20:20:19 INFO - 'install', 20:20:19 INFO - 'run-tests'), 20:20:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:20:19 INFO - 'download_minidump_stackwalk': True, 20:20:19 INFO - 'download_symbols': 'ondemand', 20:20:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:20:19 INFO - 'tooltool.py': '/tools/tooltool.py', 20:20:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:20:19 INFO - '/tools/misc-python/virtualenv.py')}, 20:20:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:20:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:20:19 INFO - 'installer_path': 'installer.exe', 20:20:19 INFO - 'log_level': 'info', 20:20:19 INFO - 'log_name': 'talos', 20:20:19 INFO - 'log_to_console': True, 20:20:19 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:20:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:20:19 INFO - 'opt_config_files': (), 20:20:19 INFO - 'pip_index': False, 20:20:19 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:20:19 INFO - 'cmd': ('bash', 20:20:19 INFO - '-c', 20:20:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:20:19 INFO - 'enabled': True, 20:20:19 INFO - 'halt_on_failure': False, 20:20:19 INFO - 'name': 'check_screen_resolution'},), 20:20:19 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:20:19 INFO - 'cmd': ('bash', 20:20:19 INFO - '-c', 20:20:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:20:19 INFO - 'enabled': True, 20:20:19 INFO - 'halt_on_failure': False, 20:20:19 INFO - 'name': 'check_screen_resolution'},), 20:20:19 INFO - 'run_cmd_checks_enabled': True, 20:20:19 INFO - 'sps_profile': False, 20:20:19 INFO - 'sps_profile_interval': 0, 20:20:19 INFO - 'suite': 'dromaeojs', 20:20:19 INFO - 'system_bits': '32', 20:20:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:20:19 INFO - 'title': 't-yosemite-r7-0021', 20:20:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:20:19 INFO - 'use_talos_json': True, 20:20:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:20:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:20:19 INFO - 'work_dir': 'build'} 20:20:19 INFO - [mozharness: 2017-01-28 04:20:19.946199Z] Running clobber step. 20:20:19 INFO - Running pre-action listener: _resource_record_pre_action 20:20:19 INFO - Running main action method: clobber 20:20:19 INFO - rmtree: /builds/slave/test/build 20:20:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:20:22 INFO - Running post-action listener: _resource_record_post_action 20:20:22 INFO - [mozharness: 2017-01-28 04:20:22.531423Z] Finished clobber step (success) 20:20:22 INFO - [mozharness: 2017-01-28 04:20:22.531550Z] Running read-buildbot-config step. 20:20:22 INFO - Running pre-action listener: _resource_record_pre_action 20:20:22 INFO - Running main action method: read_buildbot_config 20:20:22 INFO - Using buildbot properties: 20:20:22 INFO - { 20:20:22 INFO - "project": "", 20:20:22 INFO - "product": "firefox", 20:20:22 INFO - "script_repo_revision": "production", 20:20:22 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 20:20:22 INFO - "repository": "", 20:20:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 20:20:22 INFO - "buildid": "20170127181720", 20:20:22 INFO - "pgo_build": "False", 20:20:22 INFO - "basedir": "/builds/slave/test", 20:20:22 INFO - "buildnumber": 12, 20:20:22 INFO - "slavename": "t-yosemite-r7-0021", 20:20:22 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 20:20:22 INFO - "platform": "yosemite_r7", 20:20:22 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 20:20:22 INFO - "branch": "mozilla-beta", 20:20:22 INFO - "repo_path": "releases/mozilla-beta", 20:20:22 INFO - "revision": "eee47824f4687534a901cd9c28126041bd19d261", 20:20:22 INFO - "stage_platform": "macosx64", 20:20:22 INFO - "builduid": "0f3cf512e7ff4ed7be7c7118bcb7e4e8", 20:20:22 INFO - "slavebuilddir": "test" 20:20:22 INFO - } 20:20:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/Uryn4NE9RU6EPApn98bvSA/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 20:20:22 INFO - Running post-action listener: _resource_record_post_action 20:20:22 INFO - [mozharness: 2017-01-28 04:20:22.534908Z] Finished read-buildbot-config step (success) 20:20:22 INFO - [mozharness: 2017-01-28 04:20:22.535015Z] Running download-and-extract step. 20:20:22 INFO - Running pre-action listener: _resource_record_pre_action 20:20:22 INFO - Running main action method: download_and_extract 20:20:22 INFO - mkdir: /builds/slave/test/build/tests 20:20:22 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')]} 20:20:22 INFO - trying https://queue.taskcluster.net/v1/task/Uryn4NE9RU6EPApn98bvSA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 20:20:22 INFO - Downloading https://queue.taskcluster.net/v1/task/Uryn4NE9RU6EPApn98bvSA/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 20:20:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Uryn4NE9RU6EPApn98bvSA/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 20:20:23 INFO - Downloaded 1165 bytes. 20:20:23 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 20:20:23 INFO - Using the following test package requirements: 20:20:23 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 20:20:23 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 20:20:23 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 20:20:23 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 20:20:23 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 20:20:23 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 20:20:23 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 20:20:23 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 20:20:23 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 20:20:23 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 20:20:23 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 20:20:23 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 20:20:23 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 20:20:23 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 20:20:23 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 20:20:23 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 20:20:23 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 20:20:23 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 20:20:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Uryn4NE9RU6EPApn98bvSA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 20:20:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Uryn4NE9RU6EPApn98bvSA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 20:20:23 INFO - Fetch https://queue.taskcluster.net/v1/task/Uryn4NE9RU6EPApn98bvSA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 20:20:24 INFO - Http code: 200 20:20:24 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 20:20:24 INFO - x-amz-cf-id: vUphLKiW_uRSTsMphbGujOsWdOQ0JFXmfYkmrdjC9Ut2y5enPM3opQ== 20:20:24 INFO - x-amz-version-id: NFBnRuxCi9w3n9CJEjELLmKGVhyO2SW6 20:20:24 INFO - Expected file size: 16087557 20:20:24 INFO - Obtained file size: 16087557 20:20:31 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 20:20:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Uryn4NE9RU6EPApn98bvSA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 20:20:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Uryn4NE9RU6EPApn98bvSA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 20:20:31 INFO - Fetch https://queue.taskcluster.net/v1/task/Uryn4NE9RU6EPApn98bvSA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 20:20:31 INFO - Http code: 200 20:20:31 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 20:20:31 INFO - x-amz-cf-id: 5UtkLy2KOjMawPqHFJwO8Wm9iIhE06YivSB0kZiTm0YTIKhIS5G6OA== 20:20:31 INFO - x-amz-version-id: NFBnRuxCi9w3n9CJEjELLmKGVhyO2SW6 20:20:31 INFO - Expected file size: 16087557 20:20:31 INFO - Obtained file size: 16087557 20:20:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Uryn4NE9RU6EPApn98bvSA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 20:20:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Uryn4NE9RU6EPApn98bvSA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 20:20:38 INFO - Fetch https://queue.taskcluster.net/v1/task/Uryn4NE9RU6EPApn98bvSA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 20:20:38 INFO - Http code: 200 20:20:38 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 20:20:38 INFO - x-amz-cf-id: 0kT7SL9MlEpgGXgtc73DojZILoY2agWQeW8w4rHJb9FynbKUwDXixA== 20:20:38 INFO - x-amz-version-id: l7v8YPe_sd5IgKuRKwzN8jyD1TiinCkl 20:20:39 INFO - Expected file size: 14402992 20:20:39 INFO - Obtained file size: 14402992 20:20:39 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')]} 20:20:39 INFO - trying https://queue.taskcluster.net/v1/task/Uryn4NE9RU6EPApn98bvSA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 20:20:39 INFO - Downloading https://queue.taskcluster.net/v1/task/Uryn4NE9RU6EPApn98bvSA/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 20:20:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Uryn4NE9RU6EPApn98bvSA/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 20:20:41 INFO - Downloaded 82136699 bytes. 20:20:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Uryn4NE9RU6EPApn98bvSA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 20:20:41 INFO - mkdir: /builds/slave/test/properties 20:20:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:20:41 INFO - Writing to file /builds/slave/test/properties/build_url 20:20:41 INFO - Contents: 20:20:41 INFO - build_url:https://queue.taskcluster.net/v1/task/Uryn4NE9RU6EPApn98bvSA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 20:20:42 INFO - Running post-action listener: _resource_record_post_action 20:20:42 INFO - Running post-action listener: set_extra_try_arguments 20:20:42 INFO - [mozharness: 2017-01-28 04:20:42.325282Z] Finished download-and-extract step (success) 20:20:42 INFO - [mozharness: 2017-01-28 04:20:42.325399Z] Running populate-webroot step. 20:20:42 INFO - Running pre-action listener: _resource_record_pre_action 20:20:42 INFO - Running main action method: populate_webroot 20:20:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:20:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:20:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:20:42 INFO - '--tppagecycles', 20:20:42 INFO - '7'], 20:20:42 INFO - 'tests': ['tsvgm']}}, 20:20:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:20:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:20:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:20:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:20:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:20:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:20:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:42 INFO - 'talos_options': ['--disable-e10s'], 20:20:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:20:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:20:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:42 INFO - 'talos_options': ['--disable-e10s'], 20:20:42 INFO - 'tests': ['damp', 'tps']}, 20:20:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:42 INFO - 'tests': ['damp', 'tps']}, 20:20:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:20:42 INFO - 'tests': ['dromaeo_dom']}, 20:20:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:20:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:20:42 INFO - 'tests': ['basic_compositor_video']}, 20:20:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:20:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:20:42 INFO - 'tests': ['a11yr', 20:20:42 INFO - 'ts_paint', 20:20:42 INFO - 'tpaint', 20:20:42 INFO - 'sessionrestore', 20:20:42 INFO - 'sessionrestore_no_auto_restore', 20:20:42 INFO - 'tabpaint']}, 20:20:42 INFO - 'other-e10s': {'tests': ['a11yr', 20:20:42 INFO - 'ts_paint', 20:20:42 INFO - 'tpaint', 20:20:42 INFO - 'sessionrestore', 20:20:42 INFO - 'sessionrestore_no_auto_restore', 20:20:42 INFO - 'tabpaint']}, 20:20:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:20:42 INFO - 'ts_paint', 20:20:42 INFO - 'tpaint', 20:20:42 INFO - 'sessionrestore', 20:20:42 INFO - 'sessionrestore_no_auto_restore', 20:20:42 INFO - 'tabpaint']}, 20:20:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:20:42 INFO - 'ts_paint', 20:20:42 INFO - 'tpaint', 20:20:42 INFO - 'sessionrestore', 20:20:42 INFO - 'sessionrestore_no_auto_restore', 20:20:42 INFO - 'tabpaint']}, 20:20:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:20:42 INFO - 'tests': ['a11yr', 20:20:42 INFO - 'ts_paint', 20:20:42 INFO - 'tpaint', 20:20:42 INFO - 'sessionrestore', 20:20:42 INFO - 'sessionrestore_no_auto_restore', 20:20:42 INFO - 'tabpaint']}, 20:20:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:20:42 INFO - 'tests': ['a11yr', 20:20:42 INFO - 'ts_paint', 20:20:42 INFO - 'tpaint', 20:20:42 INFO - 'sessionrestore', 20:20:42 INFO - 'sessionrestore_no_auto_restore', 20:20:42 INFO - 'tabpaint']}, 20:20:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:20:42 INFO - 'tests': ['tsvgx', 20:20:42 INFO - 'tsvgr_opacity', 20:20:42 INFO - 'tart', 20:20:42 INFO - 'tscrollx', 20:20:42 INFO - 'cart']}, 20:20:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:20:42 INFO - 'tsvgr_opacity', 20:20:42 INFO - 'tart', 20:20:42 INFO - 'tscrollx', 20:20:42 INFO - 'cart']}, 20:20:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:42 INFO - 'talos_options': ['--disable-e10s'], 20:20:42 INFO - 'tests': ['tp5o']}, 20:20:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:42 INFO - 'tests': ['tp5o']}, 20:20:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:42 INFO - 'talos_options': ['--disable-e10s', 20:20:42 INFO - '--xperf_path', 20:20:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:20:42 INFO - 'tests': ['tp5n']}, 20:20:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:42 INFO - 'talos_options': ['--xperf_path', 20:20:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:20:42 INFO - 'tests': ['tp5n']}}, 20:20:42 INFO - 'talos.zip': {'path': '', 20:20:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:20:42 INFO - Running post-action listener: _resource_record_post_action 20:20:42 INFO - [mozharness: 2017-01-28 04:20:42.344199Z] Finished populate-webroot step (success) 20:20:42 INFO - [mozharness: 2017-01-28 04:20:42.344331Z] Running create-virtualenv step. 20:20:42 INFO - Running pre-action listener: _resource_record_pre_action 20:20:42 INFO - Running main action method: create_virtualenv 20:20:42 INFO - Creating virtualenv /builds/slave/test/build/venv 20:20:42 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 20:20:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:20:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:20:42 INFO - Using real prefix '/tools/python27' 20:20:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:20:43 INFO - Installing distribute.............................................................................................................................................................................................done. 20:20:46 INFO - Installing pip.................done. 20:20:46 INFO - Return code: 0 20:20:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:20:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:20:46 INFO - Reading from file tmpfile_stdout 20:20:46 INFO - Output received: 20:20:46 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) 20:20:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:20:46 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')]} 20:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:46 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')]} 20:20:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:46 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 0x10ca3c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9b2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0b959f380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c850d30>, '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 0x10c6b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c848b20>, '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.6M1Ro5Obq6/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.uG0KC3p7su/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 20:20:46 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 20:20:46 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 20:20:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6M1Ro5Obq6/Render', 20:20:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:20:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:20:46 INFO - 'HOME': '/Users/cltbld', 20:20:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:20:46 INFO - 'LOGNAME': 'cltbld', 20:20:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:46 INFO - 'MOZ_NO_REMOTE': '1', 20:20:46 INFO - 'NO_EM_RESTART': '1', 20:20:46 INFO - 'PAGER': '/bin/cat', 20:20:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:20:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:46 INFO - 'PWD': '/builds/slave/test', 20:20:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:20:46 INFO - 'SHELL': '/bin/bash', 20:20:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uG0KC3p7su/Listeners', 20:20:46 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 20:20:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:20:46 INFO - 'USER': 'cltbld', 20:20:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:20:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:20:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:46 INFO - 'XPC_FLAGS': '0x0', 20:20:46 INFO - 'XPC_SERVICE_NAME': '0', 20:20:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:20:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:46 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 20:20:46 INFO - Cleaning up... 20:20:46 INFO - Return code: 0 20:20:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:20:46 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')]} 20:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:46 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')]} 20:20:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:46 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 0x10ca3c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9b2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0b959f380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c850d30>, '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 0x10c6b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c848b20>, '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.6M1Ro5Obq6/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.uG0KC3p7su/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 20:20:46 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 20:20:46 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 20:20:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6M1Ro5Obq6/Render', 20:20:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:20:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:20:46 INFO - 'HOME': '/Users/cltbld', 20:20:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:20:46 INFO - 'LOGNAME': 'cltbld', 20:20:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:46 INFO - 'MOZ_NO_REMOTE': '1', 20:20:46 INFO - 'NO_EM_RESTART': '1', 20:20:46 INFO - 'PAGER': '/bin/cat', 20:20:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:20:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:46 INFO - 'PWD': '/builds/slave/test', 20:20:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:20:46 INFO - 'SHELL': '/bin/bash', 20:20:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uG0KC3p7su/Listeners', 20:20:46 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 20:20:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:20:46 INFO - 'USER': 'cltbld', 20:20:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:20:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:20:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:46 INFO - 'XPC_FLAGS': '0x0', 20:20:46 INFO - 'XPC_SERVICE_NAME': '0', 20:20:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:20:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:47 INFO - Downloading/unpacking psutil>=3.1.1 20:20:47 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 20:20:47 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 20:20:47 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 20:20:47 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 20:20:47 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 20:20:47 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 20:20:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:20:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:20:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:20:50 INFO - Installing collected packages: psutil 20:20:50 INFO - Running setup.py install for psutil 20:20:50 INFO - building 'psutil._psutil_osx' extension 20:20:50 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 20:20:51 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 20:20:51 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 20:20:51 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 20:20:51 INFO - building 'psutil._psutil_posix' extension 20:20:51 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 20:20:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:20:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:20:51 INFO - ^ 20:20:51 INFO - 1 warning generated. 20:20:51 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 20:20:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:20:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:20:51 INFO - Successfully installed psutil 20:20:51 INFO - Cleaning up... 20:20:51 INFO - Return code: 0 20:20:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:20:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:51 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 0x10ca3c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9b2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0b959f380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c850d30>, '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 0x10c6b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c848b20>, '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.6M1Ro5Obq6/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.uG0KC3p7su/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 20:20:51 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 20:20:51 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 20:20:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6M1Ro5Obq6/Render', 20:20:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:20:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:20:51 INFO - 'HOME': '/Users/cltbld', 20:20:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:20:51 INFO - 'LOGNAME': 'cltbld', 20:20:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:51 INFO - 'MOZ_NO_REMOTE': '1', 20:20:51 INFO - 'NO_EM_RESTART': '1', 20:20:51 INFO - 'PAGER': '/bin/cat', 20:20:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:20:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:51 INFO - 'PWD': '/builds/slave/test', 20:20:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:20:51 INFO - 'SHELL': '/bin/bash', 20:20:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uG0KC3p7su/Listeners', 20:20:51 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 20:20:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:20:51 INFO - 'USER': 'cltbld', 20:20:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:20:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:20:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:51 INFO - 'XPC_FLAGS': '0x0', 20:20:51 INFO - 'XPC_SERVICE_NAME': '0', 20:20:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:20:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:20:51 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 20:20:51 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 20:20:51 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 20:20:51 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 20:20:51 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 20:20:51 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 20:20:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:20:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:20:54 INFO - Installing collected packages: mozsystemmonitor 20:20:54 INFO - Running setup.py install for mozsystemmonitor 20:20:54 INFO - Successfully installed mozsystemmonitor 20:20:54 INFO - Cleaning up... 20:20:54 INFO - Return code: 0 20:20:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:20:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:54 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 0x10ca3c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9b2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0b959f380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c850d30>, '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 0x10c6b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c848b20>, '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.6M1Ro5Obq6/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.uG0KC3p7su/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 20:20:54 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 20:20:54 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 20:20:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6M1Ro5Obq6/Render', 20:20:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:20:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:20:54 INFO - 'HOME': '/Users/cltbld', 20:20:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:20:54 INFO - 'LOGNAME': 'cltbld', 20:20:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:54 INFO - 'MOZ_NO_REMOTE': '1', 20:20:54 INFO - 'NO_EM_RESTART': '1', 20:20:54 INFO - 'PAGER': '/bin/cat', 20:20:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:20:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:54 INFO - 'PWD': '/builds/slave/test', 20:20:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:20:54 INFO - 'SHELL': '/bin/bash', 20:20:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uG0KC3p7su/Listeners', 20:20:54 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 20:20:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:20:54 INFO - 'USER': 'cltbld', 20:20:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:20:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:20:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:54 INFO - 'XPC_FLAGS': '0x0', 20:20:54 INFO - 'XPC_SERVICE_NAME': '0', 20:20:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:20:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:55 INFO - Downloading/unpacking jsonschema==2.5.1 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:20:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:20:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:58 INFO - Downloading functools32-3.2.3-2.tar.gz 20:20:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:20:58 INFO - warning: no files found matching '*.txt' 20:20:58 INFO - no previously-included directories found matching 'build' 20:20:58 INFO - no previously-included directories found matching 'dist' 20:20:58 INFO - no previously-included directories found matching '.git*' 20:20:58 INFO - Installing collected packages: jsonschema, functools32 20:20:58 INFO - Running setup.py install for functools32 20:20:58 INFO - warning: no files found matching '*.txt' 20:20:58 INFO - no previously-included directories found matching 'build' 20:20:58 INFO - no previously-included directories found matching 'dist' 20:20:58 INFO - no previously-included directories found matching '.git*' 20:20:58 INFO - Successfully installed jsonschema functools32 20:20:58 INFO - Cleaning up... 20:20:58 INFO - Return code: 0 20:20:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:20:58 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')]} 20:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:58 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')]} 20:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:58 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 0x10ca3c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9b2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0b959f380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c850d30>, '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 0x10c6b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c848b20>, '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.6M1Ro5Obq6/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.uG0KC3p7su/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 20:20:58 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 20:20:58 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 20:20:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6M1Ro5Obq6/Render', 20:20:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:20:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:20:58 INFO - 'HOME': '/Users/cltbld', 20:20:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:20:58 INFO - 'LOGNAME': 'cltbld', 20:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:58 INFO - 'MOZ_NO_REMOTE': '1', 20:20:58 INFO - 'NO_EM_RESTART': '1', 20:20:58 INFO - 'PAGER': '/bin/cat', 20:20:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:58 INFO - 'PWD': '/builds/slave/test', 20:20:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:20:58 INFO - 'SHELL': '/bin/bash', 20:20:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uG0KC3p7su/Listeners', 20:20:58 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 20:20:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:20:58 INFO - 'USER': 'cltbld', 20:20:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:20:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:58 INFO - 'XPC_FLAGS': '0x0', 20:20:58 INFO - 'XPC_SERVICE_NAME': '0', 20:20:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:20:58 INFO - Cleaning up... 20:20:58 INFO - Return code: 0 20:20:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:20:58 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')]} 20:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:58 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')]} 20:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:58 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 0x10ca3c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9b2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0b959f380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c850d30>, '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 0x10c6b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c848b20>, '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.6M1Ro5Obq6/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.uG0KC3p7su/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 20:20:58 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 20:20:58 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 20:20:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6M1Ro5Obq6/Render', 20:20:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:20:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:20:58 INFO - 'HOME': '/Users/cltbld', 20:20:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:20:58 INFO - 'LOGNAME': 'cltbld', 20:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:58 INFO - 'MOZ_NO_REMOTE': '1', 20:20:58 INFO - 'NO_EM_RESTART': '1', 20:20:58 INFO - 'PAGER': '/bin/cat', 20:20:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:58 INFO - 'PWD': '/builds/slave/test', 20:20:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:20:58 INFO - 'SHELL': '/bin/bash', 20:20:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uG0KC3p7su/Listeners', 20:20:58 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 20:20:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:20:58 INFO - 'USER': 'cltbld', 20:20:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:20:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:58 INFO - 'XPC_FLAGS': '0x0', 20:20:58 INFO - 'XPC_SERVICE_NAME': '0', 20:20:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:20:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:59 INFO - Downloading/unpacking blobuploader==1.2.4 20:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:21:01 INFO - Downloading blobuploader-1.2.4.tar.gz 20:21:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:21:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:21: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 20:21: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 20:21: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 20:21: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 20:21: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 20:21: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 20:21:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:21:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:21:02 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 20:21:02 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 20:21:02 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 20:21:02 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 20:21:02 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 20:21:02 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 20:21:02 INFO - Downloading docopt-0.6.1.tar.gz 20:21:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:21:03 INFO - Installing collected packages: blobuploader, requests, docopt 20:21:03 INFO - Running setup.py install for blobuploader 20:21:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:21:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:21:03 INFO - Running setup.py install for requests 20:21:03 INFO - Running setup.py install for docopt 20:21:03 INFO - Successfully installed blobuploader requests docopt 20:21:03 INFO - Cleaning up... 20:21:03 INFO - Return code: 0 20:21:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:21: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')]} 20:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:21:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21: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')]} 20:21:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:21:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:03 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 0x10ca3c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9b2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0b959f380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c850d30>, '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 0x10c6b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c848b20>, '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.6M1Ro5Obq6/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.uG0KC3p7su/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 20:21:03 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 20:21:03 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 20:21:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6M1Ro5Obq6/Render', 20:21:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:21:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:21:03 INFO - 'HOME': '/Users/cltbld', 20:21:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:21:03 INFO - 'LOGNAME': 'cltbld', 20:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:21:03 INFO - 'MOZ_NO_REMOTE': '1', 20:21:03 INFO - 'NO_EM_RESTART': '1', 20:21:03 INFO - 'PAGER': '/bin/cat', 20:21:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:21:03 INFO - 'PWD': '/builds/slave/test', 20:21:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:21:03 INFO - 'SHELL': '/bin/bash', 20:21:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uG0KC3p7su/Listeners', 20:21:03 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 20:21:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:21:03 INFO - 'USER': 'cltbld', 20:21:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:21:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:21:03 INFO - 'XPC_FLAGS': '0x0', 20:21:03 INFO - 'XPC_SERVICE_NAME': '0', 20:21:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:21:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:21:04 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-B9P_6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:21:04 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-JCsCJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:21:04 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-cYgqbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:21:04 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-PMdAFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:21:04 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-dN7RBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:21:04 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-Mus0X1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:21:04 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-DzaQf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:21:04 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-BShvDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:21:04 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-8lsN34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:21:05 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-JbntBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:21:05 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-BZamTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:21:05 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-ZtduES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:21:05 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-7G6Pjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:21:05 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-NL3krv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:21:05 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-KXcCSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:21:05 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-RQ2ucg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:21:05 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-QfXo2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:21:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:21:05 INFO - Running setup.py install for manifestparser 20:21:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:21:06 INFO - Running setup.py install for mozcrash 20:21:06 INFO - Running setup.py install for mozdebug 20:21:06 INFO - Running setup.py install for mozdevice 20:21:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:21:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:21:06 INFO - Running setup.py install for mozfile 20:21:06 INFO - Running setup.py install for mozhttpd 20:21:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:21:06 INFO - Running setup.py install for mozinfo 20:21:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:21:06 INFO - Running setup.py install for mozInstall 20:21:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:21:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:21:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:21:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:21:07 INFO - Running setup.py install for mozleak 20:21:07 INFO - Running setup.py install for mozlog 20:21:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:21:07 INFO - Running setup.py install for moznetwork 20:21:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:21:07 INFO - Running setup.py install for mozprocess 20:21:07 INFO - Running setup.py install for mozprofile 20:21:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:21:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:21:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:21:07 INFO - Running setup.py install for mozrunner 20:21:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:21:08 INFO - Running setup.py install for mozscreenshot 20:21:08 INFO - Running setup.py install for moztest 20:21:08 INFO - Running setup.py install for mozversion 20:21:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:21:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:21:08 INFO - Cleaning up... 20:21:08 INFO - Return code: 0 20:21:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:21:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:21:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:21:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:21:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:08 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 0x10ca3c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9b2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0b959f380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c850d30>, '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 0x10c6b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c848b20>, '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.6M1Ro5Obq6/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.uG0KC3p7su/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 20:21:08 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 20:21:08 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 20:21:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6M1Ro5Obq6/Render', 20:21:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:21:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:21:08 INFO - 'HOME': '/Users/cltbld', 20:21:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:21:08 INFO - 'LOGNAME': 'cltbld', 20:21:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:21:08 INFO - 'MOZ_NO_REMOTE': '1', 20:21:08 INFO - 'NO_EM_RESTART': '1', 20:21:08 INFO - 'PAGER': '/bin/cat', 20:21:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:21:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:21:08 INFO - 'PWD': '/builds/slave/test', 20:21:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:21:08 INFO - 'SHELL': '/bin/bash', 20:21:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uG0KC3p7su/Listeners', 20:21:08 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 20:21:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:21:08 INFO - 'USER': 'cltbld', 20:21:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:21:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:21:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:21:08 INFO - 'XPC_FLAGS': '0x0', 20:21:08 INFO - 'XPC_SERVICE_NAME': '0', 20:21:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:21:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:21:08 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-lhhkw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:21:08 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)) 20:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:21:08 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-AFwzPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:21:08 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)) 20:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:21:08 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-AnnQP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:21:09 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)) 20:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:21:09 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-Ol4bHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:21:09 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)) 20:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:21:09 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-l13Hwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:21:09 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)) 20:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:21:09 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-jD6X5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:21:09 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)) 20:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:21:09 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-DzzbEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:21:09 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)) 20:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:21:09 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-zJsq41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:21:09 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)) 20:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:21:09 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-TjEq0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:21:09 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)) 20:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:21:09 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-qpTbsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:21:09 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)) 20:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:21:09 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-snRoDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:21:09 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)) 20:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:21:09 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-JxEzzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:21:10 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)) 20:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:21:10 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-WbAxZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:21:10 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)) 20:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:21:10 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-zfrfiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:21:10 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)) 20:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:21:10 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-f7eMYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:21:10 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)) 20:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:21:10 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-ygHLdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:21:10 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)) 20:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:21:10 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-oE7Ic0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:21:10 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)) 20:21:10 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)) 20:21:10 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)) 20:21:10 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)) 20:21:10 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)) 20:21:10 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)) 20:21:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:21:10 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 20:21:10 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 20:21:10 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 20:21:10 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 20:21:10 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 20:21:10 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 20:21:13 INFO - Downloading blessings-1.6.tar.gz 20:21:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:21:13 INFO - Installing collected packages: blessings 20:21:13 INFO - Running setup.py install for blessings 20:21:13 INFO - Successfully installed blessings 20:21:13 INFO - Cleaning up... 20:21:13 INFO - Return code: 0 20:21:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:21:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:21:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:21:13 INFO - Reading from file tmpfile_stdout 20:21:13 INFO - Current package versions: 20:21:13 INFO - blessings == 1.6 20:21:13 INFO - blobuploader == 1.2.4 20:21:13 INFO - docopt == 0.6.1 20:21:13 INFO - functools32 == 3.2.3-2 20:21:13 INFO - jsonschema == 2.5.1 20:21:13 INFO - manifestparser == 1.1 20:21:13 INFO - mozInstall == 1.12 20:21:13 INFO - mozcrash == 1.0 20:21:13 INFO - mozdebug == 0.1 20:21:13 INFO - mozdevice == 0.48 20:21:13 INFO - mozfile == 1.2 20:21:13 INFO - mozhttpd == 0.7 20:21:13 INFO - mozinfo == 0.9 20:21:13 INFO - mozleak == 0.1 20:21:13 INFO - mozlog == 3.4 20:21:13 INFO - moznetwork == 0.27 20:21:13 INFO - mozprocess == 0.23 20:21:13 INFO - mozprofile == 0.28 20:21:13 INFO - mozrunner == 6.13 20:21:13 INFO - mozscreenshot == 0.1 20:21:13 INFO - mozsystemmonitor == 0.3 20:21:13 INFO - moztest == 0.8 20:21:13 INFO - mozversion == 1.4 20:21:13 INFO - psutil == 3.1.1 20:21:13 INFO - requests == 1.2.3 20:21:13 INFO - wsgiref == 0.1.2 20:21:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:21:13 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')]} 20:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:21:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21: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')]} 20:21:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:21:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:14 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 0x10ca3c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9b2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0b959f380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c850d30>, '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 0x10c6b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c848b20>, '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.6M1Ro5Obq6/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.uG0KC3p7su/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 20:21:14 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 20:21:14 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 20:21:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6M1Ro5Obq6/Render', 20:21:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:21:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:21:14 INFO - 'HOME': '/Users/cltbld', 20:21:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:21:14 INFO - 'LOGNAME': 'cltbld', 20:21:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:21:14 INFO - 'MOZ_NO_REMOTE': '1', 20:21:14 INFO - 'NO_EM_RESTART': '1', 20:21:14 INFO - 'PAGER': '/bin/cat', 20:21:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:21:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:21:14 INFO - 'PWD': '/builds/slave/test', 20:21:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:21:14 INFO - 'SHELL': '/bin/bash', 20:21:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uG0KC3p7su/Listeners', 20:21:14 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 20:21:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:21:14 INFO - 'USER': 'cltbld', 20:21:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:21:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:21:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:21:14 INFO - 'XPC_FLAGS': '0x0', 20:21:14 INFO - 'XPC_SERVICE_NAME': '0', 20:21:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:21:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:21:14 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)) 20:21:14 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)) 20:21:14 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)) 20:21:14 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)) 20:21:14 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)) 20:21:14 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)) 20:21:14 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)) 20:21:14 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)) 20:21:14 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)) 20:21:14 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)) 20:21:14 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)) 20:21:14 INFO - Cleaning up... 20:21:14 INFO - Return code: 0 20:21:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:21: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')]} 20:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:21:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21: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')]} 20:21:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:21:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ca3c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9b2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0b959f380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c850d30>, '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 0x10c6b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c848b20>, '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.6M1Ro5Obq6/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.uG0KC3p7su/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 20:21:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:21:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:21:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6M1Ro5Obq6/Render', 20:21:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:21:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:21:15 INFO - 'HOME': '/Users/cltbld', 20:21:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:21:15 INFO - 'LOGNAME': 'cltbld', 20:21:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:21:15 INFO - 'MOZ_NO_REMOTE': '1', 20:21:15 INFO - 'NO_EM_RESTART': '1', 20:21:15 INFO - 'PAGER': '/bin/cat', 20:21:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:21:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:21:15 INFO - 'PWD': '/builds/slave/test', 20:21:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:21:15 INFO - 'SHELL': '/bin/bash', 20:21:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uG0KC3p7su/Listeners', 20:21:15 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 20:21:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:21:15 INFO - 'USER': 'cltbld', 20:21:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:21:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:21:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:21:15 INFO - 'XPC_FLAGS': '0x0', 20:21:15 INFO - 'XPC_SERVICE_NAME': '0', 20:21:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:21:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:21:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:21:15 INFO - Cleaning up... 20:21:15 INFO - Return code: 0 20:21:15 INFO - Running post-action listener: _resource_record_post_action 20:21:15 INFO - Running post-action listener: _start_resource_monitoring 20:21:15 INFO - Starting resource monitoring. 20:21:15 INFO - [mozharness: 2017-01-28 04:21:15.547505Z] Finished create-virtualenv step (success) 20:21:15 INFO - [mozharness: 2017-01-28 04:21:15.548482Z] Running install step. 20:21:15 INFO - Running pre-action listener: _resource_record_pre_action 20:21:15 INFO - Running main action method: install 20:21:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:21:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:21:15 INFO - Reading from file tmpfile_stdout 20:21:15 INFO - Detecting whether we're running mozinstall >=1.0... 20:21:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:21:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:21:15 INFO - Reading from file tmpfile_stdout 20:21:15 INFO - Output received: 20:21:15 INFO - Usage: mozinstall [options] installer 20:21:15 INFO - Options: 20:21:15 INFO - -h, --help show this help message and exit 20:21:15 INFO - -d DEST, --destination=DEST 20:21:15 INFO - Directory to install application into. [default: 20:21:15 INFO - "/builds/slave/test"] 20:21:15 INFO - --app=APP Application being installed. [default: firefox] 20:21:15 INFO - mkdir: /builds/slave/test/build/application 20:21:15 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'] 20:21:15 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 20:21:37 INFO - Reading from file tmpfile_stdout 20:21:37 INFO - Output received: 20:21:37 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 20:21:37 INFO - Running post-action listener: _resource_record_post_action 20:21:37 INFO - [mozharness: 2017-01-28 04:21:37.030354Z] Finished install step (success) 20:21:37 INFO - [mozharness: 2017-01-28 04:21:37.030483Z] Running run-tests step. 20:21:37 INFO - Running pre-action listener: _resource_record_pre_action 20:21:37 INFO - Running main action method: run_tests 20:21:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:21:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:21:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:21:37 INFO - 2017-01-27 20:21:37.044 screenresolution[1639:7485] starting screenresolution argv=screenresolution get 20:21:37 INFO - 2017-01-27 20:21:37.047 screenresolution[1639:7485] Display 0: 1600x1200x32@60 20:21:37 INFO - 2017-01-27 20:21:37.053 screenresolution[1640:7487] starting screenresolution argv=screenresolution list 20:21:37 INFO - Available Modes on Display 0 20:21:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:21:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:21:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:21:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:21:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:21:37 INFO - Intel Iris: 20:21:37 INFO - Chipset Model: Intel Iris 20:21:37 INFO - Type: GPU 20:21:37 INFO - Bus: Built-In 20:21:37 INFO - VRAM (Dynamic, Max): 1536 MB 20:21:37 INFO - Vendor: Intel (0x8086) 20:21:37 INFO - Device ID: 0x0a2e 20:21:37 INFO - Revision ID: 0x0009 20:21:37 INFO - Displays: 20:21:37 INFO - Display: 20:21:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:21:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:21:37 INFO - Display Serial Number: 1600x1200 60 20:21:37 INFO - Main Display: Yes 20:21:37 INFO - Mirror: Off 20:21:37 INFO - Online: Yes 20:21:37 INFO - Rotation: Supported 20:21:37 INFO - Return code: 0 20:21:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:21:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:21:37 INFO - Python 2.7.3 20:21:37 INFO - Return code: 0 20:21:37 INFO - grabbing minidump binary from tooltool 20:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:21:37 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 0x10c850d30>, '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 0x10c6b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c848b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:21:37 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 20:21:37 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 20:21:37 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 20:21:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:21:37 INFO - Return code: 0 20:21:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:21:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:21:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:21:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:21:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:21:37 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/Uryn4NE9RU6EPApn98bvSA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0021', '--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 20:21:37 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/Uryn4NE9RU6EPApn98bvSA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0021 --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 20:21:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6M1Ro5Obq6/Render', 20:21:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:21:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:21:37 INFO - 'HOME': '/Users/cltbld', 20:21:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:21:37 INFO - 'LOGNAME': 'cltbld', 20:21:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:21:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:21:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:21:37 INFO - 'MOZ_NO_REMOTE': '1', 20:21:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:21:37 INFO - 'NO_EM_RESTART': '1', 20:21:37 INFO - 'PAGER': '/bin/cat', 20:21:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:21:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:21:37 INFO - 'PWD': '/builds/slave/test', 20:21:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:21:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:21:37 INFO - 'SHELL': '/bin/bash', 20:21:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uG0KC3p7su/Listeners', 20:21:37 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 20:21:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:21:37 INFO - 'USER': 'cltbld', 20:21:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:21:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:21:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:21:37 INFO - 'XPC_FLAGS': '0x0', 20:21:37 INFO - 'XPC_SERVICE_NAME': '0', 20:21:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:21:37 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/Uryn4NE9RU6EPApn98bvSA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0021', '--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 20:21:37 INFO - mozversion application_buildid: 20170127181720 20:21:37 INFO - mozversion application_changeset: eee47824f4687534a901cd9c28126041bd19d261 20:21:37 INFO - mozversion application_display_name: Firefox 20:21:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:21:37 INFO - mozversion application_name: Firefox 20:21:37 INFO - mozversion application_remotingname: firefox 20:21:37 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 20:21:37 INFO - mozversion application_vendor: Mozilla 20:21:37 INFO - mozversion application_version: 52.0 20:21:37 INFO - mozversion platform_buildid: 20170127181720 20:21:37 INFO - mozversion platform_changeset: eee47824f4687534a901cd9c28126041bd19d261 20:21:37 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 20:21:37 INFO - mozversion platform_version: 52.0 20:21:37 INFO - using testdate: 1485577297 20:21:37 INFO - actual date: 1485577297 20:21:37 INFO - starting webserver on 'localhost:49243' 20:21:37 INFO - SUITE-START | Running 2 tests 20:21:37 INFO - TEST-START | dromaeo_css 20:21:37 INFO - operating with platform_type : mac_ 20:21:37 INFO - Initialising browser for dromaeo_css test... 20:21:37 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/tmpbAsIqJ/profile http://localhost:49243/getInfo.html) 20:21:40 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 20:21:40 INFO - PROCESS | 1650 | colorDepth:24 20:21:40 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 20:21:40 INFO - PROCESS | 1650 | __metrics 20:21:40 INFO - PROCESS | 1650 | 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" 20:21:40 INFO - PROCESS | 1650 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:21:41 INFO - TEST-INFO | 1650: exit 0 20:21:41 INFO - Browser initialized. 20:21:41 INFO - Running cycle 1/1 for dromaeo_css test... 20:21:41 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/tmpbAsIqJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:21:53 INFO - PROCESS | 1653 | RSS: Main: 191139840 20:21:53 INFO - PROCESS | 1653 | 20:24:56 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 20:24:58 INFO - PROCESS | 1653 | RSS: Main: 336728064 20:24:58 INFO - PROCESS | 1653 | 20:28:00 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 20:28:01 INFO - PROCESS | 1653 | RSS: Main: 318877696 20:28:01 INFO - PROCESS | 1653 | 20:31:03 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 20:31:04 INFO - PROCESS | 1653 | RSS: Main: 293150720 20:31:04 INFO - PROCESS | 1653 | 20:34:06 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 20:34:07 INFO - PROCESS | 1653 | RSS: Main: 285937664 20:34:07 INFO - PROCESS | 1653 | 20:37:10 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 20:37:11 INFO - PROCESS | 1653 | RSS: Main: 276946944 20:37:11 INFO - PROCESS | 1653 | 20:40:14 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 20:40:14 INFO - PROCESS | 1653 | RSS: Main: 356290560 20:40:14 INFO - PROCESS | 1653 | 20:40:14 INFO - PROCESS | 1653 | __start_tp_report 20:40:14 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 20:40:14 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 20:40:14 INFO - PROCESS | 1653 | |i|pagename|runs| 20:40:14 INFO - PROCESS | 1653 | |0;dojo.html;3526.2594855080433;3552.040948943785;3558.2883423315343;3561.8041007744564;3624.2207925296057;5854.5609079319065;5932.881342373161;5974.492168165706;5980.820575382734;5991.640501569898;5797.913031304523;5804;5856.76572937082;5869.2369991901;5902.498287645544;5270.051390749663;5317.8404647860625;5317.973410132944;5361.597880159004;5412.944475827216;4449;4792.209285467911;5339.6262261641705;5384.0847056000375;5404;4657.4411070671395;5067.315912351823;5396.919046214291;5403.675779453226;5410.972945135269;5406;5449.918251226235;5463.699496527689;5465.808696695596;5474.288342515487;5157.690538567698;5315.0432922074015;5339.813106541253;5391.919121213185;5427.9185812212845;5728.856778580527;5772.855678608026;5801.129830525413;5842.328132264802;5881.794137205177;6199.814005579839;6202.3797620238065;6216.658083805389;6234.138476696663;6296.748130074791;6357.65032923189;6363.172787537636;6370.203724534434;6379.043143528462;6386.169797926286;5843.065109582446;5900.704964751788;5951.672658003851;5987.371326010706;6015.39846015395;5449.455054494598;6359.491240700733;6396.904046439307;6397.840053998687;6414.807555773335;6239.532035097386;6244.063390491372;6258.186435763321;6261.749530018748;6263.154474146023;6150.815475535741;6253.405926436982;6279.780207692709;6349.206349206349;6355.809325720235;6242.438180563771;6289.182406287154;6301.023341382093;6306.180196574416;6311.1795466589965;5266.868328291824;6298.685065746786;6299.590526615755;6302.527310451735;6309.33751956038;5016.974915125474;5039.420466646309;5049.394072711225;5103.081445339801;5103.5661968733075;4561.429821272341;4594.540545945446;4623.42207224097;4624.190766615829;4624.838130665411;6112.898653789679;6117.675163990783;6128.547837496741;6134.467201660849;6149.0161574148815;6252.499800015988;6310.5267104967315;6311.589746666544;6318.399752023551;6334.619922804554;4895.804167833318;5250.291210686585;6012.188354572164;6114.908276375769;6139.416755408319;5523.7238138092935;5553.444655534414;5582.49757521825;5600.355959064678;5628.577856660767;5692;6564.770233041821;6604.96697516519;6626.536142470077;6644.634545100066;5047.470015648304;6245.437910588069;6323.399277068671;6324.778632747832;6349.746010159542;6335.524835637253;6394.2646595640235;6475.870482590416;6519.1199188110895;6538.640374779433;6323.462505687068;6327.303996560283;6352.333005034405;6356.872862542816;6363.490920726424;6271.592346497463;6272.310045894857;6306.842328941813;6325.493960483058;6347.5556711029785;6131.590761709946;6163.3836616338;6190.752369905334;6324.177856878577;6336.619802811846;6144.617461071223;6259.937400625936;6264;6281.403266689657;6283.8114856554375;6126.356732543197;6132.478739307209;6138.938610613836;6145.539084568586;6150.077488376601;6063.787767428119;6129.419919118684;6129.756146212572;6184.536159787944;6207.037909124093;6063.242094738158;6118.051701986199;6129.567611078424;6138.232720909887;6162.22972128484 20:40:14 INFO - PROCESS | 1653 | |1;ext.html;458.4521496811312;488.73852488918436;515.8632962264999;522.214067827919;533.6104643610164;29884.252893677643;41179.794101029525;42199.578004219984;42227.36658950118;42256.57743422565;44073.55926440735;44205;44299.89250268745;44304;44355.77822110893;9560.235181185488;9745.805083898318;9757.316987810857;9760.072793084646;9778.706638800812;7558.924410755904;9094.63621455141;11627;11844.230125041888;11853.70365740859;11923;11998.580049698263;12008.979236764886;12015.699607509794;12018.879811201907;11822.881771182307;11859.110566707532;11867.703307417298;11893.226940248856;11902.345371004549;9750.609975600968;11554.768904621944;11665;11684.474198660995;11708.180427370087;41451.58548414507;41760;41774.79112604448;41857;41889.95275118116;3340.131565792887;3463.9653603463894;3908.6482216600357;3974.105826189113;4283.507396649394;22851.88574057119;31161.22096947572;31584.36831263362;31693;31978;3146.561715517283;3235.2397186661115;3275.8853440129483;3281.0156952914267;3283.8522266498067;445971;519854;520643.9999999962;523754;524043;35006.47490287648;52613.94772104536;65926.67036664786;65984.67007665028;65985.67007164934;36224.45663315053;36757.816210918776;37107;37234.81382593124;37292.44061339082;15066.472673456376;15187.468438604596;15201.923990380199;15204.239788010555;15239.3904243829;11216;12789.93605031969;12844.908182804566;12882.80675789864;12912.741745165044;7723.9227607723205;7835.0597928247835;7839.137694853562;7847.293743562993;8079.394045446615;3318.95884031319;3334.3998080345773;3354.3794398036443;3355.614104377979;3391.7795343302605;923.8614207868739;968.864358989742;986.4623780039896;1013.6705570689555;1068.1828401273033;26841.731582684315;29991.700082999327;30352.54471182934;30601;30717.77128914863;901.5041727050096;984.773502094508;1012.3065699995526;1097.2812807611028;1123.601121601836;15649.217539122998;16184.919075404783;16324.510264692079;16348.673026539402;16605.750913736305;667303;672140;674186;674210;674591;61199.38800612026;61589;61643.76712465726;61702;61773.691131544954;1271.9300438475786;1308.0974127851753;1372.8627137286192;1398.2030242761527;1423.4235134770433;30159.547606786353;30732.692673073878;31852.681473185898;32083.679163209003;32382;52729.736351317995;57730;62755.686221570424;62851;63155.684221578595;493163;496244;496947;497282;497539;37283.44074838825;38063.42904856374;41991;43383.34924976191;43690.68927932167;47386.815329617035;47402.52597474119;47568.2864757022;47913.56259312087;47960;38898.61101389063;39569.208615828094;40529.79735101423;40790.79604601958;41730.79134604307;39510.80244598759;39757.80121099376;39857.80071099626;40900.79549602352;41068.589314107674;39134.02164945899;39281.21437571175;39373.409398859614;39552.60447395489;39585.60414395935;33909.49135763015;35061.47407788936;35411.64588354187;36104.27791444209;36197.81901090478;26149.869250654385;26391.4721705561;26512.337191570365;26653.466930661667;26965.86517067402 20:40:14 INFO - PROCESS | 1653 | |2;jquery.html;326.3847647185056;391.2370876790259;392.135341571834;405.5640186799192;411.78381349791357;14729.410823567072;15920;19190.808091919076;21369.252076177338;21566.784332156694;16360.672786544263;18206.908965455186;20573.382798516068;21601.783982160174;21825;5789.321096881899;5929.051351783715;6194.442500174983;6266.122742815986;6286.46565041972;4125.195586860564;5100.438951715309;6203.844903877394;6236.189295391616;6240.500759939217;6265.279492858312;6270.905936410957;6291.276503202122;6295.559310848243;6307.684615769216;6062.848428789293;6159.9384006160035;6248.562600617958;6267.2165979252595;6268.467180289681;6062.63624182546;6127.693615319216;6128.142060111588;6129.84675383119;6130.785422510191;25822.612660810104;26275.817588208385;26424.47151056968;26707.931682732666;26720;2129.2015494189677;2701.810873238874;2838.8722507487214;2906.200794781431;3024.364883374494;10577.629782957636;10974.231803773739;11030.558777648885;14991.875609329343;16033.679326413523;1843.9170237339351;1864.1611274926338;1915.9425217243504;1916.7891531931477;1999.9505207689044;102450;119215.40392297984;123566.14650780245;128359.35820320933;132851.33574332067;11545.538178472934;11723.706907327214;11771.23486973344;11807.88192118085;11901.166918315808;13390.26353550564;14992.70014599702;15067.020643658347;15095.698086038217;15114.697706046038;7947.880781788278;8273.669053237803;8599.914000860037;8764.78088047804;8881.467111973303;8694.869576956351;8697.95651021741;8716.78208044804;8870.467771933705;8897.510636914902;4160.355144952538;4428.601425871622;4542.818287268472;4634.86095417138;4672.08894265615;1815;1893.3941138835717;1936.94189174325;1954.2280799084283;1983.8214560689319;958.7075941837667;968.6900191938512;992.1467537917385;1047.1988928469727;1081.810683130449;19649.80350196508;20160.899195503927;21475.67786483204;21585.02867370972;21693.67459488109;935.3452583191793;955.2214944819949;991.5934466868549;995.5520015992832;998.0418797954045;10621.468926553642;11191.32852028881;11192.496337664825;11217.71955701114;11225.719357015976;594332.2267109354;604349;611099;613902;614589;107660.38509422365;127241;128550;128679;131117;953.2278854128178;1037.2687255484714;1045.3362115056993;1047.9004494573003;1049.8582691336724;18251.54371140679;18565.907170464063;19192.61614767669;19801.10895009757;19827.702584460956;46296.30555541737;56259.71870140623;56313.155302671315;56946;58013.70993145176;81174;83520.58239708762;83875.5806220965;83921.58039209765;84297;7252.709891604277;7551.546907185587;7644.235576442311;7781.182975787461;8081.87877181831;11924.880751192377;13146.539871104465;13267.33663316811;13560.254186019863;13751.656208594864;10444.321119127233;11197.72005699864;11424.942875285571;11683.88316116862;12006.279623222284;11239.438028098399;11441.771164576496;11610.94194529022;11758.3532905691;11839.467223974769;11276.774464510829;11537.423128843691;11574.942125289657;12009.759804804029;12116.575919843115;7249.347558719741;7660.476180956823;7666.884996724942;7754.224577542201;7835.84328313442;11257.774844503228;11560.421978900853;11605.767884642091;11860.644180674593;11950.641480755592 20:40:14 INFO - PROCESS | 1653 | |3;mootools.html;1369.2195448594293;1502.9549113526596;1544.374528316032;1718.888272262303;1883.6138591588726;7535;8038.3971202159855;8122.878156827653;8337.541435221061;8347.749567512968;8366.665333386673;8435.40952133351;8445.408821382505;8451.535165565907;8459.365547583926;2370.1941339944415;2394.281715485356;2402.9759702402926;2403.9158629447975;2403.975960240393;2063.226290141197;2348.988255058722;2416.66166736657;2420.576399130145;2433.415980164765;2377.049180327874;2378.1438682074527;2402.9759702403016;2406.6750988616577;2407.217654262363;2343.6601692754457;2357.292812156355;2381.166591692911;2390.103711108334;2391.103336248898;2321.3848330192513;2346.1319311854554;2389.8446600971056;2393.748656391089;2394.820388470872;8461.703840365557;8521.36089793268;8547.31621470287;8553.572321383906;8581.442206256574;5043.52086551777;5236.266922630834;5266.552343050846;5300.602454815866;5308.734563271821;3056.6790486998766;3530.858765649371;3557.2529768748595;3622.4023036198996;3626.0753507855593;1047.7328281288299;1067.412922892406;1106.6403418888813;1107.0368779162181;1127.8872112788738;9821.705348839547;10890.564377424893;11014.339139651647;11030.117590592814;11041.889581104166;4298.4412026436985;4426.026274219666;4522.005158865044;4533.9319910201375;4540.547024951984;8707.869381959275;8709.172628600272;8719.258862996716;8725.127487251224;8728.519931403707;5159.8452046437915;5168.302279192336;5169.327987361619;5178.948210517847;5179.378474583074;4314.460692413449;4377.190219809346;4480.385203240668;4753.83361582343;4895.853124406273;3644.817759112034;3659.9268014640093;3742.4573436852047;3761.8119094045187;3773.132179598708;1138.5445821671399;1139.9658010259704;1140.4696815980442;1140.7604403075281;1143.9942800285946;920.2362039507193;934.672864497434;935.7239614313794;950.8621249918723;978.2223132609593;5595.7481913313995;5606.719664016783;6000.279966403972;6122.357152499013;6149.446549810449;439.96920215585243;441.96243319318216;443.9400680908101;449.3596624809633;457.5287453922465;3441.208522039945;3990.86031988879;4003.4395184674167;4025.6980726445636;4031.9193616127513;9966.352187107816;10126.493675316206;10287.331323463952;10372.636957706443;10410.271281010257;10251;10433.895661043292;10445.268831181897;10456.52945617449;10460.895391045991;7882.763517094496;7951.324137448381;8055.7583272501915;8062.637181326854;8074.111847696749;5623.2127502148915;5706.8573285666525;5808.5353171747;5824.097264923944;5907.054871220584;9437.245020398488;9528.333016688764;9562.426254424758;9595.568199430903;9663.27525435581;8960.68637597681;9325.253979681745;9331.673391431268;9547.522623868917;9570.47362395075;7220.602866842374;7453.515521491086;7608.353289970414;7670.232976702285;8007.15924827908;7801.141874393698;8171.877421838558;8171.959140204499;8177;8181;7065.717371305091;7186.784396468114;7217.097862767154;7240.710371585077;7249.42004639617;6434.8391290218115;6895.931130674753;6975.6163411012885;7073.540219885691;7303.342699157101;6812.21659509143;6813.931860681329;6817.7272909083085;6884.311568843075;6906.620135892374;4769.379980602638;4912.164931961646;4919.926201106915;4985.277134815359;5037.924431133462;4904.5340692634145;4923.384576927884;4951.3810773653295;5063.949360506495;5084.669496482717 20:40:14 INFO - PROCESS | 1653 | |4;prototype.html;244.4170652992613;305.78594983511545;314.0954052329292;319.7330229258569;319.9376121656276;4916.378604112132;5451.781928722851;5471.288732464779;5472.671639701615;5516.200150978106;4038.9798051009775;4832.4442689090765;5220.843374698756;5391.872713825981;5428.262955854128;3737.4206997915367;4072.572379900112;4165.042430057868;4201.915961680765;4209.074003719192;3788.7916164610933;4163.562825903282;4202.726822756526;4210.136921931012;4215.831366745327;3344.3812894614452;3685.852565897361;4161.9583804161875;4182.519010313822;4192.664586833062;3951.1551682788345;4138.889166525064;4166.979165104185;4189.874303770892;4198.8320467181275;3038.437888990544;3187.872485100593;3620.529331186955;3643.7995910224927;3649.981750091259;4841.296408247694;4930.137225985474;5386.380566234855;5398.24424580559;5401.43284955078;4778.092162489116;4791.747878497101;4805.087033463631;4823.228283474662;4851.636127290432;4550.749708766017;4677.251639737659;4764.761761911891;5721.284839395075;5740.282464691913;4010.8195131219163;4017.517897852247;4033.7781422021776;4042.919141617151;4052.5542190359038;5467.097928841737;5629.437056294379;5637.661740295554;5950.910736338915;5970.164177015221;3881.262560113569;3916.3929590913453;3921.705872059607;3930.8820735377985;3935.626115519021;3376.885627742839;3982.820773065219;4002.5397079335667;4020.974651463858;4021.6728479602248;4113.362428823537;4281.892952676146;4405.603495685404;4617.376654151713;4631.286424023066;5280.709560974184;5673.4114447954635;5721.885562288731;5738.139279108167;5744.827655170351;1133.4389477208833;1265.8670839561714;1294.5210272199347;1299.3503248375812;1349.6221058103747;778.7546922719325;856.6873091321747;882.5675419044622;900.5407242306471;904.9638014479347;4383.802728877208;4684.672072954929;4734.763261836894;4775.6657034007985;4896.87371904464;4636.559526844944;4901.358045054946;4906.239532872411;5112.156494178494;5534.640248383842;4332.1407870805115;4787.640926930494;4877.926831097537;4954.677945933503;5128.512791284822;2691.7711994480687;2702.810803243754;2849.0056960127995;2898.8693310416825;2907.418516296749;4930.299046828838;5781.219535362672;5801.403130059306;5841.656419023563;5873.911891321633;5305.920411193758;5674.0637794764225;6163.8150855474405;6165.84585385369;6173.47525460332;4908.858330668375;5656.8868622627315;6082.057281121433;6137.956547386955;6294.223465920411;5005.499450054966;5010.849674509771;5076.619253555924;5275.709835958905;5909.28630697093;5369.382521009978;5573.331200255833;5932.991391463548;5941.940580594139;5953.493953013869;5145.434002259673;5174.404943431554;6276.874462510816;6279.623222606659;6294.244690637152;3510.368133735952;3679.7792132472136;3753.70497178473;3938.4879965604287;4000.7199496035;4867.756612169306;5019.7239151847;5981.581289309706;6100.75596976116;6124.244090159357;4930.556249937523;5608.439156084522;5721.599488035798;5873.823785286449;5948.494377977747;4583.656225783013;4749.786259618257;4792.640551958547;5428.70142142186;5759.848030394021;4595.609373203315;4765.26138448541;5604.719764011865;5716.599838011466;5724.284464441945;5252.684838909678;5316.680999140064;5592.623135167619;5807.6442667999;5815.79644712433;4430.269005614166;5091.745412729275;5680.75610134003;5685.71571421419;5692.829215123553 20:40:14 INFO - PROCESS | 1653 | |5;yui.html;710.7690000749755;757.4584172316796;761.980950476238;793.4485532554875;838.4218528026321;14822.555323340304;15745.370185192607;15853.52439426819;15868.682626347467;15877.603059923493;13063.738725225514;13163.802542961863;13193;13208.93395533021;13214.867851321484;709.0817391478048;716.040505722332;842.2125312832521;853.564682012172;869.9652013919435;840.9453385529921;847.7753395350237;850.8851305073829;851.1998721202082;853.6628031927416;914.5930061122802;915.6795121707415;916.7524768312552;916.9724908252763;917.5091326140516;905.9864102038474;906.207068814787;907.9001309855911;910.1126401758299;910.1171863292595;677.4512644757762;681.8602186551745;682.5085938124543;684.165318311659;686.6360828760764;14679.119252844863;14753.631159220999;14776.48282310114;14789.926050369786;15395.461158859498;14129.858701412957;14524;14666.926665366711;14726.779098313535;14736.631584210374;9777.951110244474;11586.566184804442;11900.047996160372;11915.642530724092;11985.880141198564;3741.925161496782;3790.753601015953;3891.2801131790425;3913.393424019253;4014.959850401488;92248.53875730645;93934;93946.77239524238;95184;97555;10245.44412635883;10444.582216711246;11202.775944481065;11208.943955280172;11354.716132096764;20415.693764593543;21214.151433942778;21840.45398865041;22162.445938851335;22163;8151.144129866398;8155.796105097302;8176.182381761776;8253.463524870864;8400.117987611335;4370.104128653618;4433.7561434121435;4502.234620114523;4555.72665640056;4669.41632295963;3462.9826850865584;3577.0878426001723;3583.2475180211927;3584.0502266899293;3589.3539162950397;653.6568301641677;667.9198496180489;669.1769123977535;680.459035067113;689.8758223519715;621.6021746082511;643.7264162730821;646.9967650161719;652.9020646903002;671.3152584363921;8342.207490288412;9419.576119074658;9444.669436569824;9470.763230919281;9604.423734575948;670.6881300195432;686.8557602903446;706.7243774927782;712.398023669998;717.2218143314562;4404.955950440519;4758.881027974328;4806.543378379049;4841.1285968526;4860.270959356125;99932.00135997239;103703;114524.42737786424;115452;115975;91904.40477976075;94788.52605737065;94980;97364;101017.49491252497;81601.77597335925;86578.56710716407;87974.56012719896;89881.10118898858;90683.09316906746;8984.640614375614;10011.149052330342;10031;10106.595736170471;10154.644587439405;50919.472415827586;51154;51668.96662066813;54311;55208.72395637996;58214;66583;78604;79740.60129699315;82395;10811.783764324828;12354;13300.935925125774;13338.866611334151;13476.79784803209;11916.880831191576;14005.859941400455;14743.483978060716;15052.3226454812;15393.982343282769;12998.545050923172;13044.673883152996;13238.139520931109;13841.79237311421;14489.347979340744;13612.047156698936;13798.448062077405;14063.296835157997;14356.49752258666;14494.637634059232;12103.117243029263;12862.421191046613;12908.225506469642;13823.447062117804;13878.306084695927;9599.42403455795;9607.567659455202;11042.447877605928;11178.552857885594;12015.399230038289;9761.658341957997;10810.67567972962;11490.955454618084;11655.708607284885;11760 20:40:14 INFO - PROCESS | 1653 | __end_tp_report 20:40:14 INFO - PROCESS | 1653 | __start_cc_report 20:40:14 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1576 20:40:14 INFO - PROCESS | 1653 | __end_cc_report 20:40:14 INFO - PROCESS | 1653 | __startTimestamp1485578414503__endTimestamp 20:40:14 INFO - PROCESS | 1653 | 20:40:14 INFO - PROCESS | 1653 | ------- Summary: start ------- 20:40:14 INFO - PROCESS | 1653 | Number of tests: 6 20:40:14 INFO - PROCESS | 1653 | 20:40:14 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5849.36 Median:6129.76 stddev:645.65 (10.5%) stddev-sans-first:621.38 20:40:14 INFO - PROCESS | 1653 | Values: 3526.3 3552.0 3558.3 3561.8 3624.2 5854.6 5932.9 5974.5 5980.8 5991.6 5797.9 5804.0 5856.8 5869.2 5902.5 5270.1 5317.8 5318.0 5361.6 5412.9 4449.0 4792.2 5339.6 5384.1 5404.0 4657.4 5067.3 5396.9 5403.7 5411.0 5406.0 5449.9 5463.7 5465.8 5474.3 5157.7 5315.0 5339.8 5391.9 5427.9 5728.9 5772.9 5801.1 5842.3 5881.8 6199.8 6202.4 6216.7 6234.1 6296.7 6357.7 6363.2 6370.2 6379.0 6386.2 5843.1 5900.7 5951.7 5987.4 6015.4 5449.5 6359.5 6396.9 6397.8 6414.8 6239.5 6244.1 6258.2 6261.7 6263.2 6150.8 6253.4 6279.8 6349.2 6355.8 6242.4 6289.2 6301.0 6306.2 6311.2 5266.9 6298.7 6299.6 6302.5 6309.3 5017.0 5039.4 5049.4 5103.1 5103.6 4561.4 4594.5 4623.4 4624.2 4624.8 6112.9 6117.7 6128.5 6134.5 6149.0 6252.5 6310.5 6311.6 6318.4 6334.6 4895.8 5250.3 6012.2 6114.9 6139.4 5523.7 5553.4 5582.5 5600.4 5628.6 5692.0 6564.8 6605.0 6626.5 6644.6 5047.5 6245.4 6323.4 6324.8 6349.7 6335.5 6394.3 6475.9 6519.1 6538.6 6323.5 6327.3 6352.3 6356.9 6363.5 6271.6 6272.3 6306.8 6325.5 6347.6 6131.6 6163.4 6190.8 6324.2 6336.6 6144.6 6259.9 6264.0 6281.4 6283.8 6126.4 6132.5 6138.9 6145.5 6150.1 6063.8 6129.4 6129.8 6184.5 6207.0 6063.2 6118.1 6129.6 6138.2 6162.2 20:40:14 INFO - PROCESS | 1653 | 20:40:14 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:69421.89 Median:39207.62 stddev:150893.54 (384.9%) stddev-sans-first:151228.00 20:40:14 INFO - PROCESS | 1653 | Values: 458.5 488.7 515.9 522.2 533.6 29884.3 41179.8 42199.6 42227.4 42256.6 44073.6 44205.0 44299.9 44304.0 44355.8 9560.2 9745.8 9757.3 9760.1 9778.7 7558.9 9094.6 11627.0 11844.2 11853.7 11923.0 11998.6 12009.0 12015.7 12018.9 11822.9 11859.1 11867.7 11893.2 11902.3 9750.6 11554.8 11665.0 11684.5 11708.2 41451.6 41760.0 41774.8 41857.0 41890.0 3340.1 3464.0 3908.6 3974.1 4283.5 22851.9 31161.2 31584.4 31693.0 31978.0 3146.6 3235.2 3275.9 3281.0 3283.9 445971.0 519854.0 520644.0 523754.0 524043.0 35006.5 52613.9 65926.7 65984.7 65985.7 36224.5 36757.8 37107.0 37234.8 37292.4 15066.5 15187.5 15201.9 15204.2 15239.4 11216.0 12789.9 12844.9 12882.8 12912.7 7723.9 7835.1 7839.1 7847.3 8079.4 3319.0 3334.4 3354.4 3355.6 3391.8 923.9 968.9 986.5 1013.7 1068.2 26841.7 29991.7 30352.5 30601.0 30717.8 901.5 984.8 1012.3 1097.3 1123.6 15649.2 16184.9 16324.5 16348.7 16605.8 667303.0 672140.0 674186.0 674210.0 674591.0 61199.4 61589.0 61643.8 61702.0 61773.7 1271.9 1308.1 1372.9 1398.2 1423.4 30159.5 30732.7 31852.7 32083.7 32382.0 52729.7 57730.0 62755.7 62851.0 63155.7 493163.0 496244.0 496947.0 497282.0 497539.0 37283.4 38063.4 41991.0 43383.3 43690.7 47386.8 47402.5 47568.3 47913.6 47960.0 38898.6 39569.2 40529.8 40790.8 41730.8 39510.8 39757.8 39857.8 40900.8 41068.6 39134.0 39281.2 39373.4 39552.6 39585.6 33909.5 35061.5 35411.6 36104.3 36197.8 26149.9 26391.5 26512.3 26653.5 26965.9 20:40:14 INFO - PROCESS | 1653 | 20:40:14 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:35649.74 Median:21759.34 stddev:101392.17 (466.0%) stddev-sans-first:101641.91 20:40:14 INFO - PROCESS | 1653 | Values: 326.4 391.2 392.1 405.6 411.8 14729.4 15920.0 19190.8 21369.3 21566.8 16360.7 18206.9 20573.4 21601.8 21825.0 5789.3 5929.1 6194.4 6266.1 6286.5 4125.2 5100.4 6203.8 6236.2 6240.5 6265.3 6270.9 6291.3 6295.6 6307.7 6062.8 6159.9 6248.6 6267.2 6268.5 6062.6 6127.7 6128.1 6129.8 6130.8 25822.6 26275.8 26424.5 26707.9 26720.0 2129.2 2701.8 2838.9 2906.2 3024.4 10577.6 10974.2 11030.6 14991.9 16033.7 1843.9 1864.2 1915.9 1916.8 2000.0 102450.0 119215.4 123566.1 128359.4 132851.3 11545.5 11723.7 11771.2 11807.9 11901.2 13390.3 14992.7 15067.0 15095.7 15114.7 7947.9 8273.7 8599.9 8764.8 8881.5 8694.9 8698.0 8716.8 8870.5 8897.5 4160.4 4428.6 4542.8 4634.9 4672.1 1815.0 1893.4 1936.9 1954.2 1983.8 958.7 968.7 992.1 1047.2 1081.8 19649.8 20160.9 21475.7 21585.0 21693.7 935.3 955.2 991.6 995.6 998.0 10621.5 11191.3 11192.5 11217.7 11225.7 594332.2 604349.0 611099.0 613902.0 614589.0 107660.4 127241.0 128550.0 128679.0 131117.0 953.2 1037.3 1045.3 1047.9 1049.9 18251.5 18565.9 19192.6 19801.1 19827.7 46296.3 56259.7 56313.2 56946.0 58013.7 81174.0 83520.6 83875.6 83921.6 84297.0 7252.7 7551.5 7644.2 7781.2 8081.9 11924.9 13146.5 13267.3 13560.3 13751.7 10444.3 11197.7 11424.9 11683.9 12006.3 11239.4 11441.8 11610.9 11758.4 11839.5 11276.8 11537.4 11574.9 12009.8 12116.6 7249.3 7660.5 7666.9 7754.2 7835.8 11257.8 11560.4 11605.8 11860.6 11950.6 20:40:14 INFO - PROCESS | 1653 | 20:40:14 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5498.25 Median:5040.72 stddev:3021.52 (59.9%) stddev-sans-first:3014.06 20:40:14 INFO - PROCESS | 1653 | Values: 1369.2 1503.0 1544.4 1718.9 1883.6 7535.0 8038.4 8122.9 8337.5 8347.7 8366.7 8435.4 8445.4 8451.5 8459.4 2370.2 2394.3 2403.0 2403.9 2404.0 2063.2 2349.0 2416.7 2420.6 2433.4 2377.0 2378.1 2403.0 2406.7 2407.2 2343.7 2357.3 2381.2 2390.1 2391.1 2321.4 2346.1 2389.8 2393.7 2394.8 8461.7 8521.4 8547.3 8553.6 8581.4 5043.5 5236.3 5266.6 5300.6 5308.7 3056.7 3530.9 3557.3 3622.4 3626.1 1047.7 1067.4 1106.6 1107.0 1127.9 9821.7 10890.6 11014.3 11030.1 11041.9 4298.4 4426.0 4522.0 4533.9 4540.5 8707.9 8709.2 8719.3 8725.1 8728.5 5159.8 5168.3 5169.3 5178.9 5179.4 4314.5 4377.2 4480.4 4753.8 4895.9 3644.8 3659.9 3742.5 3761.8 3773.1 1138.5 1140.0 1140.5 1140.8 1144.0 920.2 934.7 935.7 950.9 978.2 5595.7 5606.7 6000.3 6122.4 6149.4 440.0 442.0 443.9 449.4 457.5 3441.2 3990.9 4003.4 4025.7 4031.9 9966.4 10126.5 10287.3 10372.6 10410.3 10251.0 10433.9 10445.3 10456.5 10460.9 7882.8 7951.3 8055.8 8062.6 8074.1 5623.2 5706.9 5808.5 5824.1 5907.1 9437.2 9528.3 9562.4 9595.6 9663.3 8960.7 9325.3 9331.7 9547.5 9570.5 7220.6 7453.5 7608.4 7670.2 8007.2 7801.1 8171.9 8172.0 8177.0 8181.0 7065.7 7186.8 7217.1 7240.7 7249.4 6434.8 6895.9 6975.6 7073.5 7303.3 6812.2 6813.9 6817.7 6884.3 6906.6 4769.4 4912.2 4919.9 4985.3 5037.9 4904.5 4923.4 4951.4 5063.9 5084.7 20:40:14 INFO - PROCESS | 1653 | 20:40:14 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4525.35 Median:4887.40 stddev:1401.23 (28.7%) stddev-sans-first:1367.82 20:40:14 INFO - PROCESS | 1653 | Values: 244.4 305.8 314.1 319.7 319.9 4916.4 5451.8 5471.3 5472.7 5516.2 4039.0 4832.4 5220.8 5391.9 5428.3 3737.4 4072.6 4165.0 4201.9 4209.1 3788.8 4163.6 4202.7 4210.1 4215.8 3344.4 3685.9 4162.0 4182.5 4192.7 3951.2 4138.9 4167.0 4189.9 4198.8 3038.4 3187.9 3620.5 3643.8 3650.0 4841.3 4930.1 5386.4 5398.2 5401.4 4778.1 4791.7 4805.1 4823.2 4851.6 4550.7 4677.3 4764.8 5721.3 5740.3 4010.8 4017.5 4033.8 4042.9 4052.6 5467.1 5629.4 5637.7 5950.9 5970.2 3881.3 3916.4 3921.7 3930.9 3935.6 3376.9 3982.8 4002.5 4021.0 4021.7 4113.4 4281.9 4405.6 4617.4 4631.3 5280.7 5673.4 5721.9 5738.1 5744.8 1133.4 1265.9 1294.5 1299.4 1349.6 778.8 856.7 882.6 900.5 905.0 4383.8 4684.7 4734.8 4775.7 4896.9 4636.6 4901.4 4906.2 5112.2 5534.6 4332.1 4787.6 4877.9 4954.7 5128.5 2691.8 2702.8 2849.0 2898.9 2907.4 4930.3 5781.2 5801.4 5841.7 5873.9 5305.9 5674.1 6163.8 6165.8 6173.5 4908.9 5656.9 6082.1 6138.0 6294.2 5005.5 5010.8 5076.6 5275.7 5909.3 5369.4 5573.3 5933.0 5941.9 5953.5 5145.4 5174.4 6276.9 6279.6 6294.2 3510.4 3679.8 3753.7 3938.5 4000.7 4867.8 5019.7 5981.6 6100.8 6124.2 4930.6 5608.4 5721.6 5873.8 5948.5 4583.7 4749.8 4792.6 5428.7 5759.8 4595.6 4765.3 5604.7 5716.6 5724.3 5252.7 5316.7 5592.6 5807.6 5815.8 4430.3 5091.7 5680.8 5685.7 5692.8 20:40:14 INFO - PROCESS | 1653 | 20:40:14 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:21001.38 Median:4714.15 stddev:30507.40 (647.1%) stddev-sans-first:30554.94 20:40:14 INFO - PROCESS | 1653 | Values: 710.8 757.5 762.0 793.4 838.4 14822.6 15745.4 15853.5 15868.7 15877.6 13063.7 13163.8 13193.0 13208.9 13214.9 709.1 716.0 842.2 853.6 870.0 840.9 847.8 850.9 851.2 853.7 914.6 915.7 916.8 917.0 917.5 906.0 906.2 907.9 910.1 910.1 677.5 681.9 682.5 684.2 686.6 14679.1 14753.6 14776.5 14789.9 15395.5 14129.9 14524.0 14666.9 14726.8 14736.6 9778.0 11586.6 11900.0 11915.6 11985.9 3741.9 3790.8 3891.3 3913.4 4015.0 92248.5 93934.0 93946.8 95184.0 97555.0 10245.4 10444.6 11202.8 11208.9 11354.7 20415.7 21214.2 21840.5 22162.4 22163.0 8151.1 8155.8 8176.2 8253.5 8400.1 4370.1 4433.8 4502.2 4555.7 4669.4 3463.0 3577.1 3583.2 3584.1 3589.4 653.7 667.9 669.2 680.5 689.9 621.6 643.7 647.0 652.9 671.3 8342.2 9419.6 9444.7 9470.8 9604.4 670.7 686.9 706.7 712.4 717.2 4405.0 4758.9 4806.5 4841.1 4860.3 99932.0 103703.0 114524.4 115452.0 115975.0 91904.4 94788.5 94980.0 97364.0 101017.5 81601.8 86578.6 87974.6 89881.1 90683.1 8984.6 10011.1 10031.0 10106.6 10154.6 50919.5 51154.0 51669.0 54311.0 55208.7 58214.0 66583.0 78604.0 79740.6 82395.0 10811.8 12354.0 13300.9 13338.9 13476.8 11916.9 14005.9 14743.5 15052.3 15394.0 12998.5 13044.7 13238.1 13841.8 14489.3 13612.0 13798.4 14063.3 14356.5 14494.6 12103.1 12862.4 12908.2 13823.4 13878.3 9599.4 9607.6 11042.4 11178.6 12015.4 9761.7 10810.7 11491.0 11655.7 11760.0 20:40:14 INFO - PROCESS | 1653 | -------- Summary: end -------- 20:40:14 INFO - PROCESS | 1653 | 20:40:15 INFO - TEST-INFO | 1653: exit 0 20:40:15 INFO - TEST-OK | dromaeo_css | took 1117453ms 20:40:15 INFO - TEST-START | kraken 20:40:15 INFO - operating with platform_type : mac_ 20:40:15 INFO - Initialising browser for kraken test... 20:40:15 INFO - TEST-INFO | started process 1775 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/tmpOnz5KE/profile http://localhost:49243/getInfo.html) 20:40:17 INFO - PROCESS | 1775 | __metrics Screen width/height:1600/1200 20:40:17 INFO - PROCESS | 1775 | colorDepth:24 20:40:17 INFO - PROCESS | 1775 | Browser inner width/height: 1024/689 20:40:17 INFO - PROCESS | 1775 | __metrics 20:40:17 INFO - PROCESS | 1775 | 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" 20:40:17 INFO - PROCESS | 1775 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:40:18 INFO - TEST-INFO | 1775: exit 0 20:40:18 INFO - Browser initialized. 20:40:18 INFO - Running cycle 1/1 for kraken test... 20:40:18 INFO - TEST-INFO | started process 1778 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/tmpOnz5KE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:40:30 INFO - PROCESS | 1778 | RSS: Main: 192131072 20:40:30 INFO - PROCESS | 1778 | 20:40:33 INFO - PROCESS | 1778 | 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) 20:40:34 INFO - PROCESS | 1778 | RSS: Main: 238751744 20:40:34 INFO - PROCESS | 1778 | 20:40:36 INFO - PROCESS | 1778 | 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) 20:40:37 INFO - PROCESS | 1778 | RSS: Main: 249847808 20:40:37 INFO - PROCESS | 1778 | 20:40:40 INFO - PROCESS | 1778 | 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) 20:40:40 INFO - PROCESS | 1778 | RSS: Main: 344117248 20:40:40 INFO - PROCESS | 1778 | 20:40:42 INFO - PROCESS | 1778 | 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) 20:40:43 INFO - PROCESS | 1778 | RSS: Main: 245673984 20:40:43 INFO - PROCESS | 1778 | 20:40:45 INFO - PROCESS | 1778 | 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) 20:40:46 INFO - PROCESS | 1778 | RSS: Main: 246910976 20:40:46 INFO - PROCESS | 1778 | 20:40:48 INFO - PROCESS | 1778 | 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) 20:40:49 INFO - PROCESS | 1778 | RSS: Main: 285765632 20:40:49 INFO - PROCESS | 1778 | 20:40:52 INFO - PROCESS | 1778 | 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) 20:40:52 INFO - PROCESS | 1778 | RSS: Main: 289247232 20:40:52 INFO - PROCESS | 1778 | 20:40:55 INFO - PROCESS | 1778 | 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) 20:40:56 INFO - PROCESS | 1778 | RSS: Main: 287191040 20:40:56 INFO - PROCESS | 1778 | 20:40:57 INFO - PROCESS | 1778 | 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) 20:40:58 INFO - PROCESS | 1778 | RSS: Main: 262156288 20:40:58 INFO - PROCESS | 1778 | 20:41:00 INFO - PROCESS | 1778 | 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) 20:41:00 INFO - PROCESS | 1778 | RSS: Main: 263798784 20:41:00 INFO - PROCESS | 1778 | 20:41:02 INFO - PROCESS | 1778 | 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) 20:41:03 INFO - PROCESS | 1778 | RSS: Main: 265498624 20:41:03 INFO - PROCESS | 1778 | 20:41:06 INFO - PROCESS | 1778 | 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) 20:41:07 INFO - PROCESS | 1778 | RSS: Main: 278245376 20:41:07 INFO - PROCESS | 1778 | 20:41:09 INFO - PROCESS | 1778 | 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) 20:41:10 INFO - PROCESS | 1778 | RSS: Main: 278704128 20:41:10 INFO - PROCESS | 1778 | 20:41:12 INFO - PROCESS | 1778 | 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) 20:41:12 INFO - PROCESS | 1778 | RSS: Main: 322588672 20:41:12 INFO - PROCESS | 1778 | 20:41:12 INFO - PROCESS | 1778 | __start_tp_report 20:41:12 INFO - PROCESS | 1778 | _x_x_mozilla_page_load 20:41:12 INFO - PROCESS | 1778 | _x_x_mozilla_page_load_details 20:41:12 INFO - PROCESS | 1778 | |i|pagename|runs| 20:41:12 INFO - PROCESS | 1778 | |0;ai-astar;115;114;114;113;113;115;113;111;114;115 20:41:12 INFO - PROCESS | 1778 | |1;audio-beat-detection;140;112;107;141;112;131;108;105;137;105 20:41:12 INFO - PROCESS | 1778 | |2;audio-dft;182;183;183;184;181;183;182;181;182;191 20:41:12 INFO - PROCESS | 1778 | |3;audio-fft;81;59;74;112;86;58;58;59;82;58 20:41:12 INFO - PROCESS | 1778 | |4;audio-oscillator;84;71;93;69;68;69;88;67;69;92 20:41:12 INFO - PROCESS | 1778 | |5;imaging-gaussian-blur;87;84;86;84;87;84;87;84;86;84 20:41:12 INFO - PROCESS | 1778 | |6;imaging-darkroom;148;108;93;92;94;93;93;93;94;93 20:41:12 INFO - PROCESS | 1778 | |7;imaging-desaturate;85;81;79;81;84;83;86;85;82;86 20:41:12 INFO - PROCESS | 1778 | |8;json-parse-financial;56;56;54;54;57;57;58;58;58;57 20:41:12 INFO - PROCESS | 1778 | |9;json-stringify-tinderbox;65;72;70;78;72;69;68;68;72;69 20:41:12 INFO - PROCESS | 1778 | |10;stanford-crypto-aes;81;81;80;81;82;82;79;79;85;80 20:41:12 INFO - PROCESS | 1778 | |11;stanford-crypto-ccm;134;135;139;142;134;138;139;141;175;144 20:41:12 INFO - PROCESS | 1778 | |12;stanford-crypto-pbkdf2;162;160;160;166;161;162;160;157;162;161 20:41:12 INFO - PROCESS | 1778 | |13;stanford-crypto-sha256-iterative;66;65;67;65;66;64;67;65;65;66 20:41:12 INFO - PROCESS | 1778 | __end_tp_report 20:41:12 INFO - PROCESS | 1778 | __start_cc_report 20:41:12 INFO - PROCESS | 1778 | _x_x_mozilla_cycle_collect,1837 20:41:12 INFO - PROCESS | 1778 | __end_cc_report 20:41:12 INFO - PROCESS | 1778 | __startTimestamp1485578472322__endTimestamp 20:41:12 INFO - PROCESS | 1778 | 20:41:12 INFO - PROCESS | 1778 | ------- Summary: start ------- 20:41:12 INFO - PROCESS | 1778 | Number of tests: 14 20:41:12 INFO - PROCESS | 1778 | 20:41:12 INFO - PROCESS | 1778 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:1.25 (1.1%) stddev-sans-first:1.24 20:41:12 INFO - PROCESS | 1778 | Values: 115.0 114.0 114.0 113.0 113.0 115.0 113.0 111.0 114.0 115.0 20:41:12 INFO - PROCESS | 1778 | 20:41:12 INFO - PROCESS | 1778 | [#1] audio-beat-detection Cycles:10 Average:119.80 Median:121.50 stddev:15.43 (12.7%) stddev-sans-first:14.53 20:41:12 INFO - PROCESS | 1778 | Values: 140.0 112.0 107.0 141.0 112.0 131.0 108.0 105.0 137.0 105.0 20:41:12 INFO - PROCESS | 1778 | 20:41:12 INFO - PROCESS | 1778 | [#2] audio-dft Cycles:10 Average:183.20 Median:183.00 stddev:2.90 (1.6%) stddev-sans-first:3.04 20:41:12 INFO - PROCESS | 1778 | Values: 182.0 183.0 183.0 184.0 181.0 183.0 182.0 181.0 182.0 191.0 20:41:12 INFO - PROCESS | 1778 | 20:41:12 INFO - PROCESS | 1778 | [#3] audio-fft Cycles:10 Average:72.70 Median:66.50 stddev:17.96 (27.0%) stddev-sans-first:18.79 20:41:12 INFO - PROCESS | 1778 | Values: 81.0 59.0 74.0 112.0 86.0 58.0 58.0 59.0 82.0 58.0 20:41:12 INFO - PROCESS | 1778 | 20:41:12 INFO - PROCESS | 1778 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:77.50 stddev:10.85 (14.0%) stddev-sans-first:11.21 20:41:12 INFO - PROCESS | 1778 | Values: 84.0 71.0 93.0 69.0 68.0 69.0 88.0 67.0 69.0 92.0 20:41:12 INFO - PROCESS | 1778 | 20:41:12 INFO - PROCESS | 1778 | [#5] imaging-gaussian-blur Cycles:10 Average:85.30 Median:86.00 stddev:1.42 (1.6%) stddev-sans-first:1.36 20:41:12 INFO - PROCESS | 1778 | Values: 87.0 84.0 86.0 84.0 87.0 84.0 87.0 84.0 86.0 84.0 20:41:12 INFO - PROCESS | 1778 | 20:41:12 INFO - PROCESS | 1778 | [#6] imaging-darkroom Cycles:10 Average:100.10 Median:93.00 stddev:17.48 (18.8%) stddev-sans-first:4.99 20:41:12 INFO - PROCESS | 1778 | Values: 148.0 108.0 93.0 92.0 94.0 93.0 93.0 93.0 94.0 93.0 20:41:12 INFO - PROCESS | 1778 | 20:41:12 INFO - PROCESS | 1778 | [#7] imaging-desaturate Cycles:10 Average:83.20 Median:84.50 stddev:2.39 (2.8%) stddev-sans-first:2.45 20:41:12 INFO - PROCESS | 1778 | Values: 85.0 81.0 79.0 81.0 84.0 83.0 86.0 85.0 82.0 86.0 20:41:12 INFO - PROCESS | 1778 | 20:41:12 INFO - PROCESS | 1778 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:57.00 stddev:1.51 (2.6%) stddev-sans-first:1.59 20:41:12 INFO - PROCESS | 1778 | Values: 56.0 56.0 54.0 54.0 57.0 57.0 58.0 58.0 58.0 57.0 20:41:12 INFO - PROCESS | 1778 | 20:41:12 INFO - PROCESS | 1778 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:71.00 stddev:3.50 (4.9%) stddev-sans-first:3.14 20:41:12 INFO - PROCESS | 1778 | Values: 65.0 72.0 70.0 78.0 72.0 69.0 68.0 68.0 72.0 69.0 20:41:12 INFO - PROCESS | 1778 | 20:41:12 INFO - PROCESS | 1778 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:81.00 stddev:1.76 (2.2%) stddev-sans-first:1.87 20:41:12 INFO - PROCESS | 1778 | Values: 81.0 81.0 80.0 81.0 82.0 82.0 79.0 79.0 85.0 80.0 20:41:12 INFO - PROCESS | 1778 | 20:41:12 INFO - PROCESS | 1778 | [#11] stanford-crypto-ccm Cycles:10 Average:142.10 Median:140.00 stddev:12.04 (8.6%) stddev-sans-first:12.41 20:41:12 INFO - PROCESS | 1778 | Values: 134.0 135.0 139.0 142.0 134.0 138.0 139.0 141.0 175.0 144.0 20:41:12 INFO - PROCESS | 1778 | 20:41:12 INFO - PROCESS | 1778 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.10 Median:161.50 stddev:2.28 (1.4%) stddev-sans-first:2.40 20:41:12 INFO - PROCESS | 1778 | Values: 162.0 160.0 160.0 166.0 161.0 162.0 160.0 157.0 162.0 161.0 20:41:12 INFO - PROCESS | 1778 | 20:41:12 INFO - PROCESS | 1778 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 20:41:12 INFO - PROCESS | 1778 | Values: 66.0 65.0 67.0 65.0 66.0 64.0 67.0 65.0 65.0 66.0 20:41:12 INFO - PROCESS | 1778 | -------- Summary: end -------- 20:41:12 INFO - PROCESS | 1778 | 20:41:13 INFO - TEST-INFO | 1778: exit 0 20:41:13 INFO - TEST-OK | kraken | took 58265ms 20:41:13 INFO - SUITE-END | took 1175s 20:41:13 INFO - Completed test suite (00:19:35) 20:41:13 INFO - javascript benchmark 20:41:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3526.2594855080433, 3552.040948943785, 3558.2883423315343, 3561.8041007744564, 3624.2207925296057, 5854.5609079319065, 5932.881342373161, 5974.492168165706, 5980.820575382734, 5991.640501569898, 5797.913031304523, 5804.0, 5856.76572937082, 5869.2369991901, 5902.498287645544, 5270.051390749663, 5317.8404647860625, 5317.973410132944, 5361.597880159004, 5412.944475827216, 4449.0, 4792.209285467911, 5339.6262261641705, 5384.0847056000375, 5404.0, 4657.4411070671395, 5067.315912351823, 5396.919046214291, 5403.675779453226, 5410.972945135269, 5406.0, 5449.918251226235, 5463.699496527689, 5465.808696695596, 5474.288342515487, 5157.690538567698, 5315.0432922074015, 5339.813106541253, 5391.919121213185, 5427.9185812212845, 5728.856778580527, 5772.855678608026, 5801.129830525413, 5842.328132264802, 5881.794137205177, 6199.814005579839, 6202.3797620238065, 6216.658083805389, 6234.138476696663, 6296.748130074791, 6357.65032923189, 6363.172787537636, 6370.203724534434, 6379.043143528462, 6386.169797926286, 5843.065109582446, 5900.704964751788, 5951.672658003851, 5987.371326010706, 6015.39846015395, 5449.455054494598, 6359.491240700733, 6396.904046439307, 6397.840053998687, 6414.807555773335, 6239.532035097386, 6244.063390491372, 6258.186435763321, 6261.749530018748, 6263.154474146023, 6150.815475535741, 6253.405926436982, 6279.780207692709, 6349.206349206349, 6355.809325720235, 6242.438180563771, 6289.182406287154, 6301.023341382093, 6306.180196574416, 6311.1795466589965, 5266.868328291824, 6298.685065746786, 6299.590526615755, 6302.527310451735, 6309.33751956038, 5016.974915125474, 5039.420466646309, 5049.394072711225, 5103.081445339801, 5103.5661968733075, 4561.429821272341, 4594.540545945446, 4623.42207224097, 4624.190766615829, 4624.838130665411, 6112.898653789679, 6117.675163990783, 6128.547837496741, 6134.467201660849, 6149.0161574148815, 6252.499800015988, 6310.5267104967315, 6311.589746666544, 6318.399752023551, 6334.619922804554, 4895.804167833318, 5250.291210686585, 6012.188354572164, 6114.908276375769, 6139.416755408319, 5523.7238138092935, 5553.444655534414, 5582.49757521825, 5600.355959064678, 5628.577856660767, 5692.0, 6564.770233041821, 6604.96697516519, 6626.536142470077, 6644.634545100066, 5047.470015648304, 6245.437910588069, 6323.399277068671, 6324.778632747832, 6349.746010159542, 6335.524835637253, 6394.2646595640235, 6475.870482590416, 6519.1199188110895, 6538.640374779433, 6323.462505687068, 6327.303996560283, 6352.333005034405, 6356.872862542816, 6363.490920726424, 6271.592346497463, 6272.310045894857, 6306.842328941813, 6325.493960483058, 6347.5556711029785, 6131.590761709946, 6163.3836616338, 6190.752369905334, 6324.177856878577, 6336.619802811846, 6144.617461071223, 6259.937400625936, 6264.0, 6281.403266689657, 6283.8114856554375, 6126.356732543197, 6132.478739307209, 6138.938610613836, 6145.539084568586, 6150.077488376601, 6063.787767428119, 6129.419919118684, 6129.756146212572, 6184.536159787944, 6207.037909124093, 6063.242094738158, 6118.051701986199, 6129.567611078424, 6138.232720909887, 6162.22972128484], "value": 5811.4999354376405, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [458.4521496811312, 488.73852488918436, 515.8632962264999, 522.214067827919, 533.6104643610164, 29884.252893677643, 41179.794101029525, 42199.578004219984, 42227.36658950118, 42256.57743422565, 44073.55926440735, 44205.0, 44299.89250268745, 44304.0, 44355.77822110893, 9560.235181185488, 9745.805083898318, 9757.316987810857, 9760.072793084646, 9778.706638800812, 7558.924410755904, 9094.63621455141, 11627.0, 11844.230125041888, 11853.70365740859, 11923.0, 11998.580049698263, 12008.979236764886, 12015.699607509794, 12018.879811201907, 11822.881771182307, 11859.110566707532, 11867.703307417298, 11893.226940248856, 11902.345371004549, 9750.609975600968, 11554.768904621944, 11665.0, 11684.474198660995, 11708.180427370087, 41451.58548414507, 41760.0, 41774.79112604448, 41857.0, 41889.95275118116, 3340.131565792887, 3463.9653603463894, 3908.6482216600357, 3974.105826189113, 4283.507396649394, 22851.88574057119, 31161.22096947572, 31584.36831263362, 31693.0, 31978.0, 3146.561715517283, 3235.2397186661115, 3275.8853440129483, 3281.0156952914267, 3283.8522266498067, 445971.0, 519854.0, 520643.9999999962, 523754.0, 524043.0, 35006.47490287648, 52613.94772104536, 65926.67036664786, 65984.67007665028, 65985.67007164934, 36224.45663315053, 36757.816210918776, 37107.0, 37234.81382593124, 37292.44061339082, 15066.472673456376, 15187.468438604596, 15201.923990380199, 15204.239788010555, 15239.3904243829, 11216.0, 12789.93605031969, 12844.908182804566, 12882.80675789864, 12912.741745165044, 7723.9227607723205, 7835.0597928247835, 7839.137694853562, 7847.293743562993, 8079.394045446615, 3318.95884031319, 3334.3998080345773, 3354.3794398036443, 3355.614104377979, 3391.7795343302605, 923.8614207868739, 968.864358989742, 986.4623780039896, 1013.6705570689555, 1068.1828401273033, 26841.731582684315, 29991.700082999327, 30352.54471182934, 30601.0, 30717.77128914863, 901.5041727050096, 984.773502094508, 1012.3065699995526, 1097.2812807611028, 1123.601121601836, 15649.217539122998, 16184.919075404783, 16324.510264692079, 16348.673026539402, 16605.750913736305, 667303.0, 672140.0, 674186.0, 674210.0, 674591.0, 61199.38800612026, 61589.0, 61643.76712465726, 61702.0, 61773.691131544954, 1271.9300438475786, 1308.0974127851753, 1372.8627137286192, 1398.2030242761527, 1423.4235134770433, 30159.547606786353, 30732.692673073878, 31852.681473185898, 32083.679163209003, 32382.0, 52729.736351317995, 57730.0, 62755.686221570424, 62851.0, 63155.684221578595, 493163.0, 496244.0, 496947.0, 497282.0, 497539.0, 37283.44074838825, 38063.42904856374, 41991.0, 43383.34924976191, 43690.68927932167, 47386.815329617035, 47402.52597474119, 47568.2864757022, 47913.56259312087, 47960.0, 38898.61101389063, 39569.208615828094, 40529.79735101423, 40790.79604601958, 41730.79134604307, 39510.80244598759, 39757.80121099376, 39857.80071099626, 40900.79549602352, 41068.589314107674, 39134.02164945899, 39281.21437571175, 39373.409398859614, 39552.60447395489, 39585.60414395935, 33909.49135763015, 35061.47407788936, 35411.64588354187, 36104.27791444209, 36197.81901090478, 26149.869250654385, 26391.4721705561, 26512.337191570365, 26653.466930661667, 26965.86517067402], "value": 19633.42678342566, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.3847647185056, 391.2370876790259, 392.135341571834, 405.5640186799192, 411.78381349791357, 14729.410823567072, 15920.0, 19190.808091919076, 21369.252076177338, 21566.784332156694, 16360.672786544263, 18206.908965455186, 20573.382798516068, 21601.783982160174, 21825.0, 5789.321096881899, 5929.051351783715, 6194.442500174983, 6266.122742815986, 6286.46565041972, 4125.195586860564, 5100.438951715309, 6203.844903877394, 6236.189295391616, 6240.500759939217, 6265.279492858312, 6270.905936410957, 6291.276503202122, 6295.559310848243, 6307.684615769216, 6062.848428789293, 6159.9384006160035, 6248.562600617958, 6267.2165979252595, 6268.467180289681, 6062.63624182546, 6127.693615319216, 6128.142060111588, 6129.84675383119, 6130.785422510191, 25822.612660810104, 26275.817588208385, 26424.47151056968, 26707.931682732666, 26720.0, 2129.2015494189677, 2701.810873238874, 2838.8722507487214, 2906.200794781431, 3024.364883374494, 10577.629782957636, 10974.231803773739, 11030.558777648885, 14991.875609329343, 16033.679326413523, 1843.9170237339351, 1864.1611274926338, 1915.9425217243504, 1916.7891531931477, 1999.9505207689044, 102450.0, 119215.40392297984, 123566.14650780245, 128359.35820320933, 132851.33574332067, 11545.538178472934, 11723.706907327214, 11771.23486973344, 11807.88192118085, 11901.166918315808, 13390.26353550564, 14992.70014599702, 15067.020643658347, 15095.698086038217, 15114.697706046038, 7947.880781788278, 8273.669053237803, 8599.914000860037, 8764.78088047804, 8881.467111973303, 8694.869576956351, 8697.95651021741, 8716.78208044804, 8870.467771933705, 8897.510636914902, 4160.355144952538, 4428.601425871622, 4542.818287268472, 4634.86095417138, 4672.08894265615, 1815.0, 1893.3941138835717, 1936.94189174325, 1954.2280799084283, 1983.8214560689319, 958.7075941837667, 968.6900191938512, 992.1467537917385, 1047.1988928469727, 1081.810683130449, 19649.80350196508, 20160.899195503927, 21475.67786483204, 21585.02867370972, 21693.67459488109, 935.3452583191793, 955.2214944819949, 991.5934466868549, 995.5520015992832, 998.0418797954045, 10621.468926553642, 11191.32852028881, 11192.496337664825, 11217.71955701114, 11225.719357015976, 594332.2267109354, 604349.0, 611099.0, 613902.0, 614589.0, 107660.38509422365, 127241.0, 128550.0, 128679.0, 131117.0, 953.2278854128178, 1037.2687255484714, 1045.3362115056993, 1047.9004494573003, 1049.8582691336724, 18251.54371140679, 18565.907170464063, 19192.61614767669, 19801.10895009757, 19827.702584460956, 46296.30555541737, 56259.71870140623, 56313.155302671315, 56946.0, 58013.70993145176, 81174.0, 83520.58239708762, 83875.5806220965, 83921.58039209765, 84297.0, 7252.709891604277, 7551.546907185587, 7644.235576442311, 7781.182975787461, 8081.87877181831, 11924.880751192377, 13146.539871104465, 13267.33663316811, 13560.254186019863, 13751.656208594864, 10444.321119127233, 11197.72005699864, 11424.942875285571, 11683.88316116862, 12006.279623222284, 11239.438028098399, 11441.771164576496, 11610.94194529022, 11758.3532905691, 11839.467223974769, 11276.774464510829, 11537.423128843691, 11574.942125289657, 12009.759804804029, 12116.575919843115, 7249.347558719741, 7660.476180956823, 7666.884996724942, 7754.224577542201, 7835.84328313442, 11257.774844503228, 11560.421978900853, 11605.767884642091, 11860.644180674593, 11950.641480755592], "value": 9847.62777316724, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1369.2195448594293, 1502.9549113526596, 1544.374528316032, 1718.888272262303, 1883.6138591588726, 7535.0, 8038.3971202159855, 8122.878156827653, 8337.541435221061, 8347.749567512968, 8366.665333386673, 8435.40952133351, 8445.408821382505, 8451.535165565907, 8459.365547583926, 2370.1941339944415, 2394.281715485356, 2402.9759702402926, 2403.9158629447975, 2403.975960240393, 2063.226290141197, 2348.988255058722, 2416.66166736657, 2420.576399130145, 2433.415980164765, 2377.049180327874, 2378.1438682074527, 2402.9759702403016, 2406.6750988616577, 2407.217654262363, 2343.6601692754457, 2357.292812156355, 2381.166591692911, 2390.103711108334, 2391.103336248898, 2321.3848330192513, 2346.1319311854554, 2389.8446600971056, 2393.748656391089, 2394.820388470872, 8461.703840365557, 8521.36089793268, 8547.31621470287, 8553.572321383906, 8581.442206256574, 5043.52086551777, 5236.266922630834, 5266.552343050846, 5300.602454815866, 5308.734563271821, 3056.6790486998766, 3530.858765649371, 3557.2529768748595, 3622.4023036198996, 3626.0753507855593, 1047.7328281288299, 1067.412922892406, 1106.6403418888813, 1107.0368779162181, 1127.8872112788738, 9821.705348839547, 10890.564377424893, 11014.339139651647, 11030.117590592814, 11041.889581104166, 4298.4412026436985, 4426.026274219666, 4522.005158865044, 4533.9319910201375, 4540.547024951984, 8707.869381959275, 8709.172628600272, 8719.258862996716, 8725.127487251224, 8728.519931403707, 5159.8452046437915, 5168.302279192336, 5169.327987361619, 5178.948210517847, 5179.378474583074, 4314.460692413449, 4377.190219809346, 4480.385203240668, 4753.83361582343, 4895.853124406273, 3644.817759112034, 3659.9268014640093, 3742.4573436852047, 3761.8119094045187, 3773.132179598708, 1138.5445821671399, 1139.9658010259704, 1140.4696815980442, 1140.7604403075281, 1143.9942800285946, 920.2362039507193, 934.672864497434, 935.7239614313794, 950.8621249918723, 978.2223132609593, 5595.7481913313995, 5606.719664016783, 6000.279966403972, 6122.357152499013, 6149.446549810449, 439.96920215585243, 441.96243319318216, 443.9400680908101, 449.3596624809633, 457.5287453922465, 3441.208522039945, 3990.86031988879, 4003.4395184674167, 4025.6980726445636, 4031.9193616127513, 9966.352187107816, 10126.493675316206, 10287.331323463952, 10372.636957706443, 10410.271281010257, 10251.0, 10433.895661043292, 10445.268831181897, 10456.52945617449, 10460.895391045991, 7882.763517094496, 7951.324137448381, 8055.7583272501915, 8062.637181326854, 8074.111847696749, 5623.2127502148915, 5706.8573285666525, 5808.5353171747, 5824.097264923944, 5907.054871220584, 9437.245020398488, 9528.333016688764, 9562.426254424758, 9595.568199430903, 9663.27525435581, 8960.68637597681, 9325.253979681745, 9331.673391431268, 9547.522623868917, 9570.47362395075, 7220.602866842374, 7453.515521491086, 7608.353289970414, 7670.232976702285, 8007.15924827908, 7801.141874393698, 8171.877421838558, 8171.959140204499, 8177.0, 8181.0, 7065.717371305091, 7186.784396468114, 7217.097862767154, 7240.710371585077, 7249.42004639617, 6434.8391290218115, 6895.931130674753, 6975.6163411012885, 7073.540219885691, 7303.342699157101, 6812.21659509143, 6813.931860681329, 6817.7272909083085, 6884.311568843075, 6906.620135892374, 4769.379980602638, 4912.164931961646, 4919.926201106915, 4985.277134815359, 5037.924431133462, 4904.5340692634145, 4923.384576927884, 4951.3810773653295, 5063.949360506495, 5084.669496482717], "value": 4384.7860227093015, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [244.4170652992613, 305.78594983511545, 314.0954052329292, 319.7330229258569, 319.9376121656276, 4916.378604112132, 5451.781928722851, 5471.288732464779, 5472.671639701615, 5516.200150978106, 4038.9798051009775, 4832.4442689090765, 5220.843374698756, 5391.872713825981, 5428.262955854128, 3737.4206997915367, 4072.572379900112, 4165.042430057868, 4201.915961680765, 4209.074003719192, 3788.7916164610933, 4163.562825903282, 4202.726822756526, 4210.136921931012, 4215.831366745327, 3344.3812894614452, 3685.852565897361, 4161.9583804161875, 4182.519010313822, 4192.664586833062, 3951.1551682788345, 4138.889166525064, 4166.979165104185, 4189.874303770892, 4198.8320467181275, 3038.437888990544, 3187.872485100593, 3620.529331186955, 3643.7995910224927, 3649.981750091259, 4841.296408247694, 4930.137225985474, 5386.380566234855, 5398.24424580559, 5401.43284955078, 4778.092162489116, 4791.747878497101, 4805.087033463631, 4823.228283474662, 4851.636127290432, 4550.749708766017, 4677.251639737659, 4764.761761911891, 5721.284839395075, 5740.282464691913, 4010.8195131219163, 4017.517897852247, 4033.7781422021776, 4042.919141617151, 4052.5542190359038, 5467.097928841737, 5629.437056294379, 5637.661740295554, 5950.910736338915, 5970.164177015221, 3881.262560113569, 3916.3929590913453, 3921.705872059607, 3930.8820735377985, 3935.626115519021, 3376.885627742839, 3982.820773065219, 4002.5397079335667, 4020.974651463858, 4021.6728479602248, 4113.362428823537, 4281.892952676146, 4405.603495685404, 4617.376654151713, 4631.286424023066, 5280.709560974184, 5673.4114447954635, 5721.885562288731, 5738.139279108167, 5744.827655170351, 1133.4389477208833, 1265.8670839561714, 1294.5210272199347, 1299.3503248375812, 1349.6221058103747, 778.7546922719325, 856.6873091321747, 882.5675419044622, 900.5407242306471, 904.9638014479347, 4383.802728877208, 4684.672072954929, 4734.763261836894, 4775.6657034007985, 4896.87371904464, 4636.559526844944, 4901.358045054946, 4906.239532872411, 5112.156494178494, 5534.640248383842, 4332.1407870805115, 4787.640926930494, 4877.926831097537, 4954.677945933503, 5128.512791284822, 2691.7711994480687, 2702.810803243754, 2849.0056960127995, 2898.8693310416825, 2907.418516296749, 4930.299046828838, 5781.219535362672, 5801.403130059306, 5841.656419023563, 5873.911891321633, 5305.920411193758, 5674.0637794764225, 6163.8150855474405, 6165.84585385369, 6173.47525460332, 4908.858330668375, 5656.8868622627315, 6082.057281121433, 6137.956547386955, 6294.223465920411, 5005.499450054966, 5010.849674509771, 5076.619253555924, 5275.709835958905, 5909.28630697093, 5369.382521009978, 5573.331200255833, 5932.991391463548, 5941.940580594139, 5953.493953013869, 5145.434002259673, 5174.404943431554, 6276.874462510816, 6279.623222606659, 6294.244690637152, 3510.368133735952, 3679.7792132472136, 3753.70497178473, 3938.4879965604287, 4000.7199496035, 4867.756612169306, 5019.7239151847, 5981.581289309706, 6100.75596976116, 6124.244090159357, 4930.556249937523, 5608.439156084522, 5721.599488035798, 5873.823785286449, 5948.494377977747, 4583.656225783013, 4749.786259618257, 4792.640551958547, 5428.70142142186, 5759.848030394021, 4595.609373203315, 4765.26138448541, 5604.719764011865, 5716.599838011466, 5724.284464441945, 5252.684838909678, 5316.680999140064, 5592.623135167619, 5807.6442667999, 5815.79644712433, 4430.269005614166, 5091.745412729275, 5680.75610134003, 5685.71571421419, 5692.829215123553], "value": 4076.725799310227, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.7690000749755, 757.4584172316796, 761.980950476238, 793.4485532554875, 838.4218528026321, 14822.555323340304, 15745.370185192607, 15853.52439426819, 15868.682626347467, 15877.603059923493, 13063.738725225514, 13163.802542961863, 13193.0, 13208.93395533021, 13214.867851321484, 709.0817391478048, 716.040505722332, 842.2125312832521, 853.564682012172, 869.9652013919435, 840.9453385529921, 847.7753395350237, 850.8851305073829, 851.1998721202082, 853.6628031927416, 914.5930061122802, 915.6795121707415, 916.7524768312552, 916.9724908252763, 917.5091326140516, 905.9864102038474, 906.207068814787, 907.9001309855911, 910.1126401758299, 910.1171863292595, 677.4512644757762, 681.8602186551745, 682.5085938124543, 684.165318311659, 686.6360828760764, 14679.119252844863, 14753.631159220999, 14776.48282310114, 14789.926050369786, 15395.461158859498, 14129.858701412957, 14524.0, 14666.926665366711, 14726.779098313535, 14736.631584210374, 9777.951110244474, 11586.566184804442, 11900.047996160372, 11915.642530724092, 11985.880141198564, 3741.925161496782, 3790.753601015953, 3891.2801131790425, 3913.393424019253, 4014.959850401488, 92248.53875730645, 93934.0, 93946.77239524238, 95184.0, 97555.0, 10245.44412635883, 10444.582216711246, 11202.775944481065, 11208.943955280172, 11354.716132096764, 20415.693764593543, 21214.151433942778, 21840.45398865041, 22162.445938851335, 22163.0, 8151.144129866398, 8155.796105097302, 8176.182381761776, 8253.463524870864, 8400.117987611335, 4370.104128653618, 4433.7561434121435, 4502.234620114523, 4555.72665640056, 4669.41632295963, 3462.9826850865584, 3577.0878426001723, 3583.2475180211927, 3584.0502266899293, 3589.3539162950397, 653.6568301641677, 667.9198496180489, 669.1769123977535, 680.459035067113, 689.8758223519715, 621.6021746082511, 643.7264162730821, 646.9967650161719, 652.9020646903002, 671.3152584363921, 8342.207490288412, 9419.576119074658, 9444.669436569824, 9470.763230919281, 9604.423734575948, 670.6881300195432, 686.8557602903446, 706.7243774927782, 712.398023669998, 717.2218143314562, 4404.955950440519, 4758.881027974328, 4806.543378379049, 4841.1285968526, 4860.270959356125, 99932.00135997239, 103703.0, 114524.42737786424, 115452.0, 115975.0, 91904.40477976075, 94788.52605737065, 94980.0, 97364.0, 101017.49491252497, 81601.77597335925, 86578.56710716407, 87974.56012719896, 89881.10118898858, 90683.09316906746, 8984.640614375614, 10011.149052330342, 10031.0, 10106.595736170471, 10154.644587439405, 50919.472415827586, 51154.0, 51668.96662066813, 54311.0, 55208.72395637996, 58214.0, 66583.0, 78604.0, 79740.60129699315, 82395.0, 10811.783764324828, 12354.0, 13300.935925125774, 13338.866611334151, 13476.79784803209, 11916.880831191576, 14005.859941400455, 14743.483978060716, 15052.3226454812, 15393.982343282769, 12998.545050923172, 13044.673883152996, 13238.139520931109, 13841.79237311421, 14489.347979340744, 13612.047156698936, 13798.448062077405, 14063.296835157997, 14356.49752258666, 14494.637634059232, 12103.117243029263, 12862.421191046613, 12908.225506469642, 13823.447062117804, 13878.306084695927, 9599.42403455795, 9607.567659455202, 11042.447877605928, 11178.552857885594, 12015.399230038289, 9761.658341957997, 10810.67567972962, 11490.955454618084, 11655.708607284885, 11760.0], "value": 7563.526793021612, "unit": "score"}], "name": "dromaeo_css", "value": 7304.7928815638925, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 113.0, 113.0, 115.0, 113.0, 111.0, 114.0, 115.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 112.0, 107.0, 141.0, 112.0, 131.0, 108.0, 105.0, 137.0, 105.0], "value": 119.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 183.0, 184.0, 181.0, 183.0, 182.0, 181.0, 182.0, 191.0], "value": 183.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 74.0, 112.0, 86.0, 58.0, 58.0, 59.0, 82.0, 58.0], "value": 72.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 71.0, 93.0, 69.0, 68.0, 69.0, 88.0, 67.0, 69.0, 92.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 86.0, 84.0, 87.0, 84.0, 87.0, 84.0, 86.0, 84.0], "value": 85.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 108.0, 93.0, 92.0, 94.0, 93.0, 93.0, 93.0, 94.0, 93.0], "value": 100.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 81.0, 79.0, 81.0, 84.0, 83.0, 86.0, 85.0, 82.0, 86.0], "value": 83.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 54.0, 54.0, 57.0, 57.0, 58.0, 58.0, 58.0, 57.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 70.0, 78.0, 72.0, 69.0, 68.0, 68.0, 72.0, 69.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 80.0, 81.0, 82.0, 82.0, 79.0, 79.0, 85.0, 80.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 135.0, 139.0, 142.0, 134.0, 138.0, 139.0, 141.0, 175.0, 144.0], "value": 142.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 160.0, 166.0, 161.0, 162.0, 160.0, 157.0, 162.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 65.0, 66.0, 64.0, 67.0, 65.0, 65.0, 66.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1411.5999999999997, "alertThreshold": 2.0}]} 20:41:13 INFO - Return code: 0 20:41:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:41:13 INFO - # TBPL SUCCESS # 20:41:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:41:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:41:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:41:13 INFO - 2017-01-27 20:41:13.645 screenresolution[1787:10034] starting screenresolution argv=screenresolution get 20:41:13 INFO - 2017-01-27 20:41:13.648 screenresolution[1787:10034] Display 0: 1600x1200x32@60 20:41:13 INFO - 2017-01-27 20:41:13.654 screenresolution[1788:10037] starting screenresolution argv=screenresolution list 20:41:13 INFO - Available Modes on Display 0 20:41:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:41:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:41:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:41:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:41:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:41:13 INFO - Intel Iris: 20:41:13 INFO - Chipset Model: Intel Iris 20:41:13 INFO - Type: GPU 20:41:13 INFO - Bus: Built-In 20:41:13 INFO - VRAM (Dynamic, Max): 1536 MB 20:41:13 INFO - Vendor: Intel (0x8086) 20:41:13 INFO - Device ID: 0x0a2e 20:41:13 INFO - Revision ID: 0x0009 20:41:13 INFO - Displays: 20:41:13 INFO - Display: 20:41:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:41:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:41:13 INFO - Display Serial Number: 1600x1200 60 20:41:13 INFO - Main Display: Yes 20:41:13 INFO - Mirror: Off 20:41:13 INFO - Online: Yes 20:41:13 INFO - Rotation: Supported 20:41:13 INFO - Return code: 0 20:41:13 INFO - Running post-action listener: _resource_record_post_action 20:41:13 INFO - [mozharness: 2017-01-28 04:41:13.895790Z] Finished run-tests step (success) 20:41:13 INFO - Running post-run listener: _resource_record_post_run 20:41:13 INFO - Total resource usage - Wall time: 1197s; CPU: 53.0%; Read bytes: 37700608; Write bytes: 499357696; Read time: 434; Write time: 1667 20:41:13 INFO - TinderboxPrint: CPU usage
53.2% 20:41:13 INFO - TinderboxPrint: I/O read bytes / time
37,700,608 / 434 20:41:13 INFO - TinderboxPrint: I/O write bytes / time
499,357,696 / 1,667 20:41:13 INFO - TinderboxPrint: CPU idle
2,241.7 (46.8%) 20:41:13 INFO - TinderboxPrint: CPU system
954.0 (19.9%) 20:41:13 INFO - TinderboxPrint: CPU user
1,593.7 (33.3%) 20:41:13 INFO - TinderboxPrint: Swap in / out
229,220,352 / 0 20:41:13 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 187517440; Write bytes: 187213312; Read time: 16852; Write time: 357 20:41:13 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 35738624; Write bytes: 305148416; Read time: 414; Write time: 1281 20:41:14 INFO - Running post-run listener: _upload_blobber_files 20:41:14 INFO - Blob upload gear active. 20:41:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:41:14 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 20:41:14 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'] 20:41:14 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 20:41:14 INFO - (blobuploader) - INFO - Open directory for files ... 20:41:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:41:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:41:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:41:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:41:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:41:15 INFO - (blobuploader) - INFO - Done attempting. 20:41:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:41:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:41:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:41:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:41:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:41:16 INFO - (blobuploader) - INFO - Done attempting. 20:41:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:41:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:41:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:41:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:41:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:41:19 INFO - (blobuploader) - INFO - Done attempting. 20:41:19 INFO - (blobuploader) - INFO - Iteration through files over. 20:41:19 INFO - Return code: 0 20:41:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:41:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:41:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/22cc9acd26b9bb67cd9a0552af65b547edfe2306fc9798ee36930f72f762a429e2c914045ea5acda24c0116d393af8c548a2509b5390ee967f13ae9ac1de425b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/85d2122a1ffc4ffc8526670f79208d5cae576370a1a8080e7c6c652f2af6e3a58684a433f550b83daf56717324b350ea9cbc87df358a76b8c5d08961d06ce078", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b50d2e537d22bf07d863680fbfa415199154535ed5c4a859c72d2ea19454245263bf53a07d6b7cf5377d42f590000962c9e0d3c1b6975dd369f57259524000f2"} 20:41:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:41:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:41:19 INFO - Contents: 20:41:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/22cc9acd26b9bb67cd9a0552af65b547edfe2306fc9798ee36930f72f762a429e2c914045ea5acda24c0116d393af8c548a2509b5390ee967f13ae9ac1de425b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/85d2122a1ffc4ffc8526670f79208d5cae576370a1a8080e7c6c652f2af6e3a58684a433f550b83daf56717324b350ea9cbc87df358a76b8c5d08961d06ce078", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b50d2e537d22bf07d863680fbfa415199154535ed5c4a859c72d2ea19454245263bf53a07d6b7cf5377d42f590000962c9e0d3c1b6975dd369f57259524000f2"} 20:41:19 INFO - Running post-run listener: copy_logs_to_upload_dir 20:41:19 INFO - Copying logs to upload dir... 20:41:19 INFO - mkdir: /builds/slave/test/build/upload/logs 20:41:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.294920 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-01-27 20:41:19.075323) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-27 20:41:19.079257) ========= 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.6M1Ro5Obq6/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.uG0KC3p7su/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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/22cc9acd26b9bb67cd9a0552af65b547edfe2306fc9798ee36930f72f762a429e2c914045ea5acda24c0116d393af8c548a2509b5390ee967f13ae9ac1de425b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/85d2122a1ffc4ffc8526670f79208d5cae576370a1a8080e7c6c652f2af6e3a58684a433f550b83daf56717324b350ea9cbc87df358a76b8c5d08961d06ce078", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b50d2e537d22bf07d863680fbfa415199154535ed5c4a859c72d2ea19454245263bf53a07d6b7cf5377d42f590000962c9e0d3c1b6975dd369f57259524000f2"} build_url:https://queue.taskcluster.net/v1/task/Uryn4NE9RU6EPApn98bvSA/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011056 build_url: 'https://queue.taskcluster.net/v1/task/Uryn4NE9RU6EPApn98bvSA/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/22cc9acd26b9bb67cd9a0552af65b547edfe2306fc9798ee36930f72f762a429e2c914045ea5acda24c0116d393af8c548a2509b5390ee967f13ae9ac1de425b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/85d2122a1ffc4ffc8526670f79208d5cae576370a1a8080e7c6c652f2af6e3a58684a433f550b83daf56717324b350ea9cbc87df358a76b8c5d08961d06ce078", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b50d2e537d22bf07d863680fbfa415199154535ed5c4a859c72d2ea19454245263bf53a07d6b7cf5377d42f590000962c9e0d3c1b6975dd369f57259524000f2"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-27 20:41:19.121091) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 20:41:19.121962) ========= 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.6M1Ro5Obq6/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.uG0KC3p7su/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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.005166 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 20:41:19.175898) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-27 20:41:19.176623) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-27 20:41:19.177228) ========= ========= Total master_lag: 0.20 =========