builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0062 starttime: 1486577844.21 results: success (0) buildid: 20170208075457 builduid: 89aa009685ec48e69f75505c5e62dc2f revision: 8b510eefa687ab18725e2c7abce570488d1e1825 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-08 10:17:24.209610) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-08 10:17:24.210044) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-08 10:17:24.210322) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-08 10:17:24.238694) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 10:17:24.239071) ========= 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.H4MRWBmwHz/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.vioC8pMRPo/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-08 10:17:24-- 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% 14.6M=0.001s 2017-02-08 10:17:24 (14.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128748 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 10:17:24.395706) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 10:17:24.396068) ========= 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.H4MRWBmwHz/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.vioC8pMRPo/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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.028412 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 10:17:24.449935) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-08 10:17:24.450298) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8b510eefa687ab18725e2c7abce570488d1e1825 --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 8b510eefa687ab18725e2c7abce570488d1e1825 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.H4MRWBmwHz/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.vioC8pMRPo/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-08 10:17:24,554 truncating revision to first 12 chars 2017-02-08 10:17:24,555 Setting DEBUG logging. 2017-02-08 10:17:24,555 attempt 1/10 2017-02-08 10:17:24,555 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/8b510eefa687?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-08 10:17:25,595 unpacking tar archive at: mozilla-beta-8b510eefa687/testing/mozharness/ program finished with exit code 0 elapsedTime=1.617135 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-08 10:17:26.093547) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-08 10:17:26.093894) ========= script_repo_revision: 8b510eefa687ab18725e2c7abce570488d1e1825 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-08 10:17:26.094336) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-08 10:17:26.094602) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-08 10:17:26.118516) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-08 10:17:26.118894) ========= /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.H4MRWBmwHz/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.vioC8pMRPo/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 10:17:26 INFO - MultiFileLogger online at 20170208 10:17:26 in /builds/slave/test 10:17:26 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 10:17:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:17:26 INFO - {'append_to_log': False, 10:17:26 INFO - 'base_work_dir': '/builds/slave/test', 10:17:26 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:17:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:17:26 INFO - 'branch': 'Mozilla-Beta', 10:17:26 INFO - 'buildbot_json_path': 'buildprops.json', 10:17:26 INFO - 'config_files': ('talos/mac_config.py',), 10:17:26 INFO - 'default_actions': ('clobber', 10:17:26 INFO - 'read-buildbot-config', 10:17:26 INFO - 'download-and-extract', 10:17:26 INFO - 'populate-webroot', 10:17:26 INFO - 'create-virtualenv', 10:17:26 INFO - 'install', 10:17:26 INFO - 'run-tests'), 10:17:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:17:26 INFO - 'download_minidump_stackwalk': True, 10:17:26 INFO - 'download_symbols': 'ondemand', 10:17:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:17:26 INFO - 'tooltool.py': '/tools/tooltool.py', 10:17:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:17:26 INFO - '/tools/misc-python/virtualenv.py')}, 10:17:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:17:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:17:26 INFO - 'installer_path': 'installer.exe', 10:17:26 INFO - 'log_level': 'info', 10:17:26 INFO - 'log_name': 'talos', 10:17:26 INFO - 'log_to_console': True, 10:17:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:17:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:17:26 INFO - 'opt_config_files': (), 10:17:26 INFO - 'pip_index': False, 10:17:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:17:26 INFO - 'cmd': ('bash', 10:17:26 INFO - '-c', 10:17:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:17:26 INFO - 'enabled': True, 10:17:26 INFO - 'halt_on_failure': False, 10:17:26 INFO - 'name': 'check_screen_resolution'},), 10:17:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:17:26 INFO - 'cmd': ('bash', 10:17:26 INFO - '-c', 10:17:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:17:26 INFO - 'enabled': True, 10:17:26 INFO - 'halt_on_failure': False, 10:17:26 INFO - 'name': 'check_screen_resolution'},), 10:17:26 INFO - 'run_cmd_checks_enabled': True, 10:17:26 INFO - 'sps_profile': False, 10:17:26 INFO - 'sps_profile_interval': 0, 10:17:26 INFO - 'suite': 'dromaeojs', 10:17:26 INFO - 'system_bits': '32', 10:17:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:17:26 INFO - 'title': 't-yosemite-r7-0062', 10:17:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:17:26 INFO - 'use_talos_json': True, 10:17:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:17:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:17:26 INFO - 'work_dir': 'build'} 10:17:26 INFO - [mozharness: 2017-02-08 18:17:26.338032Z] Running clobber step. 10:17:26 INFO - Running pre-action listener: _resource_record_pre_action 10:17:26 INFO - Running main action method: clobber 10:17:26 INFO - rmtree: /builds/slave/test/build 10:17:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:17:27 INFO - Running post-action listener: _resource_record_post_action 10:17:27 INFO - [mozharness: 2017-02-08 18:17:27.861626Z] Finished clobber step (success) 10:17:27 INFO - [mozharness: 2017-02-08 18:17:27.861783Z] Running read-buildbot-config step. 10:17:27 INFO - Running pre-action listener: _resource_record_pre_action 10:17:27 INFO - Running main action method: read_buildbot_config 10:17:27 INFO - Using buildbot properties: 10:17:27 INFO - { 10:17:27 INFO - "project": "", 10:17:27 INFO - "product": "firefox", 10:17:27 INFO - "script_repo_revision": "production", 10:17:27 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 10:17:27 INFO - "repository": "", 10:17:27 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 10:17:27 INFO - "buildid": "20170208075457", 10:17:27 INFO - "pgo_build": "False", 10:17:27 INFO - "basedir": "/builds/slave/test", 10:17:27 INFO - "buildnumber": 2, 10:17:27 INFO - "slavename": "t-yosemite-r7-0062", 10:17:27 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 10:17:27 INFO - "platform": "yosemite_r7", 10:17:27 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 10:17:27 INFO - "branch": "mozilla-beta", 10:17:27 INFO - "repo_path": "releases/mozilla-beta", 10:17:27 INFO - "revision": "8b510eefa687ab18725e2c7abce570488d1e1825", 10:17:27 INFO - "stage_platform": "macosx64", 10:17:27 INFO - "builduid": "89aa009685ec48e69f75505c5e62dc2f", 10:17:27 INFO - "slavebuilddir": "test" 10:17:27 INFO - } 10:17:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/YVfU2RQWS8e2B96Z_2z13w/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 10:17:27 INFO - Running post-action listener: _resource_record_post_action 10:17:27 INFO - [mozharness: 2017-02-08 18:17:27.867111Z] Finished read-buildbot-config step (success) 10:17:27 INFO - [mozharness: 2017-02-08 18:17:27.867389Z] Running download-and-extract step. 10:17:27 INFO - Running pre-action listener: _resource_record_pre_action 10:17:27 INFO - Running main action method: download_and_extract 10:17:27 INFO - mkdir: /builds/slave/test/build/tests 10:17:27 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')]} 10:17:27 INFO - trying https://queue.taskcluster.net/v1/task/YVfU2RQWS8e2B96Z_2z13w/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 10:17:27 INFO - Downloading https://queue.taskcluster.net/v1/task/YVfU2RQWS8e2B96Z_2z13w/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 10:17:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YVfU2RQWS8e2B96Z_2z13w/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 10:17:29 INFO - Downloaded 1165 bytes. 10:17:29 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 10:17:29 INFO - Using the following test package requirements: 10:17:29 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 10:17:29 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:17:29 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 10:17:29 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:17:29 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 10:17:29 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 10:17:29 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:17:29 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 10:17:29 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 10:17:29 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:17:29 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 10:17:29 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:17:29 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 10:17:29 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:17:29 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 10:17:29 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:17:29 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 10:17:29 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 10:17:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YVfU2RQWS8e2B96Z_2z13w/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 10:17:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YVfU2RQWS8e2B96Z_2z13w/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 10:17:29 INFO - Fetch https://queue.taskcluster.net/v1/task/YVfU2RQWS8e2B96Z_2z13w/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 10:17:29 INFO - Http code: 200 10:17:29 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 10:17:29 INFO - x-amz-cf-id: oZ8n_6Fyr1DTyrVHSSy6Tk_slLjmzdZzbNwNxTAUs501EphDrzeqgQ== 10:17:29 INFO - x-amz-version-id: RbZQwQmyBxrllH6y.B.Yb7atMual.4md 10:17:30 INFO - Expected file size: 16093018 10:17:30 INFO - Obtained file size: 16093018 10:17:36 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 10:17:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YVfU2RQWS8e2B96Z_2z13w/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 10:17:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YVfU2RQWS8e2B96Z_2z13w/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 10:17:36 INFO - Fetch https://queue.taskcluster.net/v1/task/YVfU2RQWS8e2B96Z_2z13w/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 10:17:37 INFO - Http code: 200 10:17:37 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 10:17:37 INFO - x-amz-cf-id: ckpZEA23BsZ3kxt0pyoW8LGyr3JZ88rV6XgSE-hSdpgMAWSjyuXsFw== 10:17:37 INFO - x-amz-version-id: RbZQwQmyBxrllH6y.B.Yb7atMual.4md 10:17:37 INFO - Expected file size: 16093018 10:17:37 INFO - Obtained file size: 16093018 10:17:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YVfU2RQWS8e2B96Z_2z13w/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 10:17:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YVfU2RQWS8e2B96Z_2z13w/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 10:17:44 INFO - Fetch https://queue.taskcluster.net/v1/task/YVfU2RQWS8e2B96Z_2z13w/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 10:17:44 INFO - Http code: 200 10:17:44 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 10:17:44 INFO - x-amz-cf-id: ZuTJYSIgWk_oGmqmgrRQ8CfTo14tEv_UZx0uRP3zDIPfjrYtyCoong== 10:17:44 INFO - x-amz-version-id: _h4HewBErjhIo7LIgqyqdLqBYI4oX7s2 10:17:45 INFO - Expected file size: 14403005 10:17:45 INFO - Obtained file size: 14403005 10:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:45 INFO - trying https://queue.taskcluster.net/v1/task/YVfU2RQWS8e2B96Z_2z13w/artifacts/public/build/firefox-52.0.en-US.mac.dmg 10:17:45 INFO - Downloading https://queue.taskcluster.net/v1/task/YVfU2RQWS8e2B96Z_2z13w/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 10:17:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YVfU2RQWS8e2B96Z_2z13w/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 10:17:47 INFO - Downloaded 82140622 bytes. 10:17:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YVfU2RQWS8e2B96Z_2z13w/artifacts/public/build/firefox-52.0.en-US.mac.dmg 10:17:47 INFO - mkdir: /builds/slave/test/properties 10:17:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:17:47 INFO - Writing to file /builds/slave/test/properties/build_url 10:17:47 INFO - Contents: 10:17:47 INFO - build_url:https://queue.taskcluster.net/v1/task/YVfU2RQWS8e2B96Z_2z13w/artifacts/public/build/firefox-52.0.en-US.mac.dmg 10:17:48 INFO - Running post-action listener: _resource_record_post_action 10:17:48 INFO - Running post-action listener: set_extra_try_arguments 10:17:48 INFO - [mozharness: 2017-02-08 18:17:48.537253Z] Finished download-and-extract step (success) 10:17:48 INFO - [mozharness: 2017-02-08 18:17:48.537389Z] Running populate-webroot step. 10:17:48 INFO - Running pre-action listener: _resource_record_pre_action 10:17:48 INFO - Running main action method: populate_webroot 10:17:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:17:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:17:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:17:48 INFO - '--tppagecycles', 10:17:48 INFO - '7'], 10:17:48 INFO - 'tests': ['tsvgm']}}, 10:17:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:17:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:17:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:17:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:17:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:17:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:17:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:48 INFO - 'talos_options': ['--disable-e10s'], 10:17:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:17:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:17:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:48 INFO - 'talos_options': ['--disable-e10s'], 10:17:48 INFO - 'tests': ['damp', 'tps']}, 10:17:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:48 INFO - 'tests': ['damp', 'tps']}, 10:17:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:17:48 INFO - 'tests': ['dromaeo_dom']}, 10:17:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:17:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:17:48 INFO - 'tests': ['basic_compositor_video']}, 10:17:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:17:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:17:48 INFO - 'tests': ['a11yr', 10:17:48 INFO - 'ts_paint', 10:17:48 INFO - 'tpaint', 10:17:48 INFO - 'sessionrestore', 10:17:48 INFO - 'sessionrestore_no_auto_restore', 10:17:48 INFO - 'tabpaint']}, 10:17:48 INFO - 'other-e10s': {'tests': ['a11yr', 10:17:48 INFO - 'ts_paint', 10:17:48 INFO - 'tpaint', 10:17:48 INFO - 'sessionrestore', 10:17:48 INFO - 'sessionrestore_no_auto_restore', 10:17:48 INFO - 'tabpaint']}, 10:17:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:17:48 INFO - 'ts_paint', 10:17:48 INFO - 'tpaint', 10:17:48 INFO - 'sessionrestore', 10:17:48 INFO - 'sessionrestore_no_auto_restore', 10:17:48 INFO - 'tabpaint']}, 10:17:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:17:48 INFO - 'ts_paint', 10:17:48 INFO - 'tpaint', 10:17:48 INFO - 'sessionrestore', 10:17:48 INFO - 'sessionrestore_no_auto_restore', 10:17:48 INFO - 'tabpaint']}, 10:17:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:17:48 INFO - 'tests': ['a11yr', 10:17:48 INFO - 'ts_paint', 10:17:48 INFO - 'tpaint', 10:17:48 INFO - 'sessionrestore', 10:17:48 INFO - 'sessionrestore_no_auto_restore', 10:17:48 INFO - 'tabpaint']}, 10:17:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:17:48 INFO - 'tests': ['a11yr', 10:17:48 INFO - 'ts_paint', 10:17:48 INFO - 'tpaint', 10:17:48 INFO - 'sessionrestore', 10:17:48 INFO - 'sessionrestore_no_auto_restore', 10:17:48 INFO - 'tabpaint']}, 10:17:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:17:48 INFO - 'tests': ['tsvgx', 10:17:48 INFO - 'tsvgr_opacity', 10:17:48 INFO - 'tart', 10:17:48 INFO - 'tscrollx', 10:17:48 INFO - 'cart']}, 10:17:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:17:48 INFO - 'tsvgr_opacity', 10:17:48 INFO - 'tart', 10:17:48 INFO - 'tscrollx', 10:17:48 INFO - 'cart']}, 10:17:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:48 INFO - 'talos_options': ['--disable-e10s'], 10:17:48 INFO - 'tests': ['tp5o']}, 10:17:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:48 INFO - 'tests': ['tp5o']}, 10:17:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:48 INFO - 'talos_options': ['--disable-e10s', 10:17:48 INFO - '--xperf_path', 10:17:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:17:48 INFO - 'tests': ['tp5n']}, 10:17:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:48 INFO - 'talos_options': ['--xperf_path', 10:17:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:17:48 INFO - 'tests': ['tp5n']}}, 10:17:48 INFO - 'talos.zip': {'path': '', 10:17:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:17:48 INFO - Running post-action listener: _resource_record_post_action 10:17:48 INFO - [mozharness: 2017-02-08 18:17:48.556129Z] Finished populate-webroot step (success) 10:17:48 INFO - [mozharness: 2017-02-08 18:17:48.556257Z] Running create-virtualenv step. 10:17:48 INFO - Running pre-action listener: _resource_record_pre_action 10:17:48 INFO - Running main action method: create_virtualenv 10:17:48 INFO - Creating virtualenv /builds/slave/test/build/venv 10:17:48 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 10:17:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:17:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:17:48 INFO - Using real prefix '/tools/python27' 10:17:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:17:49 INFO - Installing distribute.............................................................................................................................................................................................done. 10:17:52 INFO - Installing pip.................done. 10:17:52 INFO - Return code: 0 10:17:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:17:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:17:52 INFO - Reading from file tmpfile_stdout 10:17:52 INFO - Output received: 10:17:52 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) 10:17:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106a26490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10699c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbba4bfdf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10683ad30>, '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 0x1066a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106832b20>, '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.H4MRWBmwHz/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.vioC8pMRPo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 10:17:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:17:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:17:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H4MRWBmwHz/Render', 10:17:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:52 INFO - 'HOME': '/Users/cltbld', 10:17:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:52 INFO - 'LOGNAME': 'cltbld', 10:17:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:52 INFO - 'MOZ_NO_REMOTE': '1', 10:17:52 INFO - 'NO_EM_RESTART': '1', 10:17:52 INFO - 'PAGER': '/bin/cat', 10:17:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:52 INFO - 'PWD': '/builds/slave/test', 10:17:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:52 INFO - 'SHELL': '/bin/bash', 10:17:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vioC8pMRPo/Listeners', 10:17:52 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 10:17:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:52 INFO - 'USER': 'cltbld', 10:17:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:52 INFO - 'XPC_FLAGS': '0x0', 10:17:52 INFO - 'XPC_SERVICE_NAME': '0', 10:17:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:52 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 10:17:52 INFO - Cleaning up... 10:17:52 INFO - Return code: 0 10:17:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106a26490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10699c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbba4bfdf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10683ad30>, '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 0x1066a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106832b20>, '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.H4MRWBmwHz/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.vioC8pMRPo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 10:17:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:17:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:17:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H4MRWBmwHz/Render', 10:17:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:52 INFO - 'HOME': '/Users/cltbld', 10:17:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:52 INFO - 'LOGNAME': 'cltbld', 10:17:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:52 INFO - 'MOZ_NO_REMOTE': '1', 10:17:52 INFO - 'NO_EM_RESTART': '1', 10:17:52 INFO - 'PAGER': '/bin/cat', 10:17:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:52 INFO - 'PWD': '/builds/slave/test', 10:17:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:52 INFO - 'SHELL': '/bin/bash', 10:17:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vioC8pMRPo/Listeners', 10:17:52 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 10:17:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:52 INFO - 'USER': 'cltbld', 10:17:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:52 INFO - 'XPC_FLAGS': '0x0', 10:17:52 INFO - 'XPC_SERVICE_NAME': '0', 10:17:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:53 INFO - Downloading/unpacking psutil>=3.1.1 10:17:53 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 10:17:53 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 10:17:53 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 10:17:53 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 10:17:53 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 10:17:53 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 10:17:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:17:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:17:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:17:56 INFO - Installing collected packages: psutil 10:17:56 INFO - Running setup.py install for psutil 10:17:56 INFO - building 'psutil._psutil_osx' extension 10:17:56 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 10:17:57 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 10:17:57 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 10:17:57 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 10:17:57 INFO - building 'psutil._psutil_posix' extension 10:17:57 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 10:17:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:17:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:17:57 INFO - ^ 10:17:57 INFO - 1 warning generated. 10:17:57 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 10:17:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:17:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:17:57 INFO - Successfully installed psutil 10:17:57 INFO - Cleaning up... 10:17:58 INFO - Return code: 0 10:17:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:17: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')]} 10:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17: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')]} 10:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106a26490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10699c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbba4bfdf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10683ad30>, '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 0x1066a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106832b20>, '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.H4MRWBmwHz/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.vioC8pMRPo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 10:17: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:17: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 mozsystemmonitor==0.3 10:17:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H4MRWBmwHz/Render', 10:17:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:58 INFO - 'HOME': '/Users/cltbld', 10:17:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:58 INFO - 'LOGNAME': 'cltbld', 10:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:58 INFO - 'MOZ_NO_REMOTE': '1', 10:17:58 INFO - 'NO_EM_RESTART': '1', 10:17:58 INFO - 'PAGER': '/bin/cat', 10:17:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:58 INFO - 'PWD': '/builds/slave/test', 10:17:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:58 INFO - 'SHELL': '/bin/bash', 10:17:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vioC8pMRPo/Listeners', 10:17:58 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 10:17:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:58 INFO - 'USER': 'cltbld', 10:17:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:58 INFO - 'XPC_FLAGS': '0x0', 10:17:58 INFO - 'XPC_SERVICE_NAME': '0', 10:17:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:17:58 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 10:17:58 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 10:17:58 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 10:17:58 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 10:17:58 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 10:17:58 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 10:18:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:18:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:18:00 INFO - Installing collected packages: mozsystemmonitor 10:18:00 INFO - Running setup.py install for mozsystemmonitor 10:18:01 INFO - Successfully installed mozsystemmonitor 10:18:01 INFO - Cleaning up... 10:18:01 INFO - Return code: 0 10:18:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:18:01 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')]} 10:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:01 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')]} 10:18:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:01 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 0x106a26490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10699c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbba4bfdf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10683ad30>, '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 0x1066a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106832b20>, '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.H4MRWBmwHz/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.vioC8pMRPo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 10:18:01 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 10:18:01 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 10:18:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H4MRWBmwHz/Render', 10:18:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:18:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:18:01 INFO - 'HOME': '/Users/cltbld', 10:18:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:18:01 INFO - 'LOGNAME': 'cltbld', 10:18:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:01 INFO - 'MOZ_NO_REMOTE': '1', 10:18:01 INFO - 'NO_EM_RESTART': '1', 10:18:01 INFO - 'PAGER': '/bin/cat', 10:18:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:18:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:01 INFO - 'PWD': '/builds/slave/test', 10:18:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:18:01 INFO - 'SHELL': '/bin/bash', 10:18:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vioC8pMRPo/Listeners', 10:18:01 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 10:18:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:18:01 INFO - 'USER': 'cltbld', 10:18:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:18:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:18:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:01 INFO - 'XPC_FLAGS': '0x0', 10:18:01 INFO - 'XPC_SERVICE_NAME': '0', 10:18:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:18:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:01 INFO - Downloading/unpacking jsonschema==2.5.1 10:18: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 10:18: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 10:18: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 10:18: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 10:18: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 10:18: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 10:18:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:18:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:18:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:18:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:18:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:18:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:18:04 INFO - Downloading functools32-3.2.3-2.tar.gz 10:18:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:18:04 INFO - warning: no files found matching '*.txt' 10:18:04 INFO - no previously-included directories found matching 'build' 10:18:04 INFO - no previously-included directories found matching 'dist' 10:18:04 INFO - no previously-included directories found matching '.git*' 10:18:04 INFO - Installing collected packages: jsonschema, functools32 10:18:04 INFO - Running setup.py install for functools32 10:18:04 INFO - warning: no files found matching '*.txt' 10:18:04 INFO - no previously-included directories found matching 'build' 10:18:04 INFO - no previously-included directories found matching 'dist' 10:18:04 INFO - no previously-included directories found matching '.git*' 10:18:04 INFO - Successfully installed jsonschema functools32 10:18:04 INFO - Cleaning up... 10:18:04 INFO - Return code: 0 10:18:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:18:04 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')]} 10:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:04 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')]} 10:18:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:04 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 0x106a26490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10699c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbba4bfdf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10683ad30>, '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 0x1066a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106832b20>, '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.H4MRWBmwHz/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.vioC8pMRPo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 10:18:04 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 10:18:04 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 10:18:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H4MRWBmwHz/Render', 10:18:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:18:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:18:04 INFO - 'HOME': '/Users/cltbld', 10:18:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:18:04 INFO - 'LOGNAME': 'cltbld', 10:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:04 INFO - 'MOZ_NO_REMOTE': '1', 10:18:04 INFO - 'NO_EM_RESTART': '1', 10:18:04 INFO - 'PAGER': '/bin/cat', 10:18:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:04 INFO - 'PWD': '/builds/slave/test', 10:18:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:18:04 INFO - 'SHELL': '/bin/bash', 10:18:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vioC8pMRPo/Listeners', 10:18:04 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 10:18:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:18:04 INFO - 'USER': 'cltbld', 10:18:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:18:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:04 INFO - 'XPC_FLAGS': '0x0', 10:18:04 INFO - 'XPC_SERVICE_NAME': '0', 10:18:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:18:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:18:04 INFO - Cleaning up... 10:18:05 INFO - Return code: 0 10:18:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:05 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 0x106a26490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10699c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbba4bfdf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10683ad30>, '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 0x1066a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106832b20>, '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.H4MRWBmwHz/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.vioC8pMRPo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 10:18:05 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 10:18:05 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 10:18:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H4MRWBmwHz/Render', 10:18:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:18:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:18:05 INFO - 'HOME': '/Users/cltbld', 10:18:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:18:05 INFO - 'LOGNAME': 'cltbld', 10:18:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:05 INFO - 'MOZ_NO_REMOTE': '1', 10:18:05 INFO - 'NO_EM_RESTART': '1', 10:18:05 INFO - 'PAGER': '/bin/cat', 10:18:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:18:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:05 INFO - 'PWD': '/builds/slave/test', 10:18:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:18:05 INFO - 'SHELL': '/bin/bash', 10:18:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vioC8pMRPo/Listeners', 10:18:05 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 10:18:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:18:05 INFO - 'USER': 'cltbld', 10:18:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:18:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:18:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:05 INFO - 'XPC_FLAGS': '0x0', 10:18:05 INFO - 'XPC_SERVICE_NAME': '0', 10:18:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:18:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:05 INFO - Downloading/unpacking blobuploader==1.2.4 10:18:05 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 10:18:05 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 10:18:05 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 10:18:05 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 10:18:05 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 10:18:05 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 10:18:07 INFO - Downloading blobuploader-1.2.4.tar.gz 10:18:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:18:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:18:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:18:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:18:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:18:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:18:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:18:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:18:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:18:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:18:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:18:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:18:09 INFO - Downloading docopt-0.6.1.tar.gz 10:18:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:18:09 INFO - Installing collected packages: blobuploader, requests, docopt 10:18:09 INFO - Running setup.py install for blobuploader 10:18:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:18:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:18:09 INFO - Running setup.py install for requests 10:18:10 INFO - Running setup.py install for docopt 10:18:10 INFO - Successfully installed blobuploader requests docopt 10:18:10 INFO - Cleaning up... 10:18:10 INFO - Return code: 0 10:18:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:18:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:10 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 0x106a26490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10699c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbba4bfdf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10683ad30>, '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 0x1066a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106832b20>, '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.H4MRWBmwHz/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.vioC8pMRPo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 10:18:10 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 10:18:10 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 10:18:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H4MRWBmwHz/Render', 10:18:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:18:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:18:10 INFO - 'HOME': '/Users/cltbld', 10:18:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:18:10 INFO - 'LOGNAME': 'cltbld', 10:18:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:10 INFO - 'MOZ_NO_REMOTE': '1', 10:18:10 INFO - 'NO_EM_RESTART': '1', 10:18:10 INFO - 'PAGER': '/bin/cat', 10:18:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:18:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:10 INFO - 'PWD': '/builds/slave/test', 10:18:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:18:10 INFO - 'SHELL': '/bin/bash', 10:18:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vioC8pMRPo/Listeners', 10:18:10 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 10:18:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:18:10 INFO - 'USER': 'cltbld', 10:18:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:18:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:18:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:10 INFO - 'XPC_FLAGS': '0x0', 10:18:10 INFO - 'XPC_SERVICE_NAME': '0', 10:18:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:18:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:18:10 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-deZwfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:18:10 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-S3yEEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:18:10 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-0bZLLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:18:10 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-y0gPvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:18:10 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-yRTF64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:18:11 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-U481iQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:18:11 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-_qDNUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:18:11 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-oaBBii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:18:11 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-IxmrUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:18:11 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-DwgQNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:18:11 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-L88lUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:18:11 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-ixOKT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:18:11 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-dqvJpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:18:11 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-JiW29H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:18:12 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-gnhrIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:18:12 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-pPfylC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:18:12 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-4pxAe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:18:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:18:12 INFO - Running setup.py install for manifestparser 10:18:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:18:12 INFO - Running setup.py install for mozcrash 10:18:12 INFO - Running setup.py install for mozdebug 10:18:12 INFO - Running setup.py install for mozdevice 10:18:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:18:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:18:12 INFO - Running setup.py install for mozfile 10:18:13 INFO - Running setup.py install for mozhttpd 10:18:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:18:13 INFO - Running setup.py install for mozinfo 10:18:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:18:13 INFO - Running setup.py install for mozInstall 10:18:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:18:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:18:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:18:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:18:13 INFO - Running setup.py install for mozleak 10:18:13 INFO - Running setup.py install for mozlog 10:18:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:18:13 INFO - Running setup.py install for moznetwork 10:18:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:18:13 INFO - Running setup.py install for mozprocess 10:18:14 INFO - Running setup.py install for mozprofile 10:18:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:18:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:18:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:18:14 INFO - Running setup.py install for mozrunner 10:18:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:18:14 INFO - Running setup.py install for mozscreenshot 10:18:14 INFO - Running setup.py install for moztest 10:18:14 INFO - Running setup.py install for mozversion 10:18:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:18:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:18:14 INFO - Cleaning up... 10:18:14 INFO - Return code: 0 10:18:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:18: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')]} 10:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:15 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 0x106a26490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10699c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbba4bfdf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10683ad30>, '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 0x1066a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106832b20>, '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.H4MRWBmwHz/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.vioC8pMRPo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 10:18:15 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 10:18:15 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 10:18:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H4MRWBmwHz/Render', 10:18:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:18:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:18:15 INFO - 'HOME': '/Users/cltbld', 10:18:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:18:15 INFO - 'LOGNAME': 'cltbld', 10:18:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:15 INFO - 'MOZ_NO_REMOTE': '1', 10:18:15 INFO - 'NO_EM_RESTART': '1', 10:18:15 INFO - 'PAGER': '/bin/cat', 10:18:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:18:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:15 INFO - 'PWD': '/builds/slave/test', 10:18:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:18:15 INFO - 'SHELL': '/bin/bash', 10:18:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vioC8pMRPo/Listeners', 10:18:15 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 10:18:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:18:15 INFO - 'USER': 'cltbld', 10:18:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:18:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:18:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:15 INFO - 'XPC_FLAGS': '0x0', 10:18:15 INFO - 'XPC_SERVICE_NAME': '0', 10:18:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:18:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:18:15 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-cHCV9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:18:16 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)) 10:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:18:16 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-MG5lum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:18:16 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)) 10:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:18:16 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-WCgPAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:18:16 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)) 10:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:18:16 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-C8Alur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:18:16 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)) 10:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:18:16 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-EvXR6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:18:16 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)) 10:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:18:16 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-o966nP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:18:16 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)) 10:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:18:16 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-11ZOR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:18:16 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)) 10:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:18:16 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-oaFzdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:18:16 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)) 10:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:18:16 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-AXlDQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:18:16 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)) 10:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:18:16 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-ZuKR0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:18:17 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)) 10:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:18:17 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-rDjdQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:18:17 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)) 10:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:18:17 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-MSw1eH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:18:17 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)) 10:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:18:17 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-VBkE1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:18:17 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)) 10:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:18:17 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-_9Rmv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:18:17 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)) 10:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:18:17 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-Z93qNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:18:17 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)) 10:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:18:17 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-ZCqnHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:18:17 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)) 10:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:18:17 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-w7KIGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:18:17 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)) 10:18:17 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)) 10:18:17 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)) 10:18:17 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)) 10:18:17 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)) 10:18:17 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)) 10:18:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:18:17 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 10:18:17 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 10:18:17 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 10:18:17 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 10:18:17 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 10:18:17 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 10:18:20 INFO - Downloading blessings-1.6.tar.gz 10:18:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:18:20 INFO - Installing collected packages: blessings 10:18:20 INFO - Running setup.py install for blessings 10:18:21 INFO - Successfully installed blessings 10:18:21 INFO - Cleaning up... 10:18:21 INFO - Return code: 0 10:18:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:18:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:18:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:18:21 INFO - Reading from file tmpfile_stdout 10:18:21 INFO - Current package versions: 10:18:21 INFO - blessings == 1.6 10:18:21 INFO - blobuploader == 1.2.4 10:18:21 INFO - docopt == 0.6.1 10:18:21 INFO - functools32 == 3.2.3-2 10:18:21 INFO - jsonschema == 2.5.1 10:18:21 INFO - manifestparser == 1.1 10:18:21 INFO - mozInstall == 1.12 10:18:21 INFO - mozcrash == 1.0 10:18:21 INFO - mozdebug == 0.1 10:18:21 INFO - mozdevice == 0.48 10:18:21 INFO - mozfile == 1.2 10:18:21 INFO - mozhttpd == 0.7 10:18:21 INFO - mozinfo == 0.9 10:18:21 INFO - mozleak == 0.1 10:18:21 INFO - mozlog == 3.4 10:18:21 INFO - moznetwork == 0.27 10:18:21 INFO - mozprocess == 0.23 10:18:21 INFO - mozprofile == 0.28 10:18:21 INFO - mozrunner == 6.13 10:18:21 INFO - mozscreenshot == 0.1 10:18:21 INFO - mozsystemmonitor == 0.3 10:18:21 INFO - moztest == 0.8 10:18:21 INFO - mozversion == 1.4 10:18:21 INFO - psutil == 3.1.1 10:18:21 INFO - requests == 1.2.3 10:18:21 INFO - wsgiref == 0.1.2 10:18:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:18:21 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')]} 10:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:21 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')]} 10:18:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:21 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 0x106a26490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10699c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbba4bfdf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10683ad30>, '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 0x1066a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106832b20>, '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.H4MRWBmwHz/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.vioC8pMRPo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 10:18:21 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 10:18:21 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 10:18:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H4MRWBmwHz/Render', 10:18:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:18:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:18:21 INFO - 'HOME': '/Users/cltbld', 10:18:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:18:21 INFO - 'LOGNAME': 'cltbld', 10:18:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:21 INFO - 'MOZ_NO_REMOTE': '1', 10:18:21 INFO - 'NO_EM_RESTART': '1', 10:18:21 INFO - 'PAGER': '/bin/cat', 10:18:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:18:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:21 INFO - 'PWD': '/builds/slave/test', 10:18:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:18:21 INFO - 'SHELL': '/bin/bash', 10:18:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vioC8pMRPo/Listeners', 10:18:21 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 10:18:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:18:21 INFO - 'USER': 'cltbld', 10:18:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:18:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:18:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:21 INFO - 'XPC_FLAGS': '0x0', 10:18:21 INFO - 'XPC_SERVICE_NAME': '0', 10:18:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:18:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:21 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)) 10:18:21 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)) 10:18:21 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)) 10:18:21 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)) 10:18:21 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)) 10:18:21 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)) 10:18:21 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)) 10:18:21 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)) 10:18:21 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)) 10:18:21 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)) 10:18:21 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)) 10:18:21 INFO - Cleaning up... 10:18:21 INFO - Return code: 0 10:18:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:18:21 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')]} 10:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:21 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')]} 10:18:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:21 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 0x106a26490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10699c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbba4bfdf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10683ad30>, '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 0x1066a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106832b20>, '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.H4MRWBmwHz/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.vioC8pMRPo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 10:18:21 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 10:18:21 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 10:18:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H4MRWBmwHz/Render', 10:18:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:18:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:18:21 INFO - 'HOME': '/Users/cltbld', 10:18:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:18:21 INFO - 'LOGNAME': 'cltbld', 10:18:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:21 INFO - 'MOZ_NO_REMOTE': '1', 10:18:21 INFO - 'NO_EM_RESTART': '1', 10:18:21 INFO - 'PAGER': '/bin/cat', 10:18:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:18:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:21 INFO - 'PWD': '/builds/slave/test', 10:18:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:18:21 INFO - 'SHELL': '/bin/bash', 10:18:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vioC8pMRPo/Listeners', 10:18:21 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 10:18:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:18:21 INFO - 'USER': 'cltbld', 10:18:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:18:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:18:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:21 INFO - 'XPC_FLAGS': '0x0', 10:18:21 INFO - 'XPC_SERVICE_NAME': '0', 10:18:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:18:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:18:22 INFO - Cleaning up... 10:18:22 INFO - Return code: 0 10:18:22 INFO - Running post-action listener: _resource_record_post_action 10:18:22 INFO - Running post-action listener: _start_resource_monitoring 10:18:22 INFO - Starting resource monitoring. 10:18:22 INFO - [mozharness: 2017-02-08 18:18:22.050893Z] Finished create-virtualenv step (success) 10:18:22 INFO - [mozharness: 2017-02-08 18:18:22.051780Z] Running install step. 10:18:22 INFO - Running pre-action listener: _resource_record_pre_action 10:18:22 INFO - Running main action method: install 10:18:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:18:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:18:22 INFO - Reading from file tmpfile_stdout 10:18:22 INFO - Detecting whether we're running mozinstall >=1.0... 10:18:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:18:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:18:22 INFO - Reading from file tmpfile_stdout 10:18:22 INFO - Output received: 10:18:22 INFO - Usage: mozinstall [options] installer 10:18:22 INFO - Options: 10:18:22 INFO - -h, --help show this help message and exit 10:18:22 INFO - -d DEST, --destination=DEST 10:18:22 INFO - Directory to install application into. [default: 10:18:22 INFO - "/builds/slave/test"] 10:18:22 INFO - --app=APP Application being installed. [default: firefox] 10:18:22 INFO - mkdir: /builds/slave/test/build/application 10:18:22 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'] 10:18:22 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 10:18:43 INFO - Reading from file tmpfile_stdout 10:18:43 INFO - Output received: 10:18:43 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:18:43 INFO - Running post-action listener: _resource_record_post_action 10:18:43 INFO - [mozharness: 2017-02-08 18:18:43.765266Z] Finished install step (success) 10:18:43 INFO - [mozharness: 2017-02-08 18:18:43.765437Z] Running run-tests step. 10:18:43 INFO - Running pre-action listener: _resource_record_pre_action 10:18:43 INFO - Running main action method: run_tests 10:18:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:18:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:18:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:18:43 INFO - 2017-02-08 10:18:43.780 screenresolution[1625:7305] starting screenresolution argv=screenresolution get 10:18:43 INFO - 2017-02-08 10:18:43.782 screenresolution[1625:7305] Display 0: 1600x1200x32@60 10:18:43 INFO - 2017-02-08 10:18:43.788 screenresolution[1626:7307] starting screenresolution argv=screenresolution list 10:18:43 INFO - Available Modes on Display 0 10:18:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:18:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:18:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:18:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:18:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:18:44 INFO - Intel Iris: 10:18:44 INFO - Chipset Model: Intel Iris 10:18:44 INFO - Type: GPU 10:18:44 INFO - Bus: Built-In 10:18:44 INFO - VRAM (Dynamic, Max): 1536 MB 10:18:44 INFO - Vendor: Intel (0x8086) 10:18:44 INFO - Device ID: 0x0a2e 10:18:44 INFO - Revision ID: 0x0009 10:18:44 INFO - Displays: 10:18:44 INFO - Display: 10:18:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:18:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:18:44 INFO - Display Serial Number: 1600x1200 60 10:18:44 INFO - Main Display: Yes 10:18:44 INFO - Mirror: Off 10:18:44 INFO - Online: Yes 10:18:44 INFO - Rotation: Supported 10:18:44 INFO - Return code: 0 10:18:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:18:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:18:44 INFO - Python 2.7.3 10:18:44 INFO - Return code: 0 10:18:44 INFO - grabbing minidump binary from tooltool 10:18:44 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')]} 10:18:44 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 0x10683ad30>, '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 0x1066a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106832b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:18:44 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 10:18:44 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 10:18:44 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 10:18:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:18:44 INFO - Return code: 0 10:18:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:18:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:18:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:18:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:18:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:18:44 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/YVfU2RQWS8e2B96Z_2z13w/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0062', '--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 10:18:44 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/YVfU2RQWS8e2B96Z_2z13w/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0062 --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 10:18:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H4MRWBmwHz/Render', 10:18:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:18:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:18:44 INFO - 'HOME': '/Users/cltbld', 10:18:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:18:44 INFO - 'LOGNAME': 'cltbld', 10:18:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:18:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:18:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:44 INFO - 'MOZ_NO_REMOTE': '1', 10:18:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:18:44 INFO - 'NO_EM_RESTART': '1', 10:18:44 INFO - 'PAGER': '/bin/cat', 10:18:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:18:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:44 INFO - 'PWD': '/builds/slave/test', 10:18:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:18:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:18:44 INFO - 'SHELL': '/bin/bash', 10:18:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vioC8pMRPo/Listeners', 10:18:44 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 10:18:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:18:44 INFO - 'USER': 'cltbld', 10:18:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:18:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:18:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:44 INFO - 'XPC_FLAGS': '0x0', 10:18:44 INFO - 'XPC_SERVICE_NAME': '0', 10:18:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:18:44 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/YVfU2RQWS8e2B96Z_2z13w/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0062', '--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 10:18:44 INFO - mozversion application_buildid: 20170208075457 10:18:44 INFO - mozversion application_changeset: 8b510eefa687ab18725e2c7abce570488d1e1825 10:18:44 INFO - mozversion application_display_name: Firefox 10:18:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:18:44 INFO - mozversion application_name: Firefox 10:18:44 INFO - mozversion application_remotingname: firefox 10:18:44 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:18:44 INFO - mozversion application_vendor: Mozilla 10:18:44 INFO - mozversion application_version: 52.0 10:18:44 INFO - mozversion platform_buildid: 20170208075457 10:18:44 INFO - mozversion platform_changeset: 8b510eefa687ab18725e2c7abce570488d1e1825 10:18:44 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:18:44 INFO - mozversion platform_version: 52.0 10:18:44 INFO - using testdate: 1486577924 10:18:44 INFO - actual date: 1486577924 10:18:44 INFO - starting webserver on 'localhost:49236' 10:18:44 INFO - SUITE-START | Running 2 tests 10:18:44 INFO - TEST-START | dromaeo_css 10:18:44 INFO - operating with platform_type : mac_ 10:18:44 INFO - Initialising browser for dromaeo_css test... 10:18:44 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpXpm6eb/profile http://localhost:49236/getInfo.html) 10:18:47 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 10:18:47 INFO - PROCESS | 1636 | colorDepth:24 10:18:47 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 10:18:47 INFO - PROCESS | 1636 | __metrics 10:18:47 INFO - PROCESS | 1636 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:18:47 INFO - PROCESS | 1636 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:18:47 INFO - TEST-INFO | 1636: exit 0 10:18:47 INFO - Browser initialized. 10:18:47 INFO - Running cycle 1/1 for dromaeo_css test... 10:18:47 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpXpm6eb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:19:00 INFO - PROCESS | 1639 | RSS: Main: 171659264 10:19:00 INFO - PROCESS | 1639 | 10:22:03 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 10:22:05 INFO - PROCESS | 1639 | RSS: Main: 274235392 10:22:05 INFO - PROCESS | 1639 | 10:25:07 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 10:25:08 INFO - PROCESS | 1639 | RSS: Main: 295886848 10:25:08 INFO - PROCESS | 1639 | 10:28:10 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 10:28:11 INFO - PROCESS | 1639 | RSS: Main: 265199616 10:28:11 INFO - PROCESS | 1639 | 10:31:13 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 10:31:14 INFO - PROCESS | 1639 | RSS: Main: 262860800 10:31:14 INFO - PROCESS | 1639 | 10:34:17 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 10:34:18 INFO - PROCESS | 1639 | RSS: Main: 253382656 10:34:18 INFO - PROCESS | 1639 | 10:37:21 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 10:37:21 INFO - PROCESS | 1639 | RSS: Main: 367718400 10:37:21 INFO - PROCESS | 1639 | 10:37:21 INFO - PROCESS | 1639 | __start_tp_report 10:37:21 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 10:37:21 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 10:37:21 INFO - PROCESS | 1639 | |i|pagename|runs| 10:37:21 INFO - PROCESS | 1639 | |0;dojo.html;3179.7297229735473;3489.6684814942573;3503.649635036497;3504.439289713645;3566.8216589170534;5669.546436285098;5670.149477578355;5684.829455116343;5688.658680479169;5725.685087320196;5630.577706671996;5664.40523745007;5756.625819321741;5758.712064396785;5785.797497087592;4575.382323386342;4648.65135114866;5221.530062294392;5284.709340986245;5302.045631786277;5162.6128040397125;5170.974145129269;5180.611454140936;5344.625876188668;5364.249005139283;5232.973835130838;5243.213517972296;5261.394939581959;5286.995470860544;5296.152615581508;4542.159700455426;5079.263506791532;5245.606579506514;5249.973750131263;5259.474052594748;5150.227465880148;5243.292155558989;5249.317588713481;5270.631055826094;5297.073012222884;5579.7489112990015;5582.748776305076;5649.067903795869;5650.802221922254;5736.3403208631125;5386.407495175527;6149.893019256532;6198.411150940653;6207.441330280297;6236.656983865885;6320.494360451153;6321.87356252877;6341.492680585542;6360.045993101072;6366.93633063668;5669.858253543694;5728.627639203439;5766.826995190151;5846.678432686201;5878.29460464747;6287.622742635456;6295.496360291166;6302.149209856702;6313.084602732578;6319.115323854664;6177.938220617736;6200.534959877937;6202.689865506707;6213.96893015532;6225.315215326311;6139.952147135068;6209.192804935329;6213.285472170668;6271.905921411182;6293.937060629427;6195.81412557624;6267.185265915402;6278.560500764903;6279.717412716439;6284.968575157095;6258.15514905491;6277.027060805583;6278.30938596754;6304.905426418607;6305.936940630627;4852.393450818648;4898;4939.0121975605025;4956.281339205795;4980.12847751642;4477.306017567283;4496.325551167286;4496.685232033727;4504.436945381827;4542.613877820356;5732.856678582985;5770;5841;5848.210491583582;5878.118282257696;6252.781152659635;6334.493240540745;6343.777967771106;6353.650549219838;6358.77744278948;5637.774489020393;5659.915101273402;5671.376148623648;5705.686187259741;5730.398308177665;5378;5408.999335123015;5418.810341638024;5419.3225846769155;5425.403205647375;6337.524685648503;6338.492920566436;6346.365363463617;6350.110984462087;6361.14124593174;6140.62695141751;6147.954847675816;6227.750889964351;6306.369363063657;6312.084747711464;5114.2840002400435;6310.211223597051;6328.936710632835;6329.968350158404;6339.2392912850755;6269.153664255449;6271.905921411274;6286.622802631857;6287.339829317856;6302.495800335871;6142.78500252489;6148.50811935053;6181.227346581677;6278.497720182283;6315.463185629273;6120.785772497941;6146.231721034871;6171.321154673072;6181.041938499539;6183.505319574333;6148.9692551536955;6152.261728592419;6167.537434692326;6173.475254603409;6180.5673602849165;5689.175069614966;5773.7979170730505;5897.587168898308;6009.158717779427;6062.514998800174;6126.509879209563;6134.803982731443;6145.924463219008;6148.139260503443;6153.323134455296;5863.530917526673;5956.940430595639;6015.759369625166;6017.669028203491;6050.5764596479585 10:37:21 INFO - PROCESS | 1639 | |1;ext.html;492.3033907021565;512.8615273876052;514.6577525945247;518.8235999760082;535.3335097803235;30822.38355232894;40993.38509922354;41066.58933410665;41079;41130.9717257068;41824.790876045656;42399.36400953988;42409.93975150623;42447;42473.575264247345;8828.117188281152;9025.368224224307;9493.24054075674;9675.080867317594;9712.708618741413;11529.769404611945;11819.172657913949;11831.7633647327;12088.697782555419;12093.09301802364;11907.285562866256;11954;11971.521139154424;11981.64055078349;11991.40042997851;11783.998360139398;11856.110791690615;11861.52553897843;11868.643940681706;11868.703282417922;11676.416179191006;11756.1182911282;11758;11763.823542646782;11774.646760597196;41119.588804111874;41450.79274603638;41465.58534414647;41493.792531037456;41553.584464155276;3255.8209298488573;3417.2994536120286;3780.7353485256044;3957.881263562098;3996.6003399660094;28465.85767071172;29587.40825183506;29613.407731845244;30658;31706.365872682647;3304.322613864152;3339.081752518053;3359.059463350266;3486.3724529584665;3489.476578513243;496289;500773;500959;503131;503682;34208.315833683184;35115.122121946646;59164.7041764797;59540.404595953485;59678.701606492556;35626;35880.820595896854;35895.4615680765;35896.641033589854;35949;15370.077795332316;15585.064896106043;15589.142597157264;15589.986650867657;15603.219839008005;11943.223690460092;12160.087993400353;12723.681907952376;12992.220466772023;13034.674133146747;7993.800154996055;7995.040595128506;8018.118007019223;8067.798305042304;8088.878666820003;3303.900882973515;3347.0293614851907;3355.094124586348;3369;3386.6444023377685;924.856647219682;940.6566603189787;980.7842274699555;1000.364768372089;1062.2723434447428;29888;30044.699553004626;30536;30664.38671226563;30771.230719232197;1086.1039642295138;1093.9726506837392;1105.0217874124876;1174.6769638349522;1200.7298357869583;15475.613109672347;15837;15891.523254302389;15892.60268493297;16242.918785405996;699084;701322;701866;702392;702702;59402.405975939684;59760.402395975485;59763.701181493816;59817.700911495165;59833.10250346248;1263.5830176041884;1304.5825335892423;1386.778115501515;1412.6538997945363;1426.7431862264891;23279;27164.777585009117;27191.86404067967;27623.861880690467;28152.43695126127;47703;48221.27668085052;48267.75866120647;48313.27530087122;48514;577377;578626;579168.1041594765;581318;771454;23786.40533986664;26083.869580651975;26800.865995669898;26816.32959176036;27393.726062739916;45997.54002459932;46089.76955115203;46640.76679616716;46800;47138.05723885572;36186;38138.237235254586;38823;38874.80562597282;38904.6109538901;37604.247915041;38313.233735325695;38414.615853842224;39702.40446393364;39779.40330894981;33981.49027764536;38433.807830960664;39139.804300978314;39246;39349.2130157401;31910.84044579762;34136.31727365389;34503.4824477628;34812.65187348094;35020.47469288014;25604.615930761425;25765.484690306464;25872.353191170372;26425.735742642326;26431.471370572097 10:37:21 INFO - PROCESS | 1639 | |2;jquery.html;339.87764404814266;389.06430035764;397.9820908059138;408.004469095407;418.9204051230266;19372;21077.863449322846;21590.676139857896;21870;22056.117755289808;20686;21131.47171320718;21279.14883404662;21618.459538511546;21755.782442175572;5736.819306622585;6099.664518451484;6099.756009759604;6141.6007959482495;6144.44699977002;4331.588499092597;4450.4881938577155;6044;6149.415805498493;6165.3834616538215;4585.931211031837;4645.6980296280635;6905.689243984033;6914.170299564059;6930.099087118668;5861.941380586182;6173.166622505949;6885.896711549331;6891.965540172292;6892;6109.755609775603;6111.327753947106;6120.755169793248;6126.111713801474;6135.294441139237;11639.418029098511;13710.725785484334;14158;14198.432062717478;14210.786838197435;2328.6507023946374;2424.648425978241;2631.0396705202656;3030.5151175811766;3083.383323335342;10278.331908426004;10815.67552973412;10835.458227088693;10849.945750271278;12829.294388808612;1758.3142574395995;1890.6785846406005;1907.50404894727;2007.3375785990588;2048.95902081959;117412.8258717419;123780.38109809483;131003;132512.0369583371;133308;10652.786944261072;10947.34315941046;11056.889431105747;11502.712432189095;11884.940575297242;14975.32611032506;14984;15012.474563390448;15023.924880375747;15027.849721502864;6531.477481801445;7324.816879578053;8781.07798681142;8848;8995.010548839622;7067.5052746307265;8549.102344253888;8749.956250218707;8818.5590720465;8938.016818149998;4573.565511276423;4662.207424737802;4693.624510039189;4733.242681170997;4793.976030119897;1915.1094740945528;1977.7428934238744;1981.4154824326858;1981.5937732764748;1986.9503262418555;808.2662688533181;914.5472990869429;914.7118657622827;1012.0587853296357;1031.3554028732042;21640.783592164193;22049.78726170076;22152.003159857846;22155.55688886213;22267.109315627516;784.2275358771606;841.7306461932122;908.5139450394007;967.2213867836318;1019.4911530934259;10925.399103049409;11400.429978501043;11537.88462115368;11582.783807700238;11588.072954163647;600618;604596;609857;616976;618833;82274.58862705648;129732;138438;139686;140205.29897350448;962.6775030364906;978.3689520259393;989.1345073061071;1054.2988912373187;1060.740118670915;19141.75578587443;19780.5133888816;20111.798882010993;20141.295054673017;20238.494037649176;42972.57027429811;53277;53917.921641566165;55040.17439738327;56004.879902400906;78102;78805;82216.58891705504;84753;85258;5516.420775818642;6764.951432527966;8276.379271554779;8280.958595206985;8484.490930544187;11958.22271552381;12646.430910609228;12888.935555322163;13407.061505694897;13421.932890335485;10082.193424526167;11127.55489780432;11277.210595258253;11333.603323883954;11687.006604438719;10992.835107473235;11054.170937179582;11220.382878941737;11220.887791121984;11434.42827858587;11570.94214528922;11579.942100289782;11602.361870096887;11821.527138914691;11965.521379145084;8098.51408915467;8230.21812927771;8465.111163328009;8484.618192181244;8623.956880215559;10548.367097974146;11257.831132532854;11505.942470287595;11666.366708660624;11674.94162529182 10:37:21 INFO - PROCESS | 1639 | |3;mootools.html;1355.8779709826126;1512.689898570793;1528;1725.387487441958;1910.1881700277388;6338.936610633892;8049.919500804997;8233.135520770315;8597.828043439127;8626.35302352323;8425.199606037417;8542.572871356422;8565.229129378355;8584.656613735444;8590.140985901407;2334.2997100869757;2352.482453860148;2365.6333268343346;2366.668666386707;2372.252740386781;2325.093213646671;2373.1219448803968;2380.7738264864897;2382;2386.653935179398;2316.525112351964;2329.184785325131;2344.894479748407;2348.4363752699314;2351.2593533037125;2245.8427910046303;2275.862068965517;2308.2959697292317;2310.364649721323;2312.3756585721762;2306.411864974421;2326.895289711967;2327.2320134355623;2328.732195797488;2330.8718020508863;8449.95775021121;8467.407281490297;8564.70023549179;8582.570871456464;8590;5153.407358153785;5320.547753440962;5324.653897496651;5349.331333583302;5352.759125839347;3059.4951832947536;3146.8269245191505;3550.8757193498104;3629.745917785756;3631.673149416565;1062.4846949229618;1082.7076689293926;1085.478970094359;1086.8098082835552;1112.7385064509833;11114.333140011544;11175.944120279346;11252.606158784485;11253.156013299036;11264.549418023269;4314.050908800122;4497.617702495259;4562.064776720765;4584.243599805995;4585.312203169485;8770.815939848166;8792.60433280504;8794.296456283482;8797.648094076294;8802.603882825288;5230.476952304815;5233;5241.240020197126;5241.42344342122;5243.501867322599;4158.91682166355;4419.071994881111;4525.027119169328;4890.095332363524;4900.534449227318;3698.0200246934583;3713.2387860488534;3781.3382658035284;3817.8854634361014;3821.7706937583835;1061.6072053340313;1107.5403707461473;1156.3351073132983;1160.7272291011604;1173.6889724223088;811.9147489513634;886.7118186589385;902.9954850225707;906.428949761646;919.2921450483091;5613.915791263134;5788.971055144697;5851.9707401463575;5948.375420580864;6020.789272375446;810.2343285595174;938.9953050234706;946.4983558713893;962.9711108666751;994.1450352696675;3068.634457666362;3673.8163091845836;3676.3198808220563;3862.6716729078344;3885.572587015426;9577.425354478753;10502.842457363146;10580.470976451146;10593.258471907047;10605.469726513644;10297;10426.791464170827;10578;10580.894191058145;10595.682129536126;7916.564588947548;8176.877346839921;8185.099639039701;8212.34301255898;8221.342292616577;5378.381486129145;5401.783928642811;5440.918386224289;5600.103983362643;5611.747471363717;9493.193078588121;9576.755021847115;9706.563204655666;9733.415995040321;9803.215742740706;9493.572789224363;9695.418274903528;9825.852612210965;9961.950190249292;9967.202623790225;5591.440855914376;6236.314005459487;6805.65971701403;6806.659667016728;6962.651867406508;8128.878066828884;8205.753827385188;8207.384446166681;8209.13804050566;8260.380471464545;7108.502404831612;7253.347198752138;7305.41556675454;7328.853422931618;7482.850342993001;6951.513394062569;7088.0076789248515;7115.608641524559;7226.494145409771;7247.985282060621;6596.571222870498;6622.37087476689;6682.83292917681;6693.933060669526;6705.430038446787;4693.812247510198;4767.785449654704;4774.665773395829;4777.259524773665;4813.542713442217;4744.240921452551;4777.880552986203;4778.1638213311835;4954.925676114789;4986.5898480182195 10:37:21 INFO - PROCESS | 1639 | |4;prototype.html;312.9217695576106;314.47011785142035;320.5992509363296;324.95775549178603;327.3779818345145;4622.306654001893;5263.657862238952;5310;5333.679979201246;5404.270423492827;4128.69034822388;4966.354373931393;5063.341765570471;5139.897202055966;5305.602079844018;3675.687566556846;3725.254949010195;4039.8788036358956;4064.8170832312617;4096.959030409687;3545.564046561134;3560.6973407260416;4006.2388146252265;4017.457643218172;4047.716659833798;3883.533975922893;3982.3030969580354;4027.5166979962446;4028.7985600719994;4049.6962727795385;4007.7996100195164;4053.8378464861516;4055.5538890721996;4057.918841623166;4083.591640835922;3534.7274981006817;3565;3566.5185199998186;3571.6428357164336;3574.7855128692363;4494.943688233263;5111.207762796773;5116.974415127937;5127.051945131564;5133.153029750124;3748.025513366517;3921.4117882317596;4181.393697913785;4341.110072435144;4614.861554153381;4446.933296000562;4909.533594308535;5406.513413792738;5593.664380137205;5612.382637909826;3817.4655548223272;3853.556840963297;3862.575116737157;3863.9613603864163;3897.5517815451303;5541.612087153901;5764.221830052931;5810.5932584719085;5816.1566572846705;5835.0372188588835;3494.7728397654073;3797.810109494514;3858.440526123696;3868.883933482;3872.8450861965207;3305.338932213519;3384.492326151097;3903.277893589638;3905.218956208713;3935.6028609843665;4329.523752387235;4571.314302854598;4587.403637527167;4594.402727645384;4650.348951146842;4639.0515983287105;5616.550675945915;5654.717264136777;5654.830355089354;5676.290463692038;1200.9459574319176;1242.1987817857432;1275.09468277524;1275.2667216350635;1290.9419076141596;735.8491509240592;824.3858325547506;838.0655569040598;849.7153453593115;874.5670892908051;4324.654027677841;4695.487913966012;5154.92267615986;5165.8230188433845;5195.246689230041;4535.954640453553;4667.463241727177;5529.778808847682;5614.50154681163;5678.886422271531;4475.9257778133015;4870.951290487121;5130.948690513122;5219.399769026611;5255.658382205144;2338.8713620751023;2367.0650093213085;2531.987340063288;2794.986025069902;2842.5025620516326;4846.18268149444;5585.385607583163;5644.6613203207935;5659.971700141556;5687.829365119053;4692.343071969859;5185.0148471790235;5380.901448435114;5484.067708489566;5533.861653458695;5010.273510340907;5073.670211436245;5318.521333080042;5467.20725494801;5695.430456954271;4940.344984430256;5050.3434553507805;5406.486383793534;5481.671099734029;5525.060739674184;5311.920321195263;5318.57451403879;5319;5341.465853414783;5375.543078838186;4722.881927951828;4818.397700287464;5557.805476808292;5582.320486166582;5617.045102332695;3526.5062891195766;3640.927181456409;3657.6890964268337;3660.652238037382;3680.7055435565626;4886.096072226649;5227.477252274894;5319.6808191508635;5326.733663316896;5382.650127741685;4287.549807270192;4334.826606935687;4804.42346918372;4961.479044700254;5241.50205730455;4454.554544545519;4850;5028.270900719448;5142.151544995184;5263.631545791758;4319.589638984291;4538.818447262072;4646.605038571759;4803.18345881208;4998.625103117353;4534.546545345439;4837.467878533288;5239.371275446971;5403;5423.945760542344;4720.560229130011;5247.003069416799;5417.268668729828;5420.241166236809;5420.674759514442 10:37:21 INFO - PROCESS | 1639 | |5;yui.html;724.1418918581478;734.3537686835584;747.6149782861823;781.894444250026;829.286813340527;14166.362513686883;15010.249487525607;15323.080615163099;15345.846541534582;15514.456994005212;14295.857041429583;14300.284985750723;14505.637359066002;14518.201498917555;14569.562913112597;706.9646517674122;728.5046168605346;845.2857335551449;850.9446885952424;874.8162885793975;872.2934423117264;889.4885440871492;890.6971629645919;900.5632268349846;902.747230775384;937.1003836317144;942.3026960049548;942.575840871607;943.3443756589173;944.1361154543619;924.4407133684159;929.3819609959437;929.4330458420358;930.6510058727977;930.8277968575801;693.3170826735661;694.1773997812609;694.836713372357;695.6799872058859;698.2703075286338;14226.644333891632;14523.78214326786;14575.562733117917;14579.927100364537;14947.103173809497;14062.648433789134;14347.067440616327;14394.496192633313;14652.487162949352;14662.560123196321;11727.296362218294;11732.765344693058;11822.290662560188;11861.762764744743;11875.049996000385;3356.194513316811;3390.830458477091;3411.9829400853087;3523.9647603523895;3541.3625547401457;93249;96613;97564;99754.50122749413;100083.49958250162;10540.367577945348;10852.186086043579;11069.335839849635;11070.5571777128;11072;21534;21775.564488710137;22131.778682213295;22157.113715451524;22169.224077157545;7921.960390198012;8004.079530854026;8028.4781489203015;8064.919350806535;8217.58912054395;3976.4830572025453;4350.891227719332;4403.581659742319;4411.977940110343;4554.977225113853;3456.2396272820442;3572.4819901114192;3579.0515513388973;3584.5160903278247;3584.6594573515476;642.1972534332085;657.4575974820792;661.566673828643;671.2750229751856;674.7031306225246;628.955973081889;666.9166354205724;676.1716896801478;683.7094234950126;716.1692436773318;8447.535385553854;9141.634334626673;9154.679586214585;9174.954125229464;9223.458149231172;602.6926267603553;640.1517988664945;648.6367634124905;667.4393509451986;697.2817997462622;4386.2762644163995;4392.143532011291;4406.559344065632;4436.134953684065;4505.031418245027;74711.62644186744;75809;93016;96846;123004;102287;106086;106892;110970.44514777536;112299;91154;93564.53217733868;94031.96216926897;95465;97590.51204744073;8463.322934165375;8558.914410855812;8572.657093716181;8619.784505387415;8651.48091114535;58045;59145;60424.39575604188;60650.69674651598;61552;81498.59250703709;81828.77256841034;84502;84834.30331393461;84966;10590.89409105899;10652.786944261226;10686.57253709843;11428.599998999995;12228.633141005785;12843;13163.210207387587;13311.933440332736;13788.310584470535;14250.144991300554;12835.807462888251;13048.673783155496;13137.802932956205;13304.13523120994;13406;12985.675358115745;13048.804267936179;13167.2757998311;13286.534971276345;13378.397972091474;10777.245592808427;11839.526418943491;13041.543545976225;13236.338183091;13393.866061339262;9583.664571739955;9854.901450985399;10121.190304775748;10351.06840384369;10411.167106631603;10453.529591168568;10671.514645764613;10784.137269018303;10800.24398292112;10812.35125892449 10:37:21 INFO - PROCESS | 1639 | __end_tp_report 10:37:21 INFO - PROCESS | 1639 | __start_cc_report 10:37:21 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,1453 10:37:21 INFO - PROCESS | 1639 | __end_cc_report 10:37:21 INFO - PROCESS | 1639 | __startTimestamp1486579041343__endTimestamp 10:37:21 INFO - PROCESS | 1639 | 10:37:21 INFO - PROCESS | 1639 | ------- Summary: start ------- 10:37:21 INFO - PROCESS | 1639 | Number of tests: 6 10:37:21 INFO - PROCESS | 1639 | 10:37:21 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5755.01 Median:6009.16 stddev:649.96 (10.8%) stddev-sans-first:619.76 10:37:21 INFO - PROCESS | 1639 | Values: 3179.7 3489.7 3503.6 3504.4 3566.8 5669.5 5670.1 5684.8 5688.7 5725.7 5630.6 5664.4 5756.6 5758.7 5785.8 4575.4 4648.7 5221.5 5284.7 5302.0 5162.6 5171.0 5180.6 5344.6 5364.2 5233.0 5243.2 5261.4 5287.0 5296.2 4542.2 5079.3 5245.6 5250.0 5259.5 5150.2 5243.3 5249.3 5270.6 5297.1 5579.7 5582.7 5649.1 5650.8 5736.3 5386.4 6149.9 6198.4 6207.4 6236.7 6320.5 6321.9 6341.5 6360.0 6366.9 5669.9 5728.6 5766.8 5846.7 5878.3 6287.6 6295.5 6302.1 6313.1 6319.1 6177.9 6200.5 6202.7 6214.0 6225.3 6140.0 6209.2 6213.3 6271.9 6293.9 6195.8 6267.2 6278.6 6279.7 6285.0 6258.2 6277.0 6278.3 6304.9 6305.9 4852.4 4898.0 4939.0 4956.3 4980.1 4477.3 4496.3 4496.7 4504.4 4542.6 5732.9 5770.0 5841.0 5848.2 5878.1 6252.8 6334.5 6343.8 6353.7 6358.8 5637.8 5659.9 5671.4 5705.7 5730.4 5378.0 5409.0 5418.8 5419.3 5425.4 6337.5 6338.5 6346.4 6350.1 6361.1 6140.6 6148.0 6227.8 6306.4 6312.1 5114.3 6310.2 6328.9 6330.0 6339.2 6269.2 6271.9 6286.6 6287.3 6302.5 6142.8 6148.5 6181.2 6278.5 6315.5 6120.8 6146.2 6171.3 6181.0 6183.5 6149.0 6152.3 6167.5 6173.5 6180.6 5689.2 5773.8 5897.6 6009.2 6062.5 6126.5 6134.8 6145.9 6148.1 6153.3 5863.5 5956.9 6015.8 6017.7 6050.6 10:37:21 INFO - PROCESS | 1639 | 10:37:21 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:72059.70 Median:19254.98 stddev:164717.18 (855.5%) stddev-sans-first:165091.61 10:37:21 INFO - PROCESS | 1639 | Values: 492.3 512.9 514.7 518.8 535.3 30822.4 40993.4 41066.6 41079.0 41131.0 41824.8 42399.4 42409.9 42447.0 42473.6 8828.1 9025.4 9493.2 9675.1 9712.7 11529.8 11819.2 11831.8 12088.7 12093.1 11907.3 11954.0 11971.5 11981.6 11991.4 11784.0 11856.1 11861.5 11868.6 11868.7 11676.4 11756.1 11758.0 11763.8 11774.6 41119.6 41450.8 41465.6 41493.8 41553.6 3255.8 3417.3 3780.7 3957.9 3996.6 28465.9 29587.4 29613.4 30658.0 31706.4 3304.3 3339.1 3359.1 3486.4 3489.5 496289.0 500773.0 500959.0 503131.0 503682.0 34208.3 35115.1 59164.7 59540.4 59678.7 35626.0 35880.8 35895.5 35896.6 35949.0 15370.1 15585.1 15589.1 15590.0 15603.2 11943.2 12160.1 12723.7 12992.2 13034.7 7993.8 7995.0 8018.1 8067.8 8088.9 3303.9 3347.0 3355.1 3369.0 3386.6 924.9 940.7 980.8 1000.4 1062.3 29888.0 30044.7 30536.0 30664.4 30771.2 1086.1 1094.0 1105.0 1174.7 1200.7 15475.6 15837.0 15891.5 15892.6 16242.9 699084.0 701322.0 701866.0 702392.0 702702.0 59402.4 59760.4 59763.7 59817.7 59833.1 1263.6 1304.6 1386.8 1412.7 1426.7 23279.0 27164.8 27191.9 27623.9 28152.4 47703.0 48221.3 48267.8 48313.3 48514.0 577377.0 578626.0 579168.1 581318.0 771454.0 23786.4 26083.9 26800.9 26816.3 27393.7 45997.5 46089.8 46640.8 46800.0 47138.1 36186.0 38138.2 38823.0 38874.8 38904.6 37604.2 38313.2 38414.6 39702.4 39779.4 33981.5 38433.8 39139.8 39246.0 39349.2 31910.8 34136.3 34503.5 34812.7 35020.5 25604.6 25765.5 25872.4 26425.7 26431.5 10:37:21 INFO - PROCESS | 1639 | 10:37:21 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:35552.03 Median:22104.06 stddev:102042.07 (461.6%) stddev-sans-first:102294.07 10:37:21 INFO - PROCESS | 1639 | Values: 339.9 389.1 398.0 408.0 418.9 19372.0 21077.9 21590.7 21870.0 22056.1 20686.0 21131.5 21279.1 21618.5 21755.8 5736.8 6099.7 6099.8 6141.6 6144.4 4331.6 4450.5 6044.0 6149.4 6165.4 4585.9 4645.7 6905.7 6914.2 6930.1 5861.9 6173.2 6885.9 6892.0 6892.0 6109.8 6111.3 6120.8 6126.1 6135.3 11639.4 13710.7 14158.0 14198.4 14210.8 2328.7 2424.6 2631.0 3030.5 3083.4 10278.3 10815.7 10835.5 10849.9 12829.3 1758.3 1890.7 1907.5 2007.3 2049.0 117412.8 123780.4 131003.0 132512.0 133308.0 10652.8 10947.3 11056.9 11502.7 11884.9 14975.3 14984.0 15012.5 15023.9 15027.8 6531.5 7324.8 8781.1 8848.0 8995.0 7067.5 8549.1 8750.0 8818.6 8938.0 4573.6 4662.2 4693.6 4733.2 4794.0 1915.1 1977.7 1981.4 1981.6 1987.0 808.3 914.5 914.7 1012.1 1031.4 21640.8 22049.8 22152.0 22155.6 22267.1 784.2 841.7 908.5 967.2 1019.5 10925.4 11400.4 11537.9 11582.8 11588.1 600618.0 604596.0 609857.0 616976.0 618833.0 82274.6 129732.0 138438.0 139686.0 140205.3 962.7 978.4 989.1 1054.3 1060.7 19141.8 19780.5 20111.8 20141.3 20238.5 42972.6 53277.0 53917.9 55040.2 56004.9 78102.0 78805.0 82216.6 84753.0 85258.0 5516.4 6765.0 8276.4 8281.0 8484.5 11958.2 12646.4 12888.9 13407.1 13421.9 10082.2 11127.6 11277.2 11333.6 11687.0 10992.8 11054.2 11220.4 11220.9 11434.4 11570.9 11579.9 11602.4 11821.5 11965.5 8098.5 8230.2 8465.1 8484.6 8624.0 10548.4 11257.8 11505.9 11666.4 11674.9 10:37:21 INFO - PROCESS | 1639 | 10:37:21 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5499.08 Median:5231.74 stddev:3064.98 (58.6%) stddev-sans-first:3057.76 10:37:21 INFO - PROCESS | 1639 | Values: 1355.9 1512.7 1528.0 1725.4 1910.2 6338.9 8049.9 8233.1 8597.8 8626.4 8425.2 8542.6 8565.2 8584.7 8590.1 2334.3 2352.5 2365.6 2366.7 2372.3 2325.1 2373.1 2380.8 2382.0 2386.7 2316.5 2329.2 2344.9 2348.4 2351.3 2245.8 2275.9 2308.3 2310.4 2312.4 2306.4 2326.9 2327.2 2328.7 2330.9 8450.0 8467.4 8564.7 8582.6 8590.0 5153.4 5320.5 5324.7 5349.3 5352.8 3059.5 3146.8 3550.9 3629.7 3631.7 1062.5 1082.7 1085.5 1086.8 1112.7 11114.3 11175.9 11252.6 11253.2 11264.5 4314.1 4497.6 4562.1 4584.2 4585.3 8770.8 8792.6 8794.3 8797.6 8802.6 5230.5 5233.0 5241.2 5241.4 5243.5 4158.9 4419.1 4525.0 4890.1 4900.5 3698.0 3713.2 3781.3 3817.9 3821.8 1061.6 1107.5 1156.3 1160.7 1173.7 811.9 886.7 903.0 906.4 919.3 5613.9 5789.0 5852.0 5948.4 6020.8 810.2 939.0 946.5 963.0 994.1 3068.6 3673.8 3676.3 3862.7 3885.6 9577.4 10502.8 10580.5 10593.3 10605.5 10297.0 10426.8 10578.0 10580.9 10595.7 7916.6 8176.9 8185.1 8212.3 8221.3 5378.4 5401.8 5440.9 5600.1 5611.7 9493.2 9576.8 9706.6 9733.4 9803.2 9493.6 9695.4 9825.9 9962.0 9967.2 5591.4 6236.3 6805.7 6806.7 6962.7 8128.9 8205.8 8207.4 8209.1 8260.4 7108.5 7253.3 7305.4 7328.9 7482.9 6951.5 7088.0 7115.6 7226.5 7248.0 6596.6 6622.4 6682.8 6693.9 6705.4 4693.8 4767.8 4774.7 4777.3 4813.5 4744.2 4777.9 4778.2 4954.9 4986.6 10:37:21 INFO - PROCESS | 1639 | 10:37:21 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4345.36 Median:4803.80 stddev:1315.16 (27.4%) stddev-sans-first:1283.55 10:37:21 INFO - PROCESS | 1639 | Values: 312.9 314.5 320.6 325.0 327.4 4622.3 5263.7 5310.0 5333.7 5404.3 4128.7 4966.4 5063.3 5139.9 5305.6 3675.7 3725.3 4039.9 4064.8 4097.0 3545.6 3560.7 4006.2 4017.5 4047.7 3883.5 3982.3 4027.5 4028.8 4049.7 4007.8 4053.8 4055.6 4057.9 4083.6 3534.7 3565.0 3566.5 3571.6 3574.8 4494.9 5111.2 5117.0 5127.1 5133.2 3748.0 3921.4 4181.4 4341.1 4614.9 4446.9 4909.5 5406.5 5593.7 5612.4 3817.5 3853.6 3862.6 3864.0 3897.6 5541.6 5764.2 5810.6 5816.2 5835.0 3494.8 3797.8 3858.4 3868.9 3872.8 3305.3 3384.5 3903.3 3905.2 3935.6 4329.5 4571.3 4587.4 4594.4 4650.3 4639.1 5616.6 5654.7 5654.8 5676.3 1200.9 1242.2 1275.1 1275.3 1290.9 735.8 824.4 838.1 849.7 874.6 4324.7 4695.5 5154.9 5165.8 5195.2 4536.0 4667.5 5529.8 5614.5 5678.9 4475.9 4871.0 5130.9 5219.4 5255.7 2338.9 2367.1 2532.0 2795.0 2842.5 4846.2 5585.4 5644.7 5660.0 5687.8 4692.3 5185.0 5380.9 5484.1 5533.9 5010.3 5073.7 5318.5 5467.2 5695.4 4940.3 5050.3 5406.5 5481.7 5525.1 5311.9 5318.6 5319.0 5341.5 5375.5 4722.9 4818.4 5557.8 5582.3 5617.0 3526.5 3640.9 3657.7 3660.7 3680.7 4886.1 5227.5 5319.7 5326.7 5382.7 4287.5 4334.8 4804.4 4961.5 5241.5 4454.6 4850.0 5028.3 5142.2 5263.6 4319.6 4538.8 4646.6 4803.2 4998.6 4534.5 4837.5 5239.4 5403.0 5423.9 4720.6 5247.0 5417.3 5420.2 5420.7 10:37:21 INFO - PROCESS | 1639 | 10:37:21 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:21428.57 Median:4409.27 stddev:31657.46 (718.0%) stddev-sans-first:31708.09 10:37:21 INFO - PROCESS | 1639 | Values: 724.1 734.4 747.6 781.9 829.3 14166.4 15010.2 15323.1 15345.8 15514.5 14295.9 14300.3 14505.6 14518.2 14569.6 707.0 728.5 845.3 850.9 874.8 872.3 889.5 890.7 900.6 902.7 937.1 942.3 942.6 943.3 944.1 924.4 929.4 929.4 930.7 930.8 693.3 694.2 694.8 695.7 698.3 14226.6 14523.8 14575.6 14579.9 14947.1 14062.6 14347.1 14394.5 14652.5 14662.6 11727.3 11732.8 11822.3 11861.8 11875.0 3356.2 3390.8 3412.0 3524.0 3541.4 93249.0 96613.0 97564.0 99754.5 100083.5 10540.4 10852.2 11069.3 11070.6 11072.0 21534.0 21775.6 22131.8 22157.1 22169.2 7922.0 8004.1 8028.5 8064.9 8217.6 3976.5 4350.9 4403.6 4412.0 4555.0 3456.2 3572.5 3579.1 3584.5 3584.7 642.2 657.5 661.6 671.3 674.7 629.0 666.9 676.2 683.7 716.2 8447.5 9141.6 9154.7 9175.0 9223.5 602.7 640.2 648.6 667.4 697.3 4386.3 4392.1 4406.6 4436.1 4505.0 74711.6 75809.0 93016.0 96846.0 123004.0 102287.0 106086.0 106892.0 110970.4 112299.0 91154.0 93564.5 94032.0 95465.0 97590.5 8463.3 8558.9 8572.7 8619.8 8651.5 58045.0 59145.0 60424.4 60650.7 61552.0 81498.6 81828.8 84502.0 84834.3 84966.0 10590.9 10652.8 10686.6 11428.6 12228.6 12843.0 13163.2 13311.9 13788.3 14250.1 12835.8 13048.7 13137.8 13304.1 13406.0 12985.7 13048.8 13167.3 13286.5 13378.4 10777.2 11839.5 13041.5 13236.3 13393.9 9583.7 9854.9 10121.2 10351.1 10411.2 10453.5 10671.5 10784.1 10800.2 10812.4 10:37:21 INFO - PROCESS | 1639 | -------- Summary: end -------- 10:37:21 INFO - PROCESS | 1639 | 10:37:21 INFO - TEST-INFO | 1639: exit 0 10:37:21 INFO - TEST-OK | dromaeo_css | took 1117566ms 10:37:21 INFO - TEST-START | kraken 10:37:21 INFO - operating with platform_type : mac_ 10:37:21 INFO - Initialising browser for kraken test... 10:37:21 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpsamQt6/profile http://localhost:49236/getInfo.html) 10:37:24 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 10:37:24 INFO - PROCESS | 1649 | colorDepth:24 10:37:24 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 10:37:24 INFO - PROCESS | 1649 | __metrics 10:37:24 INFO - PROCESS | 1649 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:37:24 INFO - PROCESS | 1649 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:37:25 INFO - TEST-INFO | 1649: exit 0 10:37:25 INFO - Browser initialized. 10:37:25 INFO - Running cycle 1/1 for kraken test... 10:37:25 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpsamQt6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:37:37 INFO - PROCESS | 1651 | RSS: Main: 167440384 10:37:37 INFO - PROCESS | 1651 | 10:37:40 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 10:37:41 INFO - PROCESS | 1651 | RSS: Main: 217890816 10:37:41 INFO - PROCESS | 1651 | 10:37:43 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 10:37:44 INFO - PROCESS | 1651 | RSS: Main: 231424000 10:37:44 INFO - PROCESS | 1651 | 10:37:47 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 10:37:47 INFO - PROCESS | 1651 | RSS: Main: 327327744 10:37:47 INFO - PROCESS | 1651 | 10:37:49 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 10:37:50 INFO - PROCESS | 1651 | RSS: Main: 231448576 10:37:50 INFO - PROCESS | 1651 | 10:37:52 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:37:53 INFO - PROCESS | 1651 | RSS: Main: 232673280 10:37:53 INFO - PROCESS | 1651 | 10:37:55 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 10:37:56 INFO - PROCESS | 1651 | RSS: Main: 272322560 10:37:56 INFO - PROCESS | 1651 | 10:37:59 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 10:38:00 INFO - PROCESS | 1651 | RSS: Main: 273862656 10:38:00 INFO - PROCESS | 1651 | 10:38:02 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 10:38:03 INFO - PROCESS | 1651 | RSS: Main: 271851520 10:38:03 INFO - PROCESS | 1651 | 10:38:05 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:38:05 INFO - PROCESS | 1651 | RSS: Main: 247906304 10:38:05 INFO - PROCESS | 1651 | 10:38:07 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:38:08 INFO - PROCESS | 1651 | RSS: Main: 246464512 10:38:08 INFO - PROCESS | 1651 | 10:38:10 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:38:11 INFO - PROCESS | 1651 | RSS: Main: 252284928 10:38:11 INFO - PROCESS | 1651 | 10:38:13 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:38:14 INFO - PROCESS | 1651 | RSS: Main: 270708736 10:38:14 INFO - PROCESS | 1651 | 10:38:17 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:38:18 INFO - PROCESS | 1651 | RSS: Main: 264642560 10:38:18 INFO - PROCESS | 1651 | 10:38:19 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 10:38:20 INFO - PROCESS | 1651 | RSS: Main: 308461568 10:38:20 INFO - PROCESS | 1651 | 10:38:20 INFO - PROCESS | 1651 | __start_tp_report 10:38:20 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 10:38:20 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 10:38:20 INFO - PROCESS | 1651 | |i|pagename|runs| 10:38:20 INFO - PROCESS | 1651 | |0;ai-astar;102;113;114;113;114;113;113;112;113;113 10:38:20 INFO - PROCESS | 1651 | |1;audio-beat-detection;143;108;109;143;112;109;108;106;137;109 10:38:20 INFO - PROCESS | 1651 | |2;audio-dft;181;185;184;184;182;181;183;183;184;183 10:38:20 INFO - PROCESS | 1651 | |3;audio-fft;81;59;57;88;60;59;59;58;82;66 10:38:20 INFO - PROCESS | 1651 | |4;audio-oscillator;89;70;94;70;68;69;88;68;68;92 10:38:20 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;89;86;90;87;89;86;90;86;86;128 10:38:20 INFO - PROCESS | 1651 | |6;imaging-darkroom;94;93;93;94;93;93;94;93;93;92 10:38:20 INFO - PROCESS | 1651 | |7;imaging-desaturate;85;88;121;121;92;80;97;127;122;81 10:38:20 INFO - PROCESS | 1651 | |8;json-parse-financial;53;53;51;52;57;56;54;55;54;56 10:38:20 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;69;63;68;74;70;68;68;68;69;71 10:38:20 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;82;85;82;80;82;81;83;82;85;90 10:38:20 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;139;147;144;122;142;152;150;141;176;136 10:38:20 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;164;177;225;199;165;160;161;160;159;216 10:38:20 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;66;65;66;65;66;66;64;66;66;64 10:38:20 INFO - PROCESS | 1651 | __end_tp_report 10:38:20 INFO - PROCESS | 1651 | __start_cc_report 10:38:20 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1889 10:38:20 INFO - PROCESS | 1651 | __end_cc_report 10:38:20 INFO - PROCESS | 1651 | __startTimestamp1486579100179__endTimestamp 10:38:20 INFO - PROCESS | 1651 | 10:38:20 INFO - PROCESS | 1651 | ------- Summary: start ------- 10:38:20 INFO - PROCESS | 1651 | Number of tests: 14 10:38:20 INFO - PROCESS | 1651 | 10:38:20 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:3.56 (3.1%) stddev-sans-first:0.60 10:38:20 INFO - PROCESS | 1651 | Values: 102.0 113.0 114.0 113.0 114.0 113.0 113.0 112.0 113.0 113.0 10:38:20 INFO - PROCESS | 1651 | 10:38:20 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:118.40 Median:110.50 stddev:15.75 (14.3%) stddev-sans-first:13.96 10:38:20 INFO - PROCESS | 1651 | Values: 143.0 108.0 109.0 143.0 112.0 109.0 108.0 106.0 137.0 109.0 10:38:20 INFO - PROCESS | 1651 | 10:38:20 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:183.00 Median:183.50 stddev:1.33 (0.7%) stddev-sans-first:1.20 10:38:20 INFO - PROCESS | 1651 | Values: 181.0 185.0 184.0 184.0 182.0 181.0 183.0 183.0 184.0 183.0 10:38:20 INFO - PROCESS | 1651 | 10:38:20 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:66.90 Median:63.00 stddev:11.95 (19.0%) stddev-sans-first:11.53 10:38:20 INFO - PROCESS | 1651 | Values: 81.0 59.0 57.0 88.0 60.0 59.0 59.0 58.0 82.0 66.0 10:38:20 INFO - PROCESS | 1651 | 10:38:20 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:79.00 stddev:11.45 (14.5%) stddev-sans-first:11.38 10:38:20 INFO - PROCESS | 1651 | Values: 89.0 70.0 94.0 70.0 68.0 69.0 88.0 68.0 68.0 92.0 10:38:20 INFO - PROCESS | 1651 | 10:38:20 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:91.70 Median:88.00 stddev:12.87 (14.6%) stddev-sans-first:13.61 10:38:20 INFO - PROCESS | 1651 | Values: 89.0 86.0 90.0 87.0 89.0 86.0 90.0 86.0 86.0 128.0 10:38:20 INFO - PROCESS | 1651 | 10:38:20 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:93.20 Median:93.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 10:38:20 INFO - PROCESS | 1651 | Values: 94.0 93.0 93.0 94.0 93.0 93.0 94.0 93.0 93.0 92.0 10:38:20 INFO - PROCESS | 1651 | 10:38:20 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:101.40 Median:83.00 stddev:19.09 (23.0%) stddev-sans-first:19.30 10:38:20 INFO - PROCESS | 1651 | Values: 85.0 88.0 121.0 121.0 92.0 80.0 97.0 127.0 122.0 81.0 10:38:20 INFO - PROCESS | 1651 | 10:38:20 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.50 stddev:1.91 (3.5%) stddev-sans-first:1.99 10:38:20 INFO - PROCESS | 1651 | Values: 53.0 53.0 51.0 52.0 57.0 56.0 54.0 55.0 54.0 56.0 10:38:20 INFO - PROCESS | 1651 | 10:38:20 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:2.78 (4.0%) stddev-sans-first:2.95 10:38:20 INFO - PROCESS | 1651 | Values: 69.0 63.0 68.0 74.0 70.0 68.0 68.0 68.0 69.0 71.0 10:38:20 INFO - PROCESS | 1651 | 10:38:20 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:82.50 stddev:2.86 (3.5%) stddev-sans-first:3.00 10:38:20 INFO - PROCESS | 1651 | Values: 82.0 85.0 82.0 80.0 82.0 81.0 83.0 82.0 85.0 90.0 10:38:20 INFO - PROCESS | 1651 | 10:38:20 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:144.90 Median:145.50 stddev:13.79 (9.5%) stddev-sans-first:14.46 10:38:20 INFO - PROCESS | 1651 | Values: 139.0 147.0 144.0 122.0 142.0 152.0 150.0 141.0 176.0 136.0 10:38:20 INFO - PROCESS | 1651 | 10:38:20 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.60 Median:171.00 stddev:25.29 (14.8%) stddev-sans-first:26.26 10:38:20 INFO - PROCESS | 1651 | Values: 164.0 177.0 225.0 199.0 165.0 160.0 161.0 160.0 159.0 216.0 10:38:20 INFO - PROCESS | 1651 | 10:38:20 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:66.00 stddev:0.84 (1.3%) stddev-sans-first:0.87 10:38:20 INFO - PROCESS | 1651 | Values: 66.0 65.0 66.0 65.0 66.0 66.0 64.0 66.0 66.0 64.0 10:38:20 INFO - PROCESS | 1651 | -------- Summary: end -------- 10:38:20 INFO - PROCESS | 1651 | 10:38:21 INFO - TEST-INFO | 1651: exit 0 10:38:21 INFO - TEST-OK | kraken | took 59438ms 10:38:21 INFO - SUITE-END | took 1177s 10:38:21 INFO - Completed test suite (00:19:37) 10:38:21 INFO - javascript benchmark 10:38:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3179.7297229735473, 3489.6684814942573, 3503.649635036497, 3504.439289713645, 3566.8216589170534, 5669.546436285098, 5670.149477578355, 5684.829455116343, 5688.658680479169, 5725.685087320196, 5630.577706671996, 5664.40523745007, 5756.625819321741, 5758.712064396785, 5785.797497087592, 4575.382323386342, 4648.65135114866, 5221.530062294392, 5284.709340986245, 5302.045631786277, 5162.6128040397125, 5170.974145129269, 5180.611454140936, 5344.625876188668, 5364.249005139283, 5232.973835130838, 5243.213517972296, 5261.394939581959, 5286.995470860544, 5296.152615581508, 4542.159700455426, 5079.263506791532, 5245.606579506514, 5249.973750131263, 5259.474052594748, 5150.227465880148, 5243.292155558989, 5249.317588713481, 5270.631055826094, 5297.073012222884, 5579.7489112990015, 5582.748776305076, 5649.067903795869, 5650.802221922254, 5736.3403208631125, 5386.407495175527, 6149.893019256532, 6198.411150940653, 6207.441330280297, 6236.656983865885, 6320.494360451153, 6321.87356252877, 6341.492680585542, 6360.045993101072, 6366.93633063668, 5669.858253543694, 5728.627639203439, 5766.826995190151, 5846.678432686201, 5878.29460464747, 6287.622742635456, 6295.496360291166, 6302.149209856702, 6313.084602732578, 6319.115323854664, 6177.938220617736, 6200.534959877937, 6202.689865506707, 6213.96893015532, 6225.315215326311, 6139.952147135068, 6209.192804935329, 6213.285472170668, 6271.905921411182, 6293.937060629427, 6195.81412557624, 6267.185265915402, 6278.560500764903, 6279.717412716439, 6284.968575157095, 6258.15514905491, 6277.027060805583, 6278.30938596754, 6304.905426418607, 6305.936940630627, 4852.393450818648, 4898.0, 4939.0121975605025, 4956.281339205795, 4980.12847751642, 4477.306017567283, 4496.325551167286, 4496.685232033727, 4504.436945381827, 4542.613877820356, 5732.856678582985, 5770.0, 5841.0, 5848.210491583582, 5878.118282257696, 6252.781152659635, 6334.493240540745, 6343.777967771106, 6353.650549219838, 6358.77744278948, 5637.774489020393, 5659.915101273402, 5671.376148623648, 5705.686187259741, 5730.398308177665, 5378.0, 5408.999335123015, 5418.810341638024, 5419.3225846769155, 5425.403205647375, 6337.524685648503, 6338.492920566436, 6346.365363463617, 6350.110984462087, 6361.14124593174, 6140.62695141751, 6147.954847675816, 6227.750889964351, 6306.369363063657, 6312.084747711464, 5114.2840002400435, 6310.211223597051, 6328.936710632835, 6329.968350158404, 6339.2392912850755, 6269.153664255449, 6271.905921411274, 6286.622802631857, 6287.339829317856, 6302.495800335871, 6142.78500252489, 6148.50811935053, 6181.227346581677, 6278.497720182283, 6315.463185629273, 6120.785772497941, 6146.231721034871, 6171.321154673072, 6181.041938499539, 6183.505319574333, 6148.9692551536955, 6152.261728592419, 6167.537434692326, 6173.475254603409, 6180.5673602849165, 5689.175069614966, 5773.7979170730505, 5897.587168898308, 6009.158717779427, 6062.514998800174, 6126.509879209563, 6134.803982731443, 6145.924463219008, 6148.139260503443, 6153.323134455296, 5863.530917526673, 5956.940430595639, 6015.759369625166, 6017.669028203491, 6050.5764596479585], "value": 5714.1218013426, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.3033907021565, 512.8615273876052, 514.6577525945247, 518.8235999760082, 535.3335097803235, 30822.38355232894, 40993.38509922354, 41066.58933410665, 41079.0, 41130.9717257068, 41824.790876045656, 42399.36400953988, 42409.93975150623, 42447.0, 42473.575264247345, 8828.117188281152, 9025.368224224307, 9493.24054075674, 9675.080867317594, 9712.708618741413, 11529.769404611945, 11819.172657913949, 11831.7633647327, 12088.697782555419, 12093.09301802364, 11907.285562866256, 11954.0, 11971.521139154424, 11981.64055078349, 11991.40042997851, 11783.998360139398, 11856.110791690615, 11861.52553897843, 11868.643940681706, 11868.703282417922, 11676.416179191006, 11756.1182911282, 11758.0, 11763.823542646782, 11774.646760597196, 41119.588804111874, 41450.79274603638, 41465.58534414647, 41493.792531037456, 41553.584464155276, 3255.8209298488573, 3417.2994536120286, 3780.7353485256044, 3957.881263562098, 3996.6003399660094, 28465.85767071172, 29587.40825183506, 29613.407731845244, 30658.0, 31706.365872682647, 3304.322613864152, 3339.081752518053, 3359.059463350266, 3486.3724529584665, 3489.476578513243, 496289.0, 500773.0, 500959.0, 503131.0, 503682.0, 34208.315833683184, 35115.122121946646, 59164.7041764797, 59540.404595953485, 59678.701606492556, 35626.0, 35880.820595896854, 35895.4615680765, 35896.641033589854, 35949.0, 15370.077795332316, 15585.064896106043, 15589.142597157264, 15589.986650867657, 15603.219839008005, 11943.223690460092, 12160.087993400353, 12723.681907952376, 12992.220466772023, 13034.674133146747, 7993.800154996055, 7995.040595128506, 8018.118007019223, 8067.798305042304, 8088.878666820003, 3303.900882973515, 3347.0293614851907, 3355.094124586348, 3369.0, 3386.6444023377685, 924.856647219682, 940.6566603189787, 980.7842274699555, 1000.364768372089, 1062.2723434447428, 29888.0, 30044.699553004626, 30536.0, 30664.38671226563, 30771.230719232197, 1086.1039642295138, 1093.9726506837392, 1105.0217874124876, 1174.6769638349522, 1200.7298357869583, 15475.613109672347, 15837.0, 15891.523254302389, 15892.60268493297, 16242.918785405996, 699084.0, 701322.0, 701866.0, 702392.0, 702702.0, 59402.405975939684, 59760.402395975485, 59763.701181493816, 59817.700911495165, 59833.10250346248, 1263.5830176041884, 1304.5825335892423, 1386.778115501515, 1412.6538997945363, 1426.7431862264891, 23279.0, 27164.777585009117, 27191.86404067967, 27623.861880690467, 28152.43695126127, 47703.0, 48221.27668085052, 48267.75866120647, 48313.27530087122, 48514.0, 577377.0, 578626.0, 579168.1041594765, 581318.0, 771454.0, 23786.40533986664, 26083.869580651975, 26800.865995669898, 26816.32959176036, 27393.726062739916, 45997.54002459932, 46089.76955115203, 46640.76679616716, 46800.0, 47138.05723885572, 36186.0, 38138.237235254586, 38823.0, 38874.80562597282, 38904.6109538901, 37604.247915041, 38313.233735325695, 38414.615853842224, 39702.40446393364, 39779.40330894981, 33981.49027764536, 38433.807830960664, 39139.804300978314, 39246.0, 39349.2130157401, 31910.84044579762, 34136.31727365389, 34503.4824477628, 34812.65187348094, 35020.47469288014, 25604.615930761425, 25765.484690306464, 25872.353191170372, 26425.735742642326, 26431.471370572097], "value": 19235.815794899474, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.87764404814266, 389.06430035764, 397.9820908059138, 408.004469095407, 418.9204051230266, 19372.0, 21077.863449322846, 21590.676139857896, 21870.0, 22056.117755289808, 20686.0, 21131.47171320718, 21279.14883404662, 21618.459538511546, 21755.782442175572, 5736.819306622585, 6099.664518451484, 6099.756009759604, 6141.6007959482495, 6144.44699977002, 4331.588499092597, 4450.4881938577155, 6044.0, 6149.415805498493, 6165.3834616538215, 4585.931211031837, 4645.6980296280635, 6905.689243984033, 6914.170299564059, 6930.099087118668, 5861.941380586182, 6173.166622505949, 6885.896711549331, 6891.965540172292, 6892.0, 6109.755609775603, 6111.327753947106, 6120.755169793248, 6126.111713801474, 6135.294441139237, 11639.418029098511, 13710.725785484334, 14158.0, 14198.432062717478, 14210.786838197435, 2328.6507023946374, 2424.648425978241, 2631.0396705202656, 3030.5151175811766, 3083.383323335342, 10278.331908426004, 10815.67552973412, 10835.458227088693, 10849.945750271278, 12829.294388808612, 1758.3142574395995, 1890.6785846406005, 1907.50404894727, 2007.3375785990588, 2048.95902081959, 117412.8258717419, 123780.38109809483, 131003.0, 132512.0369583371, 133308.0, 10652.786944261072, 10947.34315941046, 11056.889431105747, 11502.712432189095, 11884.940575297242, 14975.32611032506, 14984.0, 15012.474563390448, 15023.924880375747, 15027.849721502864, 6531.477481801445, 7324.816879578053, 8781.07798681142, 8848.0, 8995.010548839622, 7067.5052746307265, 8549.102344253888, 8749.956250218707, 8818.5590720465, 8938.016818149998, 4573.565511276423, 4662.207424737802, 4693.624510039189, 4733.242681170997, 4793.976030119897, 1915.1094740945528, 1977.7428934238744, 1981.4154824326858, 1981.5937732764748, 1986.9503262418555, 808.2662688533181, 914.5472990869429, 914.7118657622827, 1012.0587853296357, 1031.3554028732042, 21640.783592164193, 22049.78726170076, 22152.003159857846, 22155.55688886213, 22267.109315627516, 784.2275358771606, 841.7306461932122, 908.5139450394007, 967.2213867836318, 1019.4911530934259, 10925.399103049409, 11400.429978501043, 11537.88462115368, 11582.783807700238, 11588.072954163647, 600618.0, 604596.0, 609857.0, 616976.0, 618833.0, 82274.58862705648, 129732.0, 138438.0, 139686.0, 140205.29897350448, 962.6775030364906, 978.3689520259393, 989.1345073061071, 1054.2988912373187, 1060.740118670915, 19141.75578587443, 19780.5133888816, 20111.798882010993, 20141.295054673017, 20238.494037649176, 42972.57027429811, 53277.0, 53917.921641566165, 55040.17439738327, 56004.879902400906, 78102.0, 78805.0, 82216.58891705504, 84753.0, 85258.0, 5516.420775818642, 6764.951432527966, 8276.379271554779, 8280.958595206985, 8484.490930544187, 11958.22271552381, 12646.430910609228, 12888.935555322163, 13407.061505694897, 13421.932890335485, 10082.193424526167, 11127.55489780432, 11277.210595258253, 11333.603323883954, 11687.006604438719, 10992.835107473235, 11054.170937179582, 11220.382878941737, 11220.887791121984, 11434.42827858587, 11570.94214528922, 11579.942100289782, 11602.361870096887, 11821.527138914691, 11965.521379145084, 8098.51408915467, 8230.21812927771, 8465.111163328009, 8484.618192181244, 8623.956880215559, 10548.367097974146, 11257.831132532854, 11505.942470287595, 11666.366708660624, 11674.94162529182], "value": 9648.577898004092, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1355.8779709826126, 1512.689898570793, 1528.0, 1725.387487441958, 1910.1881700277388, 6338.936610633892, 8049.919500804997, 8233.135520770315, 8597.828043439127, 8626.35302352323, 8425.199606037417, 8542.572871356422, 8565.229129378355, 8584.656613735444, 8590.140985901407, 2334.2997100869757, 2352.482453860148, 2365.6333268343346, 2366.668666386707, 2372.252740386781, 2325.093213646671, 2373.1219448803968, 2380.7738264864897, 2382.0, 2386.653935179398, 2316.525112351964, 2329.184785325131, 2344.894479748407, 2348.4363752699314, 2351.2593533037125, 2245.8427910046303, 2275.862068965517, 2308.2959697292317, 2310.364649721323, 2312.3756585721762, 2306.411864974421, 2326.895289711967, 2327.2320134355623, 2328.732195797488, 2330.8718020508863, 8449.95775021121, 8467.407281490297, 8564.70023549179, 8582.570871456464, 8590.0, 5153.407358153785, 5320.547753440962, 5324.653897496651, 5349.331333583302, 5352.759125839347, 3059.4951832947536, 3146.8269245191505, 3550.8757193498104, 3629.745917785756, 3631.673149416565, 1062.4846949229618, 1082.7076689293926, 1085.478970094359, 1086.8098082835552, 1112.7385064509833, 11114.333140011544, 11175.944120279346, 11252.606158784485, 11253.156013299036, 11264.549418023269, 4314.050908800122, 4497.617702495259, 4562.064776720765, 4584.243599805995, 4585.312203169485, 8770.815939848166, 8792.60433280504, 8794.296456283482, 8797.648094076294, 8802.603882825288, 5230.476952304815, 5233.0, 5241.240020197126, 5241.42344342122, 5243.501867322599, 4158.91682166355, 4419.071994881111, 4525.027119169328, 4890.095332363524, 4900.534449227318, 3698.0200246934583, 3713.2387860488534, 3781.3382658035284, 3817.8854634361014, 3821.7706937583835, 1061.6072053340313, 1107.5403707461473, 1156.3351073132983, 1160.7272291011604, 1173.6889724223088, 811.9147489513634, 886.7118186589385, 902.9954850225707, 906.428949761646, 919.2921450483091, 5613.915791263134, 5788.971055144697, 5851.9707401463575, 5948.375420580864, 6020.789272375446, 810.2343285595174, 938.9953050234706, 946.4983558713893, 962.9711108666751, 994.1450352696675, 3068.634457666362, 3673.8163091845836, 3676.3198808220563, 3862.6716729078344, 3885.572587015426, 9577.425354478753, 10502.842457363146, 10580.470976451146, 10593.258471907047, 10605.469726513644, 10297.0, 10426.791464170827, 10578.0, 10580.894191058145, 10595.682129536126, 7916.564588947548, 8176.877346839921, 8185.099639039701, 8212.34301255898, 8221.342292616577, 5378.381486129145, 5401.783928642811, 5440.918386224289, 5600.103983362643, 5611.747471363717, 9493.193078588121, 9576.755021847115, 9706.563204655666, 9733.415995040321, 9803.215742740706, 9493.572789224363, 9695.418274903528, 9825.852612210965, 9961.950190249292, 9967.202623790225, 5591.440855914376, 6236.314005459487, 6805.65971701403, 6806.659667016728, 6962.651867406508, 8128.878066828884, 8205.753827385188, 8207.384446166681, 8209.13804050566, 8260.380471464545, 7108.502404831612, 7253.347198752138, 7305.41556675454, 7328.853422931618, 7482.850342993001, 6951.513394062569, 7088.0076789248515, 7115.608641524559, 7226.494145409771, 7247.985282060621, 6596.571222870498, 6622.37087476689, 6682.83292917681, 6693.933060669526, 6705.430038446787, 4693.812247510198, 4767.785449654704, 4774.665773395829, 4777.259524773665, 4813.542713442217, 4744.240921452551, 4777.880552986203, 4778.1638213311835, 4954.925676114789, 4986.5898480182195], "value": 4437.595111038383, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.9217695576106, 314.47011785142035, 320.5992509363296, 324.95775549178603, 327.3779818345145, 4622.306654001893, 5263.657862238952, 5310.0, 5333.679979201246, 5404.270423492827, 4128.69034822388, 4966.354373931393, 5063.341765570471, 5139.897202055966, 5305.602079844018, 3675.687566556846, 3725.254949010195, 4039.8788036358956, 4064.8170832312617, 4096.959030409687, 3545.564046561134, 3560.6973407260416, 4006.2388146252265, 4017.457643218172, 4047.716659833798, 3883.533975922893, 3982.3030969580354, 4027.5166979962446, 4028.7985600719994, 4049.6962727795385, 4007.7996100195164, 4053.8378464861516, 4055.5538890721996, 4057.918841623166, 4083.591640835922, 3534.7274981006817, 3565.0, 3566.5185199998186, 3571.6428357164336, 3574.7855128692363, 4494.943688233263, 5111.207762796773, 5116.974415127937, 5127.051945131564, 5133.153029750124, 3748.025513366517, 3921.4117882317596, 4181.393697913785, 4341.110072435144, 4614.861554153381, 4446.933296000562, 4909.533594308535, 5406.513413792738, 5593.664380137205, 5612.382637909826, 3817.4655548223272, 3853.556840963297, 3862.575116737157, 3863.9613603864163, 3897.5517815451303, 5541.612087153901, 5764.221830052931, 5810.5932584719085, 5816.1566572846705, 5835.0372188588835, 3494.7728397654073, 3797.810109494514, 3858.440526123696, 3868.883933482, 3872.8450861965207, 3305.338932213519, 3384.492326151097, 3903.277893589638, 3905.218956208713, 3935.6028609843665, 4329.523752387235, 4571.314302854598, 4587.403637527167, 4594.402727645384, 4650.348951146842, 4639.0515983287105, 5616.550675945915, 5654.717264136777, 5654.830355089354, 5676.290463692038, 1200.9459574319176, 1242.1987817857432, 1275.09468277524, 1275.2667216350635, 1290.9419076141596, 735.8491509240592, 824.3858325547506, 838.0655569040598, 849.7153453593115, 874.5670892908051, 4324.654027677841, 4695.487913966012, 5154.92267615986, 5165.8230188433845, 5195.246689230041, 4535.954640453553, 4667.463241727177, 5529.778808847682, 5614.50154681163, 5678.886422271531, 4475.9257778133015, 4870.951290487121, 5130.948690513122, 5219.399769026611, 5255.658382205144, 2338.8713620751023, 2367.0650093213085, 2531.987340063288, 2794.986025069902, 2842.5025620516326, 4846.18268149444, 5585.385607583163, 5644.6613203207935, 5659.971700141556, 5687.829365119053, 4692.343071969859, 5185.0148471790235, 5380.901448435114, 5484.067708489566, 5533.861653458695, 5010.273510340907, 5073.670211436245, 5318.521333080042, 5467.20725494801, 5695.430456954271, 4940.344984430256, 5050.3434553507805, 5406.486383793534, 5481.671099734029, 5525.060739674184, 5311.920321195263, 5318.57451403879, 5319.0, 5341.465853414783, 5375.543078838186, 4722.881927951828, 4818.397700287464, 5557.805476808292, 5582.320486166582, 5617.045102332695, 3526.5062891195766, 3640.927181456409, 3657.6890964268337, 3660.652238037382, 3680.7055435565626, 4886.096072226649, 5227.477252274894, 5319.6808191508635, 5326.733663316896, 5382.650127741685, 4287.549807270192, 4334.826606935687, 4804.42346918372, 4961.479044700254, 5241.50205730455, 4454.554544545519, 4850.0, 5028.270900719448, 5142.151544995184, 5263.631545791758, 4319.589638984291, 4538.818447262072, 4646.605038571759, 4803.18345881208, 4998.625103117353, 4534.546545345439, 4837.467878533288, 5239.371275446971, 5403.0, 5423.945760542344, 4720.560229130011, 5247.003069416799, 5417.268668729828, 5420.241166236809, 5420.674759514442], "value": 3930.261444437137, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.1418918581478, 734.3537686835584, 747.6149782861823, 781.894444250026, 829.286813340527, 14166.362513686883, 15010.249487525607, 15323.080615163099, 15345.846541534582, 15514.456994005212, 14295.857041429583, 14300.284985750723, 14505.637359066002, 14518.201498917555, 14569.562913112597, 706.9646517674122, 728.5046168605346, 845.2857335551449, 850.9446885952424, 874.8162885793975, 872.2934423117264, 889.4885440871492, 890.6971629645919, 900.5632268349846, 902.747230775384, 937.1003836317144, 942.3026960049548, 942.575840871607, 943.3443756589173, 944.1361154543619, 924.4407133684159, 929.3819609959437, 929.4330458420358, 930.6510058727977, 930.8277968575801, 693.3170826735661, 694.1773997812609, 694.836713372357, 695.6799872058859, 698.2703075286338, 14226.644333891632, 14523.78214326786, 14575.562733117917, 14579.927100364537, 14947.103173809497, 14062.648433789134, 14347.067440616327, 14394.496192633313, 14652.487162949352, 14662.560123196321, 11727.296362218294, 11732.765344693058, 11822.290662560188, 11861.762764744743, 11875.049996000385, 3356.194513316811, 3390.830458477091, 3411.9829400853087, 3523.9647603523895, 3541.3625547401457, 93249.0, 96613.0, 97564.0, 99754.50122749413, 100083.49958250162, 10540.367577945348, 10852.186086043579, 11069.335839849635, 11070.5571777128, 11072.0, 21534.0, 21775.564488710137, 22131.778682213295, 22157.113715451524, 22169.224077157545, 7921.960390198012, 8004.079530854026, 8028.4781489203015, 8064.919350806535, 8217.58912054395, 3976.4830572025453, 4350.891227719332, 4403.581659742319, 4411.977940110343, 4554.977225113853, 3456.2396272820442, 3572.4819901114192, 3579.0515513388973, 3584.5160903278247, 3584.6594573515476, 642.1972534332085, 657.4575974820792, 661.566673828643, 671.2750229751856, 674.7031306225246, 628.955973081889, 666.9166354205724, 676.1716896801478, 683.7094234950126, 716.1692436773318, 8447.535385553854, 9141.634334626673, 9154.679586214585, 9174.954125229464, 9223.458149231172, 602.6926267603553, 640.1517988664945, 648.6367634124905, 667.4393509451986, 697.2817997462622, 4386.2762644163995, 4392.143532011291, 4406.559344065632, 4436.134953684065, 4505.031418245027, 74711.62644186744, 75809.0, 93016.0, 96846.0, 123004.0, 102287.0, 106086.0, 106892.0, 110970.44514777536, 112299.0, 91154.0, 93564.53217733868, 94031.96216926897, 95465.0, 97590.51204744073, 8463.322934165375, 8558.914410855812, 8572.657093716181, 8619.784505387415, 8651.48091114535, 58045.0, 59145.0, 60424.39575604188, 60650.69674651598, 61552.0, 81498.59250703709, 81828.77256841034, 84502.0, 84834.30331393461, 84966.0, 10590.89409105899, 10652.786944261226, 10686.57253709843, 11428.599998999995, 12228.633141005785, 12843.0, 13163.210207387587, 13311.933440332736, 13788.310584470535, 14250.144991300554, 12835.807462888251, 13048.673783155496, 13137.802932956205, 13304.13523120994, 13406.0, 12985.675358115745, 13048.804267936179, 13167.2757998311, 13286.534971276345, 13378.397972091474, 10777.245592808427, 11839.526418943491, 13041.543545976225, 13236.338183091, 13393.866061339262, 9583.664571739955, 9854.901450985399, 10121.190304775748, 10351.06840384369, 10411.167106631603, 10453.529591168568, 10671.514645764613, 10784.137269018303, 10800.24398292112, 10812.35125892449], "value": 7484.585113887021, "unit": "score"}], "name": "dromaeo_css", "value": 7192.579274105773, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 114.0, 113.0, 114.0, 113.0, 113.0, 112.0, 113.0, 113.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 108.0, 109.0, 143.0, 112.0, 109.0, 108.0, 106.0, 137.0, 109.0], "value": 118.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 185.0, 184.0, 184.0, 182.0, 181.0, 183.0, 183.0, 184.0, 183.0], "value": 183.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 57.0, 88.0, 60.0, 59.0, 59.0, 58.0, 82.0, 66.0], "value": 66.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 94.0, 70.0, 68.0, 69.0, 88.0, 68.0, 68.0, 92.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 90.0, 87.0, 89.0, 86.0, 90.0, 86.0, 86.0, 128.0], "value": 91.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 93.0, 94.0, 93.0, 93.0, 94.0, 93.0, 93.0, 92.0], "value": 93.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 88.0, 121.0, 121.0, 92.0, 80.0, 97.0, 127.0, 122.0, 81.0], "value": 101.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 51.0, 52.0, 57.0, 56.0, 54.0, 55.0, 54.0, 56.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 63.0, 68.0, 74.0, 70.0, 68.0, 68.0, 68.0, 69.0, 71.0], "value": 68.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 82.0, 80.0, 82.0, 81.0, 83.0, 82.0, 85.0, 90.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 147.0, 144.0, 122.0, 142.0, 152.0, 150.0, 141.0, 176.0, 136.0], "value": 144.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 177.0, 225.0, 199.0, 165.0, 160.0, 161.0, 160.0, 159.0, 216.0], "value": 178.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 65.0, 66.0, 66.0, 64.0, 66.0, 66.0, 64.0], "value": 65.4, "unit": "score"}], "name": "kraken", "value": 1439.2, "alertThreshold": 2.0}]} 10:38:21 INFO - Return code: 0 10:38:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:38:21 INFO - # TBPL SUCCESS # 10:38:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:38:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:38:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:38:21 INFO - 2017-02-08 10:38:21.983 screenresolution[1655:9707] starting screenresolution argv=screenresolution get 10:38:21 INFO - 2017-02-08 10:38:21.985 screenresolution[1655:9707] Display 0: 1600x1200x32@60 10:38:21 INFO - 2017-02-08 10:38:21.991 screenresolution[1656:9710] starting screenresolution argv=screenresolution list 10:38:21 INFO - Available Modes on Display 0 10:38:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:38:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:38:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:38:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:38:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:38:22 INFO - Intel Iris: 10:38:22 INFO - Chipset Model: Intel Iris 10:38:22 INFO - Type: GPU 10:38:22 INFO - Bus: Built-In 10:38:22 INFO - VRAM (Dynamic, Max): 1536 MB 10:38:22 INFO - Vendor: Intel (0x8086) 10:38:22 INFO - Device ID: 0x0a2e 10:38:22 INFO - Revision ID: 0x0009 10:38:22 INFO - Displays: 10:38:22 INFO - Display: 10:38:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:38:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:38:22 INFO - Display Serial Number: 1600x1200 60 10:38:22 INFO - Main Display: Yes 10:38:22 INFO - Mirror: Off 10:38:22 INFO - Online: Yes 10:38:22 INFO - Rotation: Supported 10:38:22 INFO - Return code: 0 10:38:22 INFO - Running post-action listener: _resource_record_post_action 10:38:22 INFO - [mozharness: 2017-02-08 18:38:22.224585Z] Finished run-tests step (success) 10:38:22 INFO - Running post-run listener: _resource_record_post_run 10:38:22 INFO - Total resource usage - Wall time: 1199s; CPU: 53.0%; Read bytes: 38913024; Write bytes: 500951552; Read time: 381; Write time: 1690 10:38:22 INFO - TinderboxPrint: CPU usage
53.4% 10:38:22 INFO - TinderboxPrint: I/O read bytes / time
38,913,024 / 381 10:38:22 INFO - TinderboxPrint: I/O write bytes / time
500,951,552 / 1,690 10:38:22 INFO - TinderboxPrint: CPU idle
2,234.5 (46.6%) 10:38:22 INFO - TinderboxPrint: CPU system
959.8 (20.0%) 10:38:22 INFO - TinderboxPrint: CPU user
1,603.5 (33.4%) 10:38:22 INFO - TinderboxPrint: Swap in / out
230,445,056 / 0 10:38:22 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 183308800; Write bytes: 175616000; Read time: 16688; Write time: 318 10:38:22 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 37921792; Write bytes: 307020288; Read time: 362; Write time: 1264 10:38:22 INFO - Running post-run listener: _upload_blobber_files 10:38:22 INFO - Blob upload gear active. 10:38:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:38:22 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 10:38:22 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'] 10:38:22 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 10:38:23 INFO - (blobuploader) - INFO - Open directory for files ... 10:38:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:38:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:38:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:38:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:38:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:38:23 INFO - (blobuploader) - INFO - Done attempting. 10:38:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:38:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:38:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:38:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:38:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:38:25 INFO - (blobuploader) - INFO - Done attempting. 10:38:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:38:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:38:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:38:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:38:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:38:27 INFO - (blobuploader) - INFO - Done attempting. 10:38:27 INFO - (blobuploader) - INFO - Iteration through files over. 10:38:27 INFO - Return code: 0 10:38:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:38:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:38:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8406e29d15158f70213dbc2a45f8b1684e3632e6e47900d32e30fd0d240625b0c0fdd95862cb0fe747b67a8c8b194bf38818fadcce7b7aa1b030f24b2631271a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b1f0b1b67c3cf4572e9421157ac1ffd48a3701a0090242a92c9a3b9cf33499071b96e6aae0acf7ac8c75961a8bde32201c4b21f4fcfcdc384678318871dedb2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f4a0dbbabce5655da4e3ab9d4572c08f0c1c8566f4810677e41e562955bc69b6e9431b4683aaefc89df1802069a0ceb1445aedfb3156c8910252491b37203e3f"} 10:38:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:38:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:38:27 INFO - Contents: 10:38:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8406e29d15158f70213dbc2a45f8b1684e3632e6e47900d32e30fd0d240625b0c0fdd95862cb0fe747b67a8c8b194bf38818fadcce7b7aa1b030f24b2631271a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b1f0b1b67c3cf4572e9421157ac1ffd48a3701a0090242a92c9a3b9cf33499071b96e6aae0acf7ac8c75961a8bde32201c4b21f4fcfcdc384678318871dedb2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f4a0dbbabce5655da4e3ab9d4572c08f0c1c8566f4810677e41e562955bc69b6e9431b4683aaefc89df1802069a0ceb1445aedfb3156c8910252491b37203e3f"} 10:38:27 INFO - Running post-run listener: copy_logs_to_upload_dir 10:38:27 INFO - Copying logs to upload dir... 10:38:27 INFO - mkdir: /builds/slave/test/build/upload/logs 10:38:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.228086 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-08 10:38:27.385074) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-08 10:38:27.388457) ========= 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.H4MRWBmwHz/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.vioC8pMRPo/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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/8406e29d15158f70213dbc2a45f8b1684e3632e6e47900d32e30fd0d240625b0c0fdd95862cb0fe747b67a8c8b194bf38818fadcce7b7aa1b030f24b2631271a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b1f0b1b67c3cf4572e9421157ac1ffd48a3701a0090242a92c9a3b9cf33499071b96e6aae0acf7ac8c75961a8bde32201c4b21f4fcfcdc384678318871dedb2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f4a0dbbabce5655da4e3ab9d4572c08f0c1c8566f4810677e41e562955bc69b6e9431b4683aaefc89df1802069a0ceb1445aedfb3156c8910252491b37203e3f"} build_url:https://queue.taskcluster.net/v1/task/YVfU2RQWS8e2B96Z_2z13w/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011127 build_url: 'https://queue.taskcluster.net/v1/task/YVfU2RQWS8e2B96Z_2z13w/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/8406e29d15158f70213dbc2a45f8b1684e3632e6e47900d32e30fd0d240625b0c0fdd95862cb0fe747b67a8c8b194bf38818fadcce7b7aa1b030f24b2631271a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b1f0b1b67c3cf4572e9421157ac1ffd48a3701a0090242a92c9a3b9cf33499071b96e6aae0acf7ac8c75961a8bde32201c4b21f4fcfcdc384678318871dedb2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f4a0dbbabce5655da4e3ab9d4572c08f0c1c8566f4810677e41e562955bc69b6e9431b4683aaefc89df1802069a0ceb1445aedfb3156c8910252491b37203e3f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-08 10:38:27.421777) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 10:38:27.422110) ========= 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.H4MRWBmwHz/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.vioC8pMRPo/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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.005217 ========= master_lag: 0.11 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 10:38:27.537899) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-08 10:38:27.538213) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-08 10:38:27.538526) ========= ========= Total master_lag: 0.25 =========