builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0342 starttime: 1487347916.01 results: success (0) buildid: 20170217064138 builduid: 45929baae1b64ce19bc70c2fbe086079 revision: 546f359ac8c0dbb466e6b307a0f906ea6df62a45 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-17 08:11:56.006545) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-17 08:11:56.006982) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-17 08:11:56.007276) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-17 08:11:56.032406) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 08:11:56.032784) ========= 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.kMaiYpvaaF/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.CdUdADfdoi/Listeners TMPDIR=/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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-17 08:11:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 6.97M=0.002s 2017-02-17 08:11:56 (6.97 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.621871 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 08:11:56.678609) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 08:11:56.678938) ========= 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.kMaiYpvaaF/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.CdUdADfdoi/Listeners TMPDIR=/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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.020660 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 08:11:56.728132) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-17 08:11:56.728485) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 546f359ac8c0dbb466e6b307a0f906ea6df62a45 --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 546f359ac8c0dbb466e6b307a0f906ea6df62a45 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kMaiYpvaaF/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.CdUdADfdoi/Listeners TMPDIR=/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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-17 08:11:56,824 truncating revision to first 12 chars 2017-02-17 08:11:56,824 Setting DEBUG logging. 2017-02-17 08:11:56,824 attempt 1/10 2017-02-17 08:11:56,824 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/546f359ac8c0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-17 08:11:58,281 unpacking tar archive at: mozilla-beta-546f359ac8c0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.697476 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-17 08:11:58.449883) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-17 08:11:58.450186) ========= script_repo_revision: 546f359ac8c0dbb466e6b307a0f906ea6df62a45 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-17 08:11:58.450570) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-17 08:11:58.450834) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-17 08:11:58.470907) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-17 08:11:58.471192) ========= /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.kMaiYpvaaF/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.CdUdADfdoi/Listeners TMPDIR=/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:11:58 INFO - MultiFileLogger online at 20170217 08:11:58 in /builds/slave/test 08:11:58 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 08:11:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:11:58 INFO - {'append_to_log': False, 08:11:58 INFO - 'base_work_dir': '/builds/slave/test', 08:11:58 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:11:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:11:58 INFO - 'branch': 'Mozilla-Beta', 08:11:58 INFO - 'buildbot_json_path': 'buildprops.json', 08:11:58 INFO - 'config_files': ('talos/mac_config.py',), 08:11:58 INFO - 'default_actions': ('clobber', 08:11:58 INFO - 'read-buildbot-config', 08:11:58 INFO - 'download-and-extract', 08:11:58 INFO - 'populate-webroot', 08:11:58 INFO - 'create-virtualenv', 08:11:58 INFO - 'install', 08:11:58 INFO - 'run-tests'), 08:11:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:11:58 INFO - 'download_minidump_stackwalk': True, 08:11:58 INFO - 'download_symbols': 'ondemand', 08:11:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:11:58 INFO - 'tooltool.py': '/tools/tooltool.py', 08:11:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:11:58 INFO - '/tools/misc-python/virtualenv.py')}, 08:11:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:11:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:11:58 INFO - 'installer_path': 'installer.exe', 08:11:58 INFO - 'log_level': 'info', 08:11:58 INFO - 'log_name': 'talos', 08:11:58 INFO - 'log_to_console': True, 08:11:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:11:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:11:58 INFO - 'opt_config_files': (), 08:11:58 INFO - 'pip_index': False, 08:11:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:11:58 INFO - 'cmd': ('bash', 08:11:58 INFO - '-c', 08:11:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:11:58 INFO - 'enabled': True, 08:11:58 INFO - 'halt_on_failure': False, 08:11:58 INFO - 'name': 'check_screen_resolution'},), 08:11:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:11:58 INFO - 'cmd': ('bash', 08:11:58 INFO - '-c', 08:11:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:11:58 INFO - 'enabled': True, 08:11:58 INFO - 'halt_on_failure': False, 08:11:58 INFO - 'name': 'check_screen_resolution'},), 08:11:58 INFO - 'run_cmd_checks_enabled': True, 08:11:58 INFO - 'sps_profile': False, 08:11:58 INFO - 'sps_profile_interval': 0, 08:11:58 INFO - 'suite': 'dromaeojs', 08:11:58 INFO - 'system_bits': '32', 08:11:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:11:58 INFO - 'title': 't-yosemite-r7-0342', 08:11:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:11:58 INFO - 'use_talos_json': True, 08:11:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:11:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:11:58 INFO - 'work_dir': 'build'} 08:11:58 INFO - [mozharness: 2017-02-17 16:11:58.682500Z] Running clobber step. 08:11:58 INFO - Running pre-action listener: _resource_record_pre_action 08:11:58 INFO - Running main action method: clobber 08:11:58 INFO - rmtree: /builds/slave/test/build 08:11:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:12:00 INFO - Running post-action listener: _resource_record_post_action 08:12:00 INFO - [mozharness: 2017-02-17 16:12:00.678732Z] Finished clobber step (success) 08:12:00 INFO - [mozharness: 2017-02-17 16:12:00.678855Z] Running read-buildbot-config step. 08:12:00 INFO - Running pre-action listener: _resource_record_pre_action 08:12:00 INFO - Running main action method: read_buildbot_config 08:12:00 INFO - Using buildbot properties: 08:12:00 INFO - { 08:12:00 INFO - "project": "", 08:12:00 INFO - "product": "firefox", 08:12:00 INFO - "script_repo_revision": "production", 08:12:00 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 08:12:00 INFO - "repository": "", 08:12:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 08:12:00 INFO - "buildid": "20170217064138", 08:12:00 INFO - "pgo_build": "False", 08:12:00 INFO - "basedir": "/builds/slave/test", 08:12:00 INFO - "buildnumber": 5, 08:12:00 INFO - "slavename": "t-yosemite-r7-0342", 08:12:00 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 08:12:00 INFO - "platform": "yosemite_r7", 08:12:00 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:12:00 INFO - "branch": "mozilla-beta", 08:12:00 INFO - "repo_path": "releases/mozilla-beta", 08:12:00 INFO - "revision": "546f359ac8c0dbb466e6b307a0f906ea6df62a45", 08:12:00 INFO - "stage_platform": "macosx64", 08:12:00 INFO - "builduid": "45929baae1b64ce19bc70c2fbe086079", 08:12:00 INFO - "slavebuilddir": "test" 08:12:00 INFO - } 08:12:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/IrV7ePewRYmMaRPuHkUP8Q/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 08:12:00 INFO - Running post-action listener: _resource_record_post_action 08:12:00 INFO - [mozharness: 2017-02-17 16:12:00.682112Z] Finished read-buildbot-config step (success) 08:12:00 INFO - [mozharness: 2017-02-17 16:12:00.682241Z] Running download-and-extract step. 08:12:00 INFO - Running pre-action listener: _resource_record_pre_action 08:12:00 INFO - Running main action method: download_and_extract 08:12:00 INFO - mkdir: /builds/slave/test/build/tests 08:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:00 INFO - trying https://queue.taskcluster.net/v1/task/IrV7ePewRYmMaRPuHkUP8Q/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 08:12:00 INFO - Downloading https://queue.taskcluster.net/v1/task/IrV7ePewRYmMaRPuHkUP8Q/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 08:12:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IrV7ePewRYmMaRPuHkUP8Q/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 08:12:01 INFO - Downloaded 1165 bytes. 08:12:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 08:12:01 INFO - Using the following test package requirements: 08:12:01 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 08:12:01 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:12:01 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 08:12:01 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:12:01 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 08:12:01 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:12:01 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:12:01 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 08:12:01 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 08:12:01 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:12:01 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 08:12:01 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:12:01 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 08:12:01 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:12:01 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 08:12:01 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:12:01 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 08:12:01 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 08:12:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IrV7ePewRYmMaRPuHkUP8Q/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 08:12:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IrV7ePewRYmMaRPuHkUP8Q/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 08:12:01 INFO - Fetch https://queue.taskcluster.net/v1/task/IrV7ePewRYmMaRPuHkUP8Q/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 08:12:02 INFO - Http code: 200 08:12:02 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 08:12:02 INFO - x-amz-cf-id: uPUDxzyE4tzcv5wqDX3ERZU1In5JHmCdznAsXNk8t58yRTdCfd5dKQ== 08:12:02 INFO - x-amz-version-id: 9lzT4OaYDBQgx_h6.InPdWpEVcBEWHhk 08:12:02 INFO - Expected file size: 16093083 08:12:02 INFO - Obtained file size: 16093083 08:12:09 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 08:12:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IrV7ePewRYmMaRPuHkUP8Q/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 08:12:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IrV7ePewRYmMaRPuHkUP8Q/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 08:12:09 INFO - Fetch https://queue.taskcluster.net/v1/task/IrV7ePewRYmMaRPuHkUP8Q/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 08:12:09 INFO - Http code: 200 08:12:09 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 08:12:09 INFO - x-amz-cf-id: tdvYWTMCkklyKT77mFEhooJMFC2Ral4jpIhB3kfpcGWf73g7vrAd6g== 08:12:09 INFO - x-amz-version-id: 9lzT4OaYDBQgx_h6.InPdWpEVcBEWHhk 08:12:10 INFO - Expected file size: 16093083 08:12:10 INFO - Obtained file size: 16093083 08:12:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IrV7ePewRYmMaRPuHkUP8Q/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 08:12:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IrV7ePewRYmMaRPuHkUP8Q/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 08:12:16 INFO - Fetch https://queue.taskcluster.net/v1/task/IrV7ePewRYmMaRPuHkUP8Q/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 08:12:16 INFO - Http code: 200 08:12:16 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 08:12:16 INFO - x-amz-cf-id: KAMQwZTjPHTXgFg2jPkGtdfzFAeKAZF2CwdmF2IFm0RQymuDrtL9cA== 08:12:16 INFO - x-amz-version-id: 4.P5hJPHq3gUfP2Xzy7VzXvNm1enP.8N 08:12:17 INFO - Expected file size: 14403005 08:12:17 INFO - Obtained file size: 14403005 08:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:17 INFO - trying https://queue.taskcluster.net/v1/task/IrV7ePewRYmMaRPuHkUP8Q/artifacts/public/build/firefox-52.0.en-US.mac.dmg 08:12:17 INFO - Downloading https://queue.taskcluster.net/v1/task/IrV7ePewRYmMaRPuHkUP8Q/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 08:12:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IrV7ePewRYmMaRPuHkUP8Q/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 08:12:19 INFO - Downloaded 82139419 bytes. 08:12:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IrV7ePewRYmMaRPuHkUP8Q/artifacts/public/build/firefox-52.0.en-US.mac.dmg 08:12:19 INFO - mkdir: /builds/slave/test/properties 08:12:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:12:19 INFO - Writing to file /builds/slave/test/properties/build_url 08:12:19 INFO - Contents: 08:12:19 INFO - build_url:https://queue.taskcluster.net/v1/task/IrV7ePewRYmMaRPuHkUP8Q/artifacts/public/build/firefox-52.0.en-US.mac.dmg 08:12:20 INFO - Running post-action listener: _resource_record_post_action 08:12:20 INFO - Running post-action listener: set_extra_try_arguments 08:12:20 INFO - [mozharness: 2017-02-17 16:12:20.406225Z] Finished download-and-extract step (success) 08:12:20 INFO - [mozharness: 2017-02-17 16:12:20.406370Z] Running populate-webroot step. 08:12:20 INFO - Running pre-action listener: _resource_record_pre_action 08:12:20 INFO - Running main action method: populate_webroot 08:12:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:12:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:12:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:12:20 INFO - '--tppagecycles', 08:12:20 INFO - '7'], 08:12:20 INFO - 'tests': ['tsvgm']}}, 08:12:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:12:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:12:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:12:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:12:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:12:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:12:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:20 INFO - 'talos_options': ['--disable-e10s'], 08:12:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:12:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:12:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:20 INFO - 'talos_options': ['--disable-e10s'], 08:12:20 INFO - 'tests': ['damp', 'tps']}, 08:12:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:20 INFO - 'tests': ['damp', 'tps']}, 08:12:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:12:20 INFO - 'tests': ['dromaeo_dom']}, 08:12:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:12:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:12:20 INFO - 'tests': ['basic_compositor_video']}, 08:12:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:12:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:12:20 INFO - 'tests': ['a11yr', 08:12:20 INFO - 'ts_paint', 08:12:20 INFO - 'tpaint', 08:12:20 INFO - 'sessionrestore', 08:12:20 INFO - 'sessionrestore_no_auto_restore', 08:12:20 INFO - 'tabpaint']}, 08:12:20 INFO - 'other-e10s': {'tests': ['a11yr', 08:12:20 INFO - 'ts_paint', 08:12:20 INFO - 'tpaint', 08:12:20 INFO - 'sessionrestore', 08:12:20 INFO - 'sessionrestore_no_auto_restore', 08:12:20 INFO - 'tabpaint']}, 08:12:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:12:20 INFO - 'ts_paint', 08:12:20 INFO - 'tpaint', 08:12:20 INFO - 'sessionrestore', 08:12:20 INFO - 'sessionrestore_no_auto_restore', 08:12:20 INFO - 'tabpaint']}, 08:12:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:12:20 INFO - 'ts_paint', 08:12:20 INFO - 'tpaint', 08:12:20 INFO - 'sessionrestore', 08:12:20 INFO - 'sessionrestore_no_auto_restore', 08:12:20 INFO - 'tabpaint']}, 08:12:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:12:20 INFO - 'tests': ['a11yr', 08:12:20 INFO - 'ts_paint', 08:12:20 INFO - 'tpaint', 08:12:20 INFO - 'sessionrestore', 08:12:20 INFO - 'sessionrestore_no_auto_restore', 08:12:20 INFO - 'tabpaint']}, 08:12:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:12:20 INFO - 'tests': ['a11yr', 08:12:20 INFO - 'ts_paint', 08:12:20 INFO - 'tpaint', 08:12:20 INFO - 'sessionrestore', 08:12:20 INFO - 'sessionrestore_no_auto_restore', 08:12:20 INFO - 'tabpaint']}, 08:12:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:12:20 INFO - 'tests': ['tsvgx', 08:12:20 INFO - 'tsvgr_opacity', 08:12:20 INFO - 'tart', 08:12:20 INFO - 'tscrollx', 08:12:20 INFO - 'cart']}, 08:12:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:12:20 INFO - 'tsvgr_opacity', 08:12:20 INFO - 'tart', 08:12:20 INFO - 'tscrollx', 08:12:20 INFO - 'cart']}, 08:12:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:20 INFO - 'talos_options': ['--disable-e10s'], 08:12:20 INFO - 'tests': ['tp5o']}, 08:12:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:20 INFO - 'tests': ['tp5o']}, 08:12:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:20 INFO - 'talos_options': ['--disable-e10s', 08:12:20 INFO - '--xperf_path', 08:12:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:12:20 INFO - 'tests': ['tp5n']}, 08:12:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:20 INFO - 'talos_options': ['--xperf_path', 08:12:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:12:20 INFO - 'tests': ['tp5n']}}, 08:12:20 INFO - 'talos.zip': {'path': '', 08:12:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:12:20 INFO - Running post-action listener: _resource_record_post_action 08:12:20 INFO - [mozharness: 2017-02-17 16:12:20.425492Z] Finished populate-webroot step (success) 08:12:20 INFO - [mozharness: 2017-02-17 16:12:20.425620Z] Running create-virtualenv step. 08:12:20 INFO - Running pre-action listener: _resource_record_pre_action 08:12:20 INFO - Running main action method: create_virtualenv 08:12:20 INFO - Creating virtualenv /builds/slave/test/build/venv 08:12:20 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:12:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:12:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:12:20 INFO - Using real prefix '/tools/python27' 08:12:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:12:21 INFO - Installing distribute.............................................................................................................................................................................................done. 08:12:24 INFO - Installing pip.................done. 08:12:24 INFO - Return code: 0 08:12:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:12:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:12:24 INFO - Reading from file tmpfile_stdout 08:12:24 INFO - Output received: 08:12:24 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:12:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:12:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f73490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ee9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ca948c9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d87d30>, '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 0x107beddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d7fb20>, '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.kMaiYpvaaF/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.CdUdADfdoi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:12:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:12:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:12:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kMaiYpvaaF/Render', 08:12:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:12:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:12:24 INFO - 'HOME': '/Users/cltbld', 08:12:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:12:24 INFO - 'LOGNAME': 'cltbld', 08:12:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:24 INFO - 'MOZ_NO_REMOTE': '1', 08:12:24 INFO - 'NO_EM_RESTART': '1', 08:12:24 INFO - 'PAGER': '/bin/cat', 08:12:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:12:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:24 INFO - 'PWD': '/builds/slave/test', 08:12:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:12:24 INFO - 'SHELL': '/bin/bash', 08:12:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CdUdADfdoi/Listeners', 08:12:24 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 08:12:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:12:24 INFO - 'USER': 'cltbld', 08:12:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:12:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:12:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:24 INFO - 'XPC_FLAGS': '0x0', 08:12:24 INFO - 'XPC_SERVICE_NAME': '0', 08:12:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:12:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:24 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:12:24 INFO - Cleaning up... 08:12:24 INFO - Return code: 0 08:12:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:12:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f73490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ee9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ca948c9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d87d30>, '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 0x107beddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d7fb20>, '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.kMaiYpvaaF/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.CdUdADfdoi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:12:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:12:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:12:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kMaiYpvaaF/Render', 08:12:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:12:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:12:24 INFO - 'HOME': '/Users/cltbld', 08:12:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:12:24 INFO - 'LOGNAME': 'cltbld', 08:12:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:24 INFO - 'MOZ_NO_REMOTE': '1', 08:12:24 INFO - 'NO_EM_RESTART': '1', 08:12:24 INFO - 'PAGER': '/bin/cat', 08:12:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:12:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:24 INFO - 'PWD': '/builds/slave/test', 08:12:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:12:24 INFO - 'SHELL': '/bin/bash', 08:12:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CdUdADfdoi/Listeners', 08:12:24 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 08:12:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:12:24 INFO - 'USER': 'cltbld', 08:12:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:12:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:12:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:24 INFO - 'XPC_FLAGS': '0x0', 08:12:24 INFO - 'XPC_SERVICE_NAME': '0', 08:12:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:12:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:24 INFO - Downloading/unpacking psutil>=3.1.1 08:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:12:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:12:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:12:28 INFO - Installing collected packages: psutil 08:12:28 INFO - Running setup.py install for psutil 08:12:29 INFO - building 'psutil._psutil_osx' extension 08:12:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:12:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:12:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:12:29 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:12:29 INFO - building 'psutil._psutil_posix' extension 08:12:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:12:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:12:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:12:29 INFO - ^ 08:12:29 INFO - 1 warning generated. 08:12:29 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:12:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:12:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:12:29 INFO - Successfully installed psutil 08:12:29 INFO - Cleaning up... 08:12:29 INFO - Return code: 0 08:12:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:12:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f73490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ee9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ca948c9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d87d30>, '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 0x107beddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d7fb20>, '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.kMaiYpvaaF/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.CdUdADfdoi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:12:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:12:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:12:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kMaiYpvaaF/Render', 08:12:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:12:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:12:29 INFO - 'HOME': '/Users/cltbld', 08:12:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:12:29 INFO - 'LOGNAME': 'cltbld', 08:12:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:29 INFO - 'MOZ_NO_REMOTE': '1', 08:12:29 INFO - 'NO_EM_RESTART': '1', 08:12:29 INFO - 'PAGER': '/bin/cat', 08:12:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:12:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:29 INFO - 'PWD': '/builds/slave/test', 08:12:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:12:29 INFO - 'SHELL': '/bin/bash', 08:12:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CdUdADfdoi/Listeners', 08:12:29 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 08:12:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:12:29 INFO - 'USER': 'cltbld', 08:12:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:12:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:12:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:29 INFO - 'XPC_FLAGS': '0x0', 08:12:29 INFO - 'XPC_SERVICE_NAME': '0', 08:12:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:12:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:12:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:12:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:12:32 INFO - Installing collected packages: mozsystemmonitor 08:12:32 INFO - Running setup.py install for mozsystemmonitor 08:12:32 INFO - Successfully installed mozsystemmonitor 08:12:32 INFO - Cleaning up... 08:12:33 INFO - Return code: 0 08:12:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:33 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 0x107f73490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ee9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ca948c9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d87d30>, '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 0x107beddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d7fb20>, '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.kMaiYpvaaF/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.CdUdADfdoi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:12:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:12:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kMaiYpvaaF/Render', 08:12:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:12:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:12:33 INFO - 'HOME': '/Users/cltbld', 08:12:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:12:33 INFO - 'LOGNAME': 'cltbld', 08:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:33 INFO - 'MOZ_NO_REMOTE': '1', 08:12:33 INFO - 'NO_EM_RESTART': '1', 08:12:33 INFO - 'PAGER': '/bin/cat', 08:12:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:33 INFO - 'PWD': '/builds/slave/test', 08:12:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:12:33 INFO - 'SHELL': '/bin/bash', 08:12:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CdUdADfdoi/Listeners', 08:12:33 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 08:12:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:12:33 INFO - 'USER': 'cltbld', 08:12:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:12:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:33 INFO - 'XPC_FLAGS': '0x0', 08:12:33 INFO - 'XPC_SERVICE_NAME': '0', 08:12:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:12:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:33 INFO - Downloading/unpacking jsonschema==2.5.1 08:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:12:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:36 INFO - Downloading functools32-3.2.3-2.tar.gz 08:12:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:12:36 INFO - warning: no files found matching '*.txt' 08:12:36 INFO - no previously-included directories found matching 'build' 08:12:36 INFO - no previously-included directories found matching 'dist' 08:12:36 INFO - no previously-included directories found matching '.git*' 08:12:36 INFO - Installing collected packages: jsonschema, functools32 08:12:36 INFO - Running setup.py install for functools32 08:12:36 INFO - warning: no files found matching '*.txt' 08:12:36 INFO - no previously-included directories found matching 'build' 08:12:36 INFO - no previously-included directories found matching 'dist' 08:12:36 INFO - no previously-included directories found matching '.git*' 08:12:36 INFO - Successfully installed jsonschema functools32 08:12:36 INFO - Cleaning up... 08:12:36 INFO - Return code: 0 08:12:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107f73490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ee9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ca948c9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d87d30>, '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 0x107beddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d7fb20>, '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.kMaiYpvaaF/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.CdUdADfdoi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:12:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:12:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:12:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kMaiYpvaaF/Render', 08:12:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:12:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:12:36 INFO - 'HOME': '/Users/cltbld', 08:12:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:12:36 INFO - 'LOGNAME': 'cltbld', 08:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:36 INFO - 'MOZ_NO_REMOTE': '1', 08:12:36 INFO - 'NO_EM_RESTART': '1', 08:12:36 INFO - 'PAGER': '/bin/cat', 08:12:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:36 INFO - 'PWD': '/builds/slave/test', 08:12:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:12:36 INFO - 'SHELL': '/bin/bash', 08:12:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CdUdADfdoi/Listeners', 08:12:36 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 08:12:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:12:36 INFO - 'USER': 'cltbld', 08:12:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:12:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:36 INFO - 'XPC_FLAGS': '0x0', 08:12:36 INFO - 'XPC_SERVICE_NAME': '0', 08:12:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:12:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:12:36 INFO - Cleaning up... 08:12:36 INFO - Return code: 0 08:12:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f73490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ee9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ca948c9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d87d30>, '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 0x107beddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d7fb20>, '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.kMaiYpvaaF/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.CdUdADfdoi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:12:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:12:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:12:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kMaiYpvaaF/Render', 08:12:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:12:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:12:36 INFO - 'HOME': '/Users/cltbld', 08:12:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:12:36 INFO - 'LOGNAME': 'cltbld', 08:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:36 INFO - 'MOZ_NO_REMOTE': '1', 08:12:36 INFO - 'NO_EM_RESTART': '1', 08:12:36 INFO - 'PAGER': '/bin/cat', 08:12:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:36 INFO - 'PWD': '/builds/slave/test', 08:12:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:12:36 INFO - 'SHELL': '/bin/bash', 08:12:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CdUdADfdoi/Listeners', 08:12:36 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 08:12:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:12:36 INFO - 'USER': 'cltbld', 08:12:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:12:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:36 INFO - 'XPC_FLAGS': '0x0', 08:12:36 INFO - 'XPC_SERVICE_NAME': '0', 08:12:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:12:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:37 INFO - Downloading/unpacking blobuploader==1.2.4 08:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:39 INFO - Downloading blobuploader-1.2.4.tar.gz 08:12:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:12:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:12:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:41 INFO - Downloading docopt-0.6.1.tar.gz 08:12:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:12:41 INFO - Installing collected packages: blobuploader, requests, docopt 08:12:41 INFO - Running setup.py install for blobuploader 08:12:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:12:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:12:41 INFO - Running setup.py install for requests 08:12:41 INFO - Running setup.py install for docopt 08:12:41 INFO - Successfully installed blobuploader requests docopt 08:12:41 INFO - Cleaning up... 08:12:42 INFO - Return code: 0 08:12:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:12:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:42 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 0x107f73490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ee9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ca948c9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d87d30>, '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 0x107beddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d7fb20>, '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.kMaiYpvaaF/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.CdUdADfdoi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:12:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:12:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:12:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kMaiYpvaaF/Render', 08:12:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:12:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:12:42 INFO - 'HOME': '/Users/cltbld', 08:12:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:12:42 INFO - 'LOGNAME': 'cltbld', 08:12:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:42 INFO - 'MOZ_NO_REMOTE': '1', 08:12:42 INFO - 'NO_EM_RESTART': '1', 08:12:42 INFO - 'PAGER': '/bin/cat', 08:12:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:12:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:42 INFO - 'PWD': '/builds/slave/test', 08:12:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:12:42 INFO - 'SHELL': '/bin/bash', 08:12:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CdUdADfdoi/Listeners', 08:12:42 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 08:12:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:12:42 INFO - 'USER': 'cltbld', 08:12:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:12:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:12:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:42 INFO - 'XPC_FLAGS': '0x0', 08:12:42 INFO - 'XPC_SERVICE_NAME': '0', 08:12:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:12:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:12:42 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-jPVlP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:12:42 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-WUIFii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:12:42 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-VuDJC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:12:42 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-oCf0kE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:12:42 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-5EcCtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:12:42 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-z9Jj3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:12:42 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-EWZX3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:12:43 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-JK_hPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:12:43 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-kcnfro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:12:43 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-w52jS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:12:43 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-pKmw9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:12:43 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-lR1RTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:12:43 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-TLU6yT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:12:43 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-DOYBUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:12:43 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-xBUQ4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:12:43 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-m6j7qD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:12:43 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-6Sn0xS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:12:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:12:44 INFO - Running setup.py install for manifestparser 08:12:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:12:44 INFO - Running setup.py install for mozcrash 08:12:44 INFO - Running setup.py install for mozdebug 08:12:44 INFO - Running setup.py install for mozdevice 08:12:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:12:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:12:44 INFO - Running setup.py install for mozfile 08:12:44 INFO - Running setup.py install for mozhttpd 08:12:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:12:44 INFO - Running setup.py install for mozinfo 08:12:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:12:45 INFO - Running setup.py install for mozInstall 08:12:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:12:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:12:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:12:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:12:45 INFO - Running setup.py install for mozleak 08:12:45 INFO - Running setup.py install for mozlog 08:12:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:12:45 INFO - Running setup.py install for moznetwork 08:12:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:12:45 INFO - Running setup.py install for mozprocess 08:12:45 INFO - Running setup.py install for mozprofile 08:12:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:12:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:12:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:12:46 INFO - Running setup.py install for mozrunner 08:12:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:12:46 INFO - Running setup.py install for mozscreenshot 08:12:46 INFO - Running setup.py install for moztest 08:12:46 INFO - Running setup.py install for mozversion 08:12:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:12:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:12:46 INFO - Cleaning up... 08:12:46 INFO - Return code: 0 08:12:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f73490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ee9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ca948c9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d87d30>, '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 0x107beddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d7fb20>, '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.kMaiYpvaaF/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.CdUdADfdoi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:12:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:12:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:12:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kMaiYpvaaF/Render', 08:12:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:12:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:12:46 INFO - 'HOME': '/Users/cltbld', 08:12:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:12:46 INFO - 'LOGNAME': 'cltbld', 08:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:46 INFO - 'MOZ_NO_REMOTE': '1', 08:12:46 INFO - 'NO_EM_RESTART': '1', 08:12:46 INFO - 'PAGER': '/bin/cat', 08:12:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:46 INFO - 'PWD': '/builds/slave/test', 08:12:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:12:46 INFO - 'SHELL': '/bin/bash', 08:12:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CdUdADfdoi/Listeners', 08:12:46 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 08:12:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:12:46 INFO - 'USER': 'cltbld', 08:12:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:12:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:46 INFO - 'XPC_FLAGS': '0x0', 08:12:46 INFO - 'XPC_SERVICE_NAME': '0', 08:12:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:12:46 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-J4VIaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:12:47 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-tBMbGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:12:47 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-vxrDc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:12:47 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-2A1Tcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:12:47 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-6w7wNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:12:47 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-1m0LUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:12:47 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-k4gJYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:12:47 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-ZUQ_Jr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:12:47 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-YtOXsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:12:47 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-y8_YW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:12:48 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-U01iSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:12:48 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-tCnuvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:12:48 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-9VebFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:12:48 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-ubb47t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:12:48 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-uUiMta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:12:48 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-Aq7JJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:12:48 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-_IybZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:12:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:51 INFO - Downloading blessings-1.6.tar.gz 08:12:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:12:51 INFO - Installing collected packages: blessings 08:12:51 INFO - Running setup.py install for blessings 08:12:51 INFO - Successfully installed blessings 08:12:51 INFO - Cleaning up... 08:12:51 INFO - Return code: 0 08:12:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:12:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:12:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:12:52 INFO - Reading from file tmpfile_stdout 08:12:52 INFO - Current package versions: 08:12:52 INFO - blessings == 1.6 08:12:52 INFO - blobuploader == 1.2.4 08:12:52 INFO - docopt == 0.6.1 08:12:52 INFO - functools32 == 3.2.3-2 08:12:52 INFO - jsonschema == 2.5.1 08:12:52 INFO - manifestparser == 1.1 08:12:52 INFO - mozInstall == 1.12 08:12:52 INFO - mozcrash == 1.0 08:12:52 INFO - mozdebug == 0.1 08:12:52 INFO - mozdevice == 0.48 08:12:52 INFO - mozfile == 1.2 08:12:52 INFO - mozhttpd == 0.7 08:12:52 INFO - mozinfo == 0.9 08:12:52 INFO - mozleak == 0.1 08:12:52 INFO - mozlog == 3.4 08:12:52 INFO - moznetwork == 0.27 08:12:52 INFO - mozprocess == 0.23 08:12:52 INFO - mozprofile == 0.28 08:12:52 INFO - mozrunner == 6.13 08:12:52 INFO - mozscreenshot == 0.1 08:12:52 INFO - mozsystemmonitor == 0.3 08:12:52 INFO - moztest == 0.8 08:12:52 INFO - mozversion == 1.4 08:12:52 INFO - psutil == 3.1.1 08:12:52 INFO - requests == 1.2.3 08:12:52 INFO - wsgiref == 0.1.2 08:12:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:52 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 0x107f73490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ee9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ca948c9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d87d30>, '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 0x107beddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d7fb20>, '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.kMaiYpvaaF/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.CdUdADfdoi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:12:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:12:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kMaiYpvaaF/Render', 08:12:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:12:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:12:52 INFO - 'HOME': '/Users/cltbld', 08:12:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:12:52 INFO - 'LOGNAME': 'cltbld', 08:12:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:52 INFO - 'MOZ_NO_REMOTE': '1', 08:12:52 INFO - 'NO_EM_RESTART': '1', 08:12:52 INFO - 'PAGER': '/bin/cat', 08:12:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:12:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:52 INFO - 'PWD': '/builds/slave/test', 08:12:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:12:52 INFO - 'SHELL': '/bin/bash', 08:12:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CdUdADfdoi/Listeners', 08:12:52 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 08:12:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:12:52 INFO - 'USER': 'cltbld', 08:12:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:12:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:12:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:52 INFO - 'XPC_FLAGS': '0x0', 08:12:52 INFO - 'XPC_SERVICE_NAME': '0', 08:12:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:12:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:12:52 INFO - Cleaning up... 08:12:52 INFO - Return code: 0 08:12:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f73490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ee9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ca948c9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d87d30>, '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 0x107beddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d7fb20>, '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.kMaiYpvaaF/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.CdUdADfdoi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:12:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:12:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kMaiYpvaaF/Render', 08:12:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:12:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:12:52 INFO - 'HOME': '/Users/cltbld', 08:12:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:12:52 INFO - 'LOGNAME': 'cltbld', 08:12:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:52 INFO - 'MOZ_NO_REMOTE': '1', 08:12:52 INFO - 'NO_EM_RESTART': '1', 08:12:52 INFO - 'PAGER': '/bin/cat', 08:12:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:12:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:52 INFO - 'PWD': '/builds/slave/test', 08:12:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:12:52 INFO - 'SHELL': '/bin/bash', 08:12:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CdUdADfdoi/Listeners', 08:12:52 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 08:12:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:12:52 INFO - 'USER': 'cltbld', 08:12:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:12:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:12:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:52 INFO - 'XPC_FLAGS': '0x0', 08:12:52 INFO - 'XPC_SERVICE_NAME': '0', 08:12:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:12:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:12:52 INFO - Cleaning up... 08:12:52 INFO - Return code: 0 08:12:52 INFO - Running post-action listener: _resource_record_post_action 08:12:52 INFO - Running post-action listener: _start_resource_monitoring 08:12:52 INFO - Starting resource monitoring. 08:12:52 INFO - [mozharness: 2017-02-17 16:12:52.661291Z] Finished create-virtualenv step (success) 08:12:52 INFO - [mozharness: 2017-02-17 16:12:52.662343Z] Running install step. 08:12:52 INFO - Running pre-action listener: _resource_record_pre_action 08:12:52 INFO - Running main action method: install 08:12:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:12:52 INFO - Reading from file tmpfile_stdout 08:12:52 INFO - Detecting whether we're running mozinstall >=1.0... 08:12:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:12:53 INFO - Reading from file tmpfile_stdout 08:12:53 INFO - Output received: 08:12:53 INFO - Usage: mozinstall [options] installer 08:12:53 INFO - Options: 08:12:53 INFO - -h, --help show this help message and exit 08:12:53 INFO - -d DEST, --destination=DEST 08:12:53 INFO - Directory to install application into. [default: 08:12:53 INFO - "/builds/slave/test"] 08:12:53 INFO - --app=APP Application being installed. [default: firefox] 08:12:53 INFO - mkdir: /builds/slave/test/build/application 08:12:53 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'] 08:12:53 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 08:13:14 INFO - Reading from file tmpfile_stdout 08:13:14 INFO - Output received: 08:13:14 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:13:14 INFO - Running post-action listener: _resource_record_post_action 08:13:14 INFO - [mozharness: 2017-02-17 16:13:14.134742Z] Finished install step (success) 08:13:14 INFO - [mozharness: 2017-02-17 16:13:14.134891Z] Running run-tests step. 08:13:14 INFO - Running pre-action listener: _resource_record_pre_action 08:13:14 INFO - Running main action method: run_tests 08:13:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:13:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:13:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:13:14 INFO - 2017-02-17 08:13:14.149 screenresolution[2311:75167] starting screenresolution argv=screenresolution get 08:13:14 INFO - 2017-02-17 08:13:14.152 screenresolution[2311:75167] Display 0: 1600x1200x32@60 08:13:14 INFO - 2017-02-17 08:13:14.158 screenresolution[2312:75170] starting screenresolution argv=screenresolution list 08:13:14 INFO - Available Modes on Display 0 08:13:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:13:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:13:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:13:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:13:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:13:14 INFO - Intel Iris: 08:13:14 INFO - Chipset Model: Intel Iris 08:13:14 INFO - Type: GPU 08:13:14 INFO - Bus: Built-In 08:13:14 INFO - VRAM (Dynamic, Max): 1536 MB 08:13:14 INFO - Vendor: Intel (0x8086) 08:13:14 INFO - Device ID: 0x0a2e 08:13:14 INFO - Revision ID: 0x0009 08:13:14 INFO - Displays: 08:13:14 INFO - Display: 08:13:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:13:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:13:14 INFO - Display Serial Number: 1600x1200 60 08:13:14 INFO - Main Display: Yes 08:13:14 INFO - Mirror: Off 08:13:14 INFO - Online: Yes 08:13:14 INFO - Rotation: Supported 08:13:14 INFO - Return code: 0 08:13:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:13:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:13:14 INFO - Python 2.7.3 08:13:14 INFO - Return code: 0 08:13:14 INFO - grabbing minidump binary from tooltool 08:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:14 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 0x107d87d30>, '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 0x107beddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d7fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:13:14 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:13:14 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:13:14 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:13:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:13:14 INFO - Return code: 0 08:13:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:13:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:13:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:13:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:13:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:13:14 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/IrV7ePewRYmMaRPuHkUP8Q/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0342', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:13:14 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/IrV7ePewRYmMaRPuHkUP8Q/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0342 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:13:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kMaiYpvaaF/Render', 08:13:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:13:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:13:14 INFO - 'HOME': '/Users/cltbld', 08:13:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:13:14 INFO - 'LOGNAME': 'cltbld', 08:13:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:13:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:13:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:14 INFO - 'MOZ_NO_REMOTE': '1', 08:13:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:13:14 INFO - 'NO_EM_RESTART': '1', 08:13:14 INFO - 'PAGER': '/bin/cat', 08:13:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:13:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:14 INFO - 'PWD': '/builds/slave/test', 08:13:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:13:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:13:14 INFO - 'SHELL': '/bin/bash', 08:13:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CdUdADfdoi/Listeners', 08:13:14 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 08:13:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:13:14 INFO - 'USER': 'cltbld', 08:13:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:13:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:13:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:14 INFO - 'XPC_FLAGS': '0x0', 08:13:14 INFO - 'XPC_SERVICE_NAME': '0', 08:13:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:13:14 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/IrV7ePewRYmMaRPuHkUP8Q/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0342', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:13:14 INFO - mozversion application_buildid: 20170217064138 08:13:14 INFO - mozversion application_changeset: 546f359ac8c0dbb466e6b307a0f906ea6df62a45 08:13:14 INFO - mozversion application_display_name: Firefox 08:13:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:13:14 INFO - mozversion application_name: Firefox 08:13:14 INFO - mozversion application_remotingname: firefox 08:13:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:13:14 INFO - mozversion application_vendor: Mozilla 08:13:14 INFO - mozversion application_version: 52.0 08:13:14 INFO - mozversion platform_buildid: 20170217064138 08:13:14 INFO - mozversion platform_changeset: 546f359ac8c0dbb466e6b307a0f906ea6df62a45 08:13:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:13:14 INFO - mozversion platform_version: 52.0 08:13:14 INFO - using testdate: 1487347994 08:13:14 INFO - actual date: 1487347994 08:13:14 INFO - starting webserver on 'localhost:60491' 08:13:14 INFO - SUITE-START | Running 2 tests 08:13:14 INFO - TEST-START | dromaeo_css 08:13:14 INFO - operating with platform_type : mac_ 08:13:14 INFO - Initialising browser for dromaeo_css test... 08:13:14 INFO - TEST-INFO | started process 2322 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/tmpG5cqaX/profile http://localhost:60491/getInfo.html) 08:13:17 INFO - PROCESS | 2322 | __metrics Screen width/height:1600/1200 08:13:17 INFO - PROCESS | 2322 | colorDepth:24 08:13:17 INFO - PROCESS | 2322 | Browser inner width/height: 1024/689 08:13:17 INFO - PROCESS | 2322 | __metrics 08:13:17 INFO - PROCESS | 2322 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:13:17 INFO - PROCESS | 2322 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:13:18 INFO - TEST-INFO | 2322: exit 0 08:13:18 INFO - Browser initialized. 08:13:18 INFO - Running cycle 1/1 for dromaeo_css test... 08:13:18 INFO - TEST-INFO | started process 2325 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/tmpG5cqaX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:13:30 INFO - PROCESS | 2325 | RSS: Main: 168243200 08:13:30 INFO - PROCESS | 2325 | 08:16:34 INFO - PROCESS | 2325 | Cycle 1(1): loaded http://localhost:60491/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60491/tests/dromaeo/cssquery-ext.html) 08:16:36 INFO - PROCESS | 2325 | RSS: Main: 319864832 08:16:36 INFO - PROCESS | 2325 | 08:19:39 INFO - PROCESS | 2325 | Cycle 1(1): loaded http://localhost:60491/tests/dromaeo/cssquery-ext.html (next: http://localhost:60491/tests/dromaeo/cssquery-jquery.html) 08:19:39 INFO - PROCESS | 2325 | RSS: Main: 305143808 08:19:39 INFO - PROCESS | 2325 | 08:22:42 INFO - PROCESS | 2325 | Cycle 1(1): loaded http://localhost:60491/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60491/tests/dromaeo/cssquery-mootools.html) 08:22:42 INFO - PROCESS | 2325 | RSS: Main: 284356608 08:22:42 INFO - PROCESS | 2325 | 08:25:45 INFO - PROCESS | 2325 | Cycle 1(1): loaded http://localhost:60491/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60491/tests/dromaeo/cssquery-prototype.html) 08:25:45 INFO - PROCESS | 2325 | RSS: Main: 285921280 08:25:45 INFO - PROCESS | 2325 | 08:28:49 INFO - PROCESS | 2325 | Cycle 1(1): loaded http://localhost:60491/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60491/tests/dromaeo/cssquery-yui.html) 08:28:49 INFO - PROCESS | 2325 | RSS: Main: 270692352 08:28:49 INFO - PROCESS | 2325 | 08:31:52 INFO - PROCESS | 2325 | Cycle 1(1): loaded http://localhost:60491/tests/dromaeo/cssquery-yui.html (next: http://localhost:60491/tests/dromaeo/cssquery-dojo.html) 08:31:53 INFO - PROCESS | 2325 | RSS: Main: 426774528 08:31:53 INFO - PROCESS | 2325 | 08:31:53 INFO - PROCESS | 2325 | __start_tp_report 08:31:53 INFO - PROCESS | 2325 | _x_x_mozilla_page_load 08:31:53 INFO - PROCESS | 2325 | _x_x_mozilla_page_load_details 08:31:53 INFO - PROCESS | 2325 | |i|pagename|runs| 08:31:53 INFO - PROCESS | 2325 | |0;dojo.html;3463.7402194835386;3480.1299675081245;3485.8779942701995;3510.9122271943215;3550.6626870447317;5860.882782344351;5980.312264089631;6006.429389208024;6030.0954856771505;6035.6982150892445;5896.764129434828;5967.701614919259;5994.340622531518;5994.520438364932;6011.939880601192;5322;5335.573154147678;5365.061114305001;5412.539934105586;5467;5312.884294298202;5313.1764576490705;5313.1764576490705;5445.047116754572;5445.210444485548;5404.91892621611;5408.675479471224;5409.756560954766;5411.83764487064;5413.106837371829;5422.132458806572;5422.91865622016;5430.619856610039;5435.537979271767;5436.836894893159;5262.184361423985;5365.356157261114;5366.168243922199;5374.865628359284;5382.67703937765;6034.698265086772;6035.547333949971;6038.215032045806;6039.275286965592;6044.697765111727;6302.810915672537;6318.684065796738;6346.174997250328;6348.523860710465;6353.618782873043;6250;6276.811695649138;6302.18071650687;6307.148534947769;6335.081413195107;5898.643312038213;5935.703214839241;6012.0681294399;6012.75948962041;6055.545834062419;6263.968680156661;6427.260865000538;6486.351364863476;6493.123428337114;6573.80278591643;6124.299866451454;6186.597871138361;6206.937930620727;6213.378662133841;6344.048392741126;6300.558960872695;6331.746730130743;6354.046892966092;6358.554901156967;6377.362263773585;6271.184745982993;6274.843128921813;6276.560640755103;6286.717097730521;6309.779157729457;6210.689465526705;6261.467775239064;6261.9373806262265;6274.905876411857;6293.2762732285455;5129.3075434816565;5132.871678208075;5138.614603904722;5144.254083157921;5168.793248270027;4508.752018639007;4592.494825569184;4596.218642830727;4598.954010459853;4608.9308660370125;5902;5969.373215812364;6017.608855424383;6026.939730602726;6108.908366374508;6294.276158241769;6341.873162536724;6342.8414289642205;6358.777442789573;6362.713677884506;6027.547933904974;6066.817995460055;6073.423024812636;6087;6089.939100609025;5499.752511137009;5514.696691681996;5570.805021824298;5590.301212348457;5602.299712535933;6422.775202867971;6491;6497.220333560003;6500.837479063061;6511.446527045254;6316.336784637547;6325.304216536269;6328.683565821782;6329.620222786648;6333.746650133943;6223.3465486125115;6353.301136875032;6378.425941665272;6403.903941440789;6451.741930322923;6122.326544080237;6291;6306.211723534559;6308.27454842699;6311.526635502448;6298.559100862895;6304.306526282197;6316.05259211122;6317.368263173829;6337.429631333202;5930.644161350333;6134.620279381861;6236.501079913505;6242.969909964805;6297.370262973666;6205.6586887721605;6283.088952102011;6293.307736149111;6305.873882522415;6307.936920630735;6248.094026366242;6253.437190652863;6255.812325630239;6259.499240060693;6271.96864015677;6106.521339539896;6122.5811271886105;6193.504519638508;6264.49884009269;6290.9056364155485;6117.553376797748;6133.701927635063;6230.875382492234;6256.562040657111;6270.7491700331475 08:31:53 INFO - PROCESS | 2325 | |1;ext.html;488.93643826302576;504.8510689346642;532.75227019436;543.8803463238089;554.7974989128967;26730.797114129862;31831.68168318319;40318;41004.38493422601;41152.382714259234;43122.78438607811;43329.7833510832;43373.783131084376;43398.783006085;43553;9467.715968520939;9611.759706007337;9628.614855405775;9629.75925601862;9630.614775408976;8772.912270877305;8912.153345432174;8914.153155450222;9063.728088157366;9414.435133891955;8986.281097512183;11364.147688923322;11535.250208736446;11540.019098376606;11839.28964262147;11715.179937404386;11765.99989000936;11787.646370608896;11787.941060294643;11800.704982375424;11607.709807254801;11676.357800320979;11692.707682307926;11706.824397634042;11725.179237453382;34484.620615175365;40143.397849032284;40588.797056014824;40878.38682419766;40977.79511102426;3209.3420848725955;3217.742580593547;3271.9345613087844;3288.802671839673;3327.05179023977;29111.708882911324;29733.55399669007;31434.842825785952;31435.84282078575;31887.681123188704;3044.421559903611;3254.2840575073446;3255.9348813023607;3289.1448223461834;3365.9495107573407;493967;494621;495267;497211;498057;61153.776924461265;61552.076718849254;61606;61609.38390616126;61673.69163154245;62392.37607623956;62427;64237.35762642407;64255;64353.678231608545;15332.386704531917;15516.844831551765;15578.610534736723;15583.688326233638;15585.064896106043;11973.940130299292;12055.156139070355;12063.276203427822;12063.974562162315;12064.155509114278;13714.794278085637;14814.259287035606;15152.56050675184;16737.414190503274;16890.577735556708;6284.183056202664;6297.811065668037;7533.886991695129;7569.810754731176;7636.465447418738;867.3234876796109;925.3337596930199;932.4358762948455;1033.5865653738565;1070.0262760887556;29774.40451190964;29785.553216701766;29840.10479685613;30274;30282;788.6766425765524;1066.6586692258402;1100.4387762241315;1156.2368836567825;1174.48322737995;14119.78820317696;14546.054506457258;14566.781498277534;14882;15054.924725376522;398305;399495;402095.9790402058;403163;403178;48612.75693621509;48707.75646121747;53587.732061340226;53757;53782.73108634432;1389.8957578181476;1392.5474220878255;1435.5334516282041;1435.554977956816;1436.5115860607443;28571.571426429036;29083.41833163367;29427.705722943352;30153.698463015087;30162.09513714592;36244.81877590595;47489.52510474851;47522.76238618923;47581.762091189325;47892.76053619709;378289;380774.0961295176;389793;391017;392012;36296;36873.81563092167;37173.442398363506;37221;37345;41750.79124604479;42179;42676;42874;43000.78499607482;34593.48109778405;34975.82512087423;35033.82483087568;35130;35986;35079.298414031065;35154.94535163949;36101.458478122324;36226.27547449089;36332.27335453329;35073.33715168006;35378.46932295966;35402.29195416129;35501.467477988364;36269.45595816012;30279.848600756854;32177.678223217466;32213.51679724853;32250.032499025066;32264;19139.71290430617;23676.934537946177;23872.761272387055;23888.40278993039;24099.397515062265 08:31:53 INFO - PROCESS | 2325 | |2;jquery.html;376.77017019618046;376.9472273881655;384.1031192166292;390.585978862406;403.4835410674338;18931.810681893177;20746.481337966557;21711.6743248851;21906.78093219067;21989.34031979041;11748.882511174887;12258.957988570959;12267.447964841582;12284.201526900746;20084;5331.946680533193;5616.101423772197;5629.817738274967;5629.971850140764;5633.380328163898;5462.562994960414;5756.395578464264;6004.459598636122;6069.908951365733;6121.296050954131;6099.634021958675;6121.632702037892;6121.785737499188;6123.173371594845;6124.265088189423;5692.146178073281;5971.223740913697;6027.8794424111275;6073.5748497604745;6082.726277317532;5733.942660573424;5850.64896106235;5852.76588936442;5864.853378665525;5873.735681894325;13548.796768048487;13803.2408217548;13804.826589739883;13815.516456923959;24122.879385603133;2120.756113047004;2213.7896899794496;2259.920902768395;2347.178487529351;2847.8291302521916;9786.755331116708;10035.996400359905;10580.682579522627;13848.892088632885;14043.438262469488;1829.4785985993929;1840.8251216134445;1863.57137858292;1870.2238570993022;1870.3079860451585;76116.23883761147;105334;107492.43957911558;107892;124019;10663.946680266548;11754.236864470227;11897.821532677017;11930.22453540517;11951;15163.545093647208;15192.848071519144;15208.46770363032;15224.923875380553;15242.923785381003;8250.587470626444;8319.750407487785;8374.246317831425;8504.829903401896;8576.656933722581;7309.634518274065;8103.189681031849;8106.594670266463;8262.917370826215;8276.255137037695;4554.385158003627;4631.3516107744945;4636.2581986882615;4693.55411235932;4726.645501587326;1901.5626405926714;1951.4243298227057;1954.589536197386;1959.294653924586;1967.7737060237969;833.995830020846;843.3211264931666;930.2697382554662;932.0008581592447;970.4129001953858;17845.46463606094;20330;21097.68353474699;21116;21415.892920535298;821.5686764448593;917.9678711245208;921.8571121476182;938.0947385772625;941.1294552538874;10585.41780202081;10969.561217551209;11024.944875275733;11038.061764750086;11049.005589496985;501865;508903;508955;612507;618148;130654.69345306425;136562.31718841344;142139.28930355283;143237;149868;973.9074787895139;985.5515740338129;1019.3934608907837;1019.97450063749;1022.4580972084807;14002.649933751738;17924.641507170043;18228.635427291116;19248.903755481133;19366.61266774685;56502;58005;58163.83672326445;58837.94067207627;59117.81764364603;77308;81297.18702813133;81539.77690334768;82154.17845821465;84074;7786.961065194638;8188.918110818816;8538.957305213435;8693.26107280863;8698.782530436789;11373.374464404536;13161.47354105825;13174.011949103664;13560.11859229147;13652.795208071688;10050;10690.73273168177;11213.327200368005;11364.488598013275;11826.113041521749;11323.377214253294;11445.141614378788;11474.368909709712;11692.298462092302;11875.881241187823;10321.174306055347;10639.680809575726;11047.502862371051;11604.825927611262;12140.15018948665;8207.79480512968;8228.341732661253;8365.498070115813;8499.362547809063;8581.35639827028;6627.3372662733345;10664.573417063231;11304.9434752829;11530.423478825858;11732.296062236293 08:31:53 INFO - PROCESS | 2325 | |3;mootools.html;1367.0225788561177;1408.9506867259645;1480.748272793625;1592.2914303135103;1844.6864033114368;7448.36688881445;8181.795455113625;8350.123237060097;8362.289205417539;8506.91493085069;8309.210624990632;8359.91640083599;8385.203405676466;8390.748277551684;8394.580270986457;2338.9532209355802;2384.141708984764;2385.42749740062;2385.8687772172525;2393.198278576679;2357.6581395697613;2406.6991626046743;2407.614781634939;2409.831311808174;2419.9516009679796;2356.163561935514;2362.444825466014;2388.3312672451652;2392.617181251;2393.56915755164;1934.7230827653682;2334.4980829121737;2362.0433724341583;2367.3726462487452;2372.1934542255544;2361.7874391304695;2370.7866292033627;2389.414593424605;2397.3287479505766;2405.8315917885757;6851.931480685179;8405.873911891265;8466.74599762008;8470.534120623362;8476.83046339076;4508.571685689854;5098.847034588968;5100.617453690988;5287.47125287472;5294.311739473882;3046.6191726034244;3348.363810875926;3548.6273941236313;3574.7140228781636;3621.004223838439;1053.836655318427;1085.8968398002178;1112.777444511101;1120.9943950280197;1125.3360517294836;10830.241883068189;10877;10949.507272172772;10952.288101273392;10963.122950163968;4287.828486860491;4459.955400445954;4542.160425027869;4544.2047641662575;4560.498345182027;8748.95625521881;8792;8799.516026618598;8806.603702833389;8842.955785221033;5183.300254465675;5183.50756678115;5186.092433824066;5192.987367463384;5195.506426889439;4198.769067701306;4407.757573333497;4450.749534194836;4524.88687782808;4788.281757736368;3706.166112624692;3760.9059773505332;3855.094052897567;3857.18999010211;3859.556151042666;1164.342146687136;1173.184636677501;1180.3744015671707;1182.781185480689;1196.3180986837592;788.940829437783;913.6117150211134;921.6589861751061;940.6707652321769;947.3889341374775;4798.352222449925;5156.561692256125;5763.682997435181;5842.152887831241;5971.790987315423;847.9019669527976;990.782027953849;1005.1807776661997;1026.9435181065114;1073.5222825842582;3854.4411060396087;3908.159745654698;3918.8824335269987;4005.319095753729;4060.939085913714;9830.508474576385;10328.793424131476;10347.4308913009;10349.172066234683;10350.171986241083;9864.852027219598;10275;10290.331128476626;10295.073443389982;10309.587616495257;7730.458867879307;8078;8080.313173380328;8091.06952700447;8116.797080073045;5633.155026746021;5643.435656434488;5690.487856092972;5781.075027995501;5824.388439213822;9182.95408522953;9408.95295523518;9425.575849086945;9427.057294270518;9536.666216682383;9088.863667045132;9321.44071355721;9588.424694518351;9687.32188746781;9795.608175672893;7694.576798276148;7757.92242077572;7809.765707028798;7828.45200835936;7902.841943161219;7903.56530390834;7960.681572737026;7973.561454120079;7988.161243069394;7989.520628762293;7036.648167591702;7217.7473788417155;7275.054242948383;7320.853582928418;7356.227596102332;6977.476689248225;7047.823804404931;7070.222275549789;7135.964320178366;7140.500164988401;6718.294579069127;6757.425618822455;6864.450843932374;6864.691088900911;6880.002399651922;4842.539958703917;4947.950520494893;4951.603871690329;5035.420926593342;5054.646174767878;4827.517248275144;4912.435069966999;4958.479359667327;5030.346055012825;5132.999065182403 08:31:53 INFO - PROCESS | 2325 | |4;prototype.html;306.7760534809589;307.46654554348214;315.29531497103966;321.1377451542608;323.2226495278855;4803.255495398219;5004.374453193351;5022.7237501937425;5052.823151189705;5083.6187285953565;3894.4547763313158;4118.50577930648;4873.7806798694055;4897.3388592539995;4965.62757793166;3679.521662183926;3857.9421308680394;3886.203328317702;3891.2801131790566;3904.1996390739973;2978.91269686565;3203.5034569641743;3408.8295585220762;3898.3567711327737;3901.161250331178;3184.570083038783;3365.293288409437;3863.130795571002;3871.9806400968096;3898.941515877264;3141.701538353853;3388.4747864081105;3465.851172273207;3822.923541529182;3843.3082045231986;2786.7909906757072;3309.1892486341;3337.7997320160625;3362.9742928406827;3367.44437167867;4805.519448055202;4934.087193869145;4976.054549635558;4987.850364489072;4992.926520798046;3795.7532760370764;3801.904952376185;3828;4350.499692535335;4363.38912552243;4515.525869783658;5004.599632029429;5246.23929530216;5257.0023391111135;5266.9992701387;3070.2784845561273;3688.5020522229424;3720.2001569662384;3724.832382542792;3736.8505259789576;5160.354955630546;5211.905499845037;5407.621466497386;5440.183972404131;5564.777408903639;2776.7362100600412;3095.3963977024264;3547.7228197848754;3644.5421831267176;3679.448082787603;3119.688031196862;3276.5576647152807;3734.402495600691;3759.887203383903;3761.5486141663177;4066.877993660195;4318.546552611993;4318.589733975267;4347.7173983690955;4354.847580334736;4596.4024676791805;5129.897402051938;5261.736913154327;5293.444188360244;5317.680939143664;1009.77816841621;1175.3662409251149;1206.5897594817804;1245.6138597034949;1247.4074814463238;808.4260175275621;821.219841150909;821.3716506872247;824.4805772363493;840.6637345062024;4280.5505421930875;4679.438467383936;4729.233398461938;4742.33607294979;4749.762511874393;4987.102321582078;5094.2613321068975;5180.766865491062;5216.8004756170885;5286.682799031993;4781.52184781526;5016.6237532184505;5071.746412679425;5087.0414890266775;5093.847184584469;2387.653790200411;2456.273536374623;2575.562154433751;2687.683035312683;2737.7399147080996;5028.32117664118;5281.709505977208;5413.891722165535;5421.647592906527;5459.416769136985;4545;4771.735490095128;4843.95156048435;5397.460253974649;5645.266115405053;5348.411674715778;5702.572307076985;5712.600117991784;5735.394089654903;5741.511971482387;4397.954950947825;5297.034399764298;5466.961277357289;5525.613207075627;5565.554755619622;5143.662647711547;5428.538574221236;5440.619156659154;5468.91796623059;5505.504504594605;4876.707397556158;5618.85952851182;5676.489115979582;5684.919865225594;5715.771369145354;3539.681428671432;3692.781382143832;3719.702423806035;3734.8879533614036;3738.8783364990936;4988.45127036033;5436.9669762746535;5456.645318054314;5461.399246082849;5486.6982315973;4716.386869707053;5368.543673787772;5403.540699040625;5411.891762164656;5416.025115479251;5065.088284108896;5329.866753331198;5376.704281264411;5384.488473595002;5420.970015697005;4679.279972421865;5182.66779949032;5221.164613661796;5308.177232528964;5323.190115360796;4592.517785632461;5117.0043682964415;5118.8976220476125;5312.335958005249;5313.946860531345;5152.330197074356;5195.870103247449;5212.661177023481;5212.713300768342;5240.423553409046 08:31:53 INFO - PROCESS | 2325 | |5;yui.html;645.6642545876144;711.9750808721695;726.8582626387856;734.4748504819054;749.5165618176277;14469.421223151074;15450.613734656612;15482.84517154828;15497.845021549796;15539.22303884804;13933.651658708537;13976.860231397683;13990.790138147935;14110.858891411108;14122.435102595884;685.1880521581942;708.2704814041546;709.0109297529942;822.7326119011316;833.6248688090353;841.4194205997873;846.5809424334932;855.5251835231444;855.6662901468401;859.70769938221;900.2078171209359;900.9909900900973;901.3960646366917;903.0472851142042;903.8237543678986;847.8007668197969;896.7758060484879;898.2230370729304;899.03802930864;900.4732231644496;669.8057563306635;671.5601281160848;672.2470832667444;673.0980486148535;673.7776533743853;14668.779968300483;14911.552653420415;15069.171195584238;15075.246237688072;15120.319585618674;14474.638134046627;14928.178950157737;14933.477328293566;14969.251537423086;15030.32363543643;11762.235454695418;11778.764424711459;11803.40982950849;11835.349055801928;11979.341136237503;3741.38267185914;3807.0101773538804;3854.1135538825947;4010.939835902464;4016.5380981186954;73833;101408.98591014069;101569;104661;105223.4738826301;10420.478976051167;10549.84175237372;10566.31318964265;10603.575856965635;10844.295120817122;22674.773252267598;22697.319080427613;23002.079916803475;23009.309720708407;23040.308790736304;7692.653830577638;7872.763817085496;7929.246721561442;8064.717734879368;8291.295239904675;4272.5727427257025;4303.569643035671;4350.869473915787;4472.530384309665;4515.209838278288;2842.332051967786;3235.2397186661115;3338.9332213355597;3344.2308269098244;3345.749068819848;537.4088502647057;588.5174157191062;617.3209469583422;632.6177302593848;639.5810743962712;514.208119495972;619.7706848466006;638.7540796793268;658.7826017414242;695.8051745511265;8612.354073444516;8867.512286824287;9134.451932883916;9391.812163756687;9418.529073546295;596.9820905372759;649.6816559885716;674.6862708840413;681.9624920629313;692.9064576282238;3735.402335626287;4269.594388533084;4411.647068234533;4592.747398893093;4641.443026836733;67764.6611766938;68356;94458.0554194463;101456.49271753593;102183;93012;95756.04243957471;96269.51865240629;97723.55691107638;98927.50536247417;71716;79610.20389796144;80612.19387806047;81088;83054.58472707598;7889.368850491832;9160.862587061067;9863.950680246553;9923.255755818198;10017.599296028076;37219.62780372162;40913.44032444404;51160.74419627878;53160.468395315555;53702;54722.726386367816;68633;73939;80245;82977.58511207406;12117.333546654667;12459.626211213677;12470.937645311715;12613.180143290656;13050.477980880658;13945.442182312594;13973.371198295898;14385.928070359581;14528.636784080483;14668.779968300698;11983.76032479363;12432;12898.80651790205;13613.11514751538;13711.97160213008;10346.896531034894;13005.089643724848;13425.66435839112;13642.727145457235;13803.2408217549;12753.362331883183;13117;13469.528566500125;13493.460261589427;14081.647958800702;10643.911082952629;10731.141508679442;10925.726856828644;11235.87710604559;11486.885131148916;10113;11068.612598559012;11126.16418290973;11308.547658093585;11595.652130436101 08:31:53 INFO - PROCESS | 2325 | __end_tp_report 08:31:53 INFO - PROCESS | 2325 | __start_cc_report 08:31:53 INFO - PROCESS | 2325 | _x_x_mozilla_cycle_collect,1674 08:31:53 INFO - PROCESS | 2325 | __end_cc_report 08:31:53 INFO - PROCESS | 2325 | __startTimestamp1487349113162__endTimestamp 08:31:53 INFO - PROCESS | 2325 | 08:31:53 INFO - PROCESS | 2325 | ------- Summary: start ------- 08:31:53 INFO - PROCESS | 2325 | Number of tests: 6 08:31:53 INFO - PROCESS | 2325 | 08:31:53 INFO - PROCESS | 2325 | [#0] dojo.html Cycles:165 Average:5913.47 Median:6134.62 stddev:621.22 (10.1%) stddev-sans-first:592.65 08:31:53 INFO - PROCESS | 2325 | Values: 3463.7 3480.1 3485.9 3510.9 3550.7 5860.9 5980.3 6006.4 6030.1 6035.7 5896.8 5967.7 5994.3 5994.5 6011.9 5322.0 5335.6 5365.1 5412.5 5467.0 5312.9 5313.2 5313.2 5445.0 5445.2 5404.9 5408.7 5409.8 5411.8 5413.1 5422.1 5422.9 5430.6 5435.5 5436.8 5262.2 5365.4 5366.2 5374.9 5382.7 6034.7 6035.5 6038.2 6039.3 6044.7 6302.8 6318.7 6346.2 6348.5 6353.6 6250.0 6276.8 6302.2 6307.1 6335.1 5898.6 5935.7 6012.1 6012.8 6055.5 6264.0 6427.3 6486.4 6493.1 6573.8 6124.3 6186.6 6206.9 6213.4 6344.0 6300.6 6331.7 6354.0 6358.6 6377.4 6271.2 6274.8 6276.6 6286.7 6309.8 6210.7 6261.5 6261.9 6274.9 6293.3 5129.3 5132.9 5138.6 5144.3 5168.8 4508.8 4592.5 4596.2 4599.0 4608.9 5902.0 5969.4 6017.6 6026.9 6108.9 6294.3 6341.9 6342.8 6358.8 6362.7 6027.5 6066.8 6073.4 6087.0 6089.9 5499.8 5514.7 5570.8 5590.3 5602.3 6422.8 6491.0 6497.2 6500.8 6511.4 6316.3 6325.3 6328.7 6329.6 6333.7 6223.3 6353.3 6378.4 6403.9 6451.7 6122.3 6291.0 6306.2 6308.3 6311.5 6298.6 6304.3 6316.1 6317.4 6337.4 5930.6 6134.6 6236.5 6243.0 6297.4 6205.7 6283.1 6293.3 6305.9 6307.9 6248.1 6253.4 6255.8 6259.5 6272.0 6106.5 6122.6 6193.5 6264.5 6290.9 6117.6 6133.7 6230.9 6256.6 6270.7 08:31:53 INFO - PROCESS | 2325 | 08:31:53 INFO - PROCESS | 2325 | [#1] ext.html Cycles:180 Average:57880.96 Median:35390.38 stddev:114044.46 (322.2%) stddev-sans-first:114282.98 08:31:53 INFO - PROCESS | 2325 | Values: 488.9 504.9 532.8 543.9 554.8 26730.8 31831.7 40318.0 41004.4 41152.4 43122.8 43329.8 43373.8 43398.8 43553.0 9467.7 9611.8 9628.6 9629.8 9630.6 8772.9 8912.2 8914.2 9063.7 9414.4 8986.3 11364.1 11535.3 11540.0 11839.3 11715.2 11766.0 11787.6 11787.9 11800.7 11607.7 11676.4 11692.7 11706.8 11725.2 34484.6 40143.4 40588.8 40878.4 40977.8 3209.3 3217.7 3271.9 3288.8 3327.1 29111.7 29733.6 31434.8 31435.8 31887.7 3044.4 3254.3 3255.9 3289.1 3365.9 493967.0 494621.0 495267.0 497211.0 498057.0 61153.8 61552.1 61606.0 61609.4 61673.7 62392.4 62427.0 64237.4 64255.0 64353.7 15332.4 15516.8 15578.6 15583.7 15585.1 11973.9 12055.2 12063.3 12064.0 12064.2 13714.8 14814.3 15152.6 16737.4 16890.6 6284.2 6297.8 7533.9 7569.8 7636.5 867.3 925.3 932.4 1033.6 1070.0 29774.4 29785.6 29840.1 30274.0 30282.0 788.7 1066.7 1100.4 1156.2 1174.5 14119.8 14546.1 14566.8 14882.0 15054.9 398305.0 399495.0 402096.0 403163.0 403178.0 48612.8 48707.8 53587.7 53757.0 53782.7 1389.9 1392.5 1435.5 1435.6 1436.5 28571.6 29083.4 29427.7 30153.7 30162.1 36244.8 47489.5 47522.8 47581.8 47892.8 378289.0 380774.1 389793.0 391017.0 392012.0 36296.0 36873.8 37173.4 37221.0 37345.0 41750.8 42179.0 42676.0 42874.0 43000.8 34593.5 34975.8 35033.8 35130.0 35986.0 35079.3 35154.9 36101.5 36226.3 36332.3 35073.3 35378.5 35402.3 35501.5 36269.5 30279.8 32177.7 32213.5 32250.0 32264.0 19139.7 23676.9 23872.8 23888.4 24099.4 08:31:53 INFO - PROCESS | 2325 | 08:31:53 INFO - PROCESS | 2325 | [#2] jquery.html Cycles:180 Average:33498.70 Median:2236.86 stddev:92952.12 (4155.5%) stddev-sans-first:93179.61 08:31:53 INFO - PROCESS | 2325 | Values: 376.8 376.9 384.1 390.6 403.5 18931.8 20746.5 21711.7 21906.8 21989.3 11748.9 12259.0 12267.4 12284.2 20084.0 5331.9 5616.1 5629.8 5630.0 5633.4 5462.6 5756.4 6004.5 6069.9 6121.3 6099.6 6121.6 6121.8 6123.2 6124.3 5692.1 5971.2 6027.9 6073.6 6082.7 5733.9 5850.6 5852.8 5864.9 5873.7 13548.8 13803.2 13804.8 13815.5 24122.9 2120.8 2213.8 2259.9 2347.2 2847.8 9786.8 10036.0 10580.7 13848.9 14043.4 1829.5 1840.8 1863.6 1870.2 1870.3 76116.2 105334.0 107492.4 107892.0 124019.0 10663.9 11754.2 11897.8 11930.2 11951.0 15163.5 15192.8 15208.5 15224.9 15242.9 8250.6 8319.8 8374.2 8504.8 8576.7 7309.6 8103.2 8106.6 8262.9 8276.3 4554.4 4631.4 4636.3 4693.6 4726.6 1901.6 1951.4 1954.6 1959.3 1967.8 834.0 843.3 930.3 932.0 970.4 17845.5 20330.0 21097.7 21116.0 21415.9 821.6 918.0 921.9 938.1 941.1 10585.4 10969.6 11024.9 11038.1 11049.0 501865.0 508903.0 508955.0 612507.0 618148.0 130654.7 136562.3 142139.3 143237.0 149868.0 973.9 985.6 1019.4 1020.0 1022.5 14002.6 17924.6 18228.6 19248.9 19366.6 56502.0 58005.0 58163.8 58837.9 59117.8 77308.0 81297.2 81539.8 82154.2 84074.0 7787.0 8188.9 8539.0 8693.3 8698.8 11373.4 13161.5 13174.0 13560.1 13652.8 10050.0 10690.7 11213.3 11364.5 11826.1 11323.4 11445.1 11474.4 11692.3 11875.9 10321.2 10639.7 11047.5 11604.8 12140.2 8207.8 8228.3 8365.5 8499.4 8581.4 6627.3 10664.6 11304.9 11530.4 11732.3 08:31:53 INFO - PROCESS | 2325 | 08:31:53 INFO - PROCESS | 2325 | [#3] mootools.html Cycles:180 Average:5491.90 Median:5045.03 stddev:2996.39 (59.4%) stddev-sans-first:2988.76 08:31:53 INFO - PROCESS | 2325 | Values: 1367.0 1409.0 1480.7 1592.3 1844.7 7448.4 8181.8 8350.1 8362.3 8506.9 8309.2 8359.9 8385.2 8390.7 8394.6 2339.0 2384.1 2385.4 2385.9 2393.2 2357.7 2406.7 2407.6 2409.8 2420.0 2356.2 2362.4 2388.3 2392.6 2393.6 1934.7 2334.5 2362.0 2367.4 2372.2 2361.8 2370.8 2389.4 2397.3 2405.8 6851.9 8405.9 8466.7 8470.5 8476.8 4508.6 5098.8 5100.6 5287.5 5294.3 3046.6 3348.4 3548.6 3574.7 3621.0 1053.8 1085.9 1112.8 1121.0 1125.3 10830.2 10877.0 10949.5 10952.3 10963.1 4287.8 4460.0 4542.2 4544.2 4560.5 8749.0 8792.0 8799.5 8806.6 8843.0 5183.3 5183.5 5186.1 5193.0 5195.5 4198.8 4407.8 4450.7 4524.9 4788.3 3706.2 3760.9 3855.1 3857.2 3859.6 1164.3 1173.2 1180.4 1182.8 1196.3 788.9 913.6 921.7 940.7 947.4 4798.4 5156.6 5763.7 5842.2 5971.8 847.9 990.8 1005.2 1026.9 1073.5 3854.4 3908.2 3918.9 4005.3 4060.9 9830.5 10328.8 10347.4 10349.2 10350.2 9864.9 10275.0 10290.3 10295.1 10309.6 7730.5 8078.0 8080.3 8091.1 8116.8 5633.2 5643.4 5690.5 5781.1 5824.4 9183.0 9409.0 9425.6 9427.1 9536.7 9088.9 9321.4 9588.4 9687.3 9795.6 7694.6 7757.9 7809.8 7828.5 7902.8 7903.6 7960.7 7973.6 7988.2 7989.5 7036.6 7217.7 7275.1 7320.9 7356.2 6977.5 7047.8 7070.2 7136.0 7140.5 6718.3 6757.4 6864.5 6864.7 6880.0 4842.5 4948.0 4951.6 5035.4 5054.6 4827.5 4912.4 4958.5 5030.3 5133.0 08:31:53 INFO - PROCESS | 2325 | 08:31:53 INFO - PROCESS | 2325 | [#4] prototype.html Cycles:180 Average:4262.24 Median:4887.02 stddev:1347.98 (27.6%) stddev-sans-first:1318.66 08:31:53 INFO - PROCESS | 2325 | Values: 306.8 307.5 315.3 321.1 323.2 4803.3 5004.4 5022.7 5052.8 5083.6 3894.5 4118.5 4873.8 4897.3 4965.6 3679.5 3857.9 3886.2 3891.3 3904.2 2978.9 3203.5 3408.8 3898.4 3901.2 3184.6 3365.3 3863.1 3872.0 3898.9 3141.7 3388.5 3465.9 3822.9 3843.3 2786.8 3309.2 3337.8 3363.0 3367.4 4805.5 4934.1 4976.1 4987.9 4992.9 3795.8 3801.9 3828.0 4350.5 4363.4 4515.5 5004.6 5246.2 5257.0 5267.0 3070.3 3688.5 3720.2 3724.8 3736.9 5160.4 5211.9 5407.6 5440.2 5564.8 2776.7 3095.4 3547.7 3644.5 3679.4 3119.7 3276.6 3734.4 3759.9 3761.5 4066.9 4318.5 4318.6 4347.7 4354.8 4596.4 5129.9 5261.7 5293.4 5317.7 1009.8 1175.4 1206.6 1245.6 1247.4 808.4 821.2 821.4 824.5 840.7 4280.6 4679.4 4729.2 4742.3 4749.8 4987.1 5094.3 5180.8 5216.8 5286.7 4781.5 5016.6 5071.7 5087.0 5093.8 2387.7 2456.3 2575.6 2687.7 2737.7 5028.3 5281.7 5413.9 5421.6 5459.4 4545.0 4771.7 4844.0 5397.5 5645.3 5348.4 5702.6 5712.6 5735.4 5741.5 4398.0 5297.0 5467.0 5525.6 5565.6 5143.7 5428.5 5440.6 5468.9 5505.5 4876.7 5618.9 5676.5 5684.9 5715.8 3539.7 3692.8 3719.7 3734.9 3738.9 4988.5 5437.0 5456.6 5461.4 5486.7 4716.4 5368.5 5403.5 5411.9 5416.0 5065.1 5329.9 5376.7 5384.5 5421.0 4679.3 5182.7 5221.2 5308.2 5323.2 4592.5 5117.0 5118.9 5312.3 5313.9 5152.3 5195.9 5212.7 5212.7 5240.4 08:31:53 INFO - PROCESS | 2325 | 08:31:53 INFO - PROCESS | 2325 | [#5] yui.html Cycles:180 Average:20013.76 Median:4271.08 stddev:28562.46 (668.7%) stddev-sans-first:28605.56 08:31:53 INFO - PROCESS | 2325 | Values: 645.7 712.0 726.9 734.5 749.5 14469.4 15450.6 15482.8 15497.8 15539.2 13933.7 13976.9 13990.8 14110.9 14122.4 685.2 708.3 709.0 822.7 833.6 841.4 846.6 855.5 855.7 859.7 900.2 901.0 901.4 903.0 903.8 847.8 896.8 898.2 899.0 900.5 669.8 671.6 672.2 673.1 673.8 14668.8 14911.6 15069.2 15075.2 15120.3 14474.6 14928.2 14933.5 14969.3 15030.3 11762.2 11778.8 11803.4 11835.3 11979.3 3741.4 3807.0 3854.1 4010.9 4016.5 73833.0 101409.0 101569.0 104661.0 105223.5 10420.5 10549.8 10566.3 10603.6 10844.3 22674.8 22697.3 23002.1 23009.3 23040.3 7692.7 7872.8 7929.2 8064.7 8291.3 4272.6 4303.6 4350.9 4472.5 4515.2 2842.3 3235.2 3338.9 3344.2 3345.7 537.4 588.5 617.3 632.6 639.6 514.2 619.8 638.8 658.8 695.8 8612.4 8867.5 9134.5 9391.8 9418.5 597.0 649.7 674.7 682.0 692.9 3735.4 4269.6 4411.6 4592.7 4641.4 67764.7 68356.0 94458.1 101456.5 102183.0 93012.0 95756.0 96269.5 97723.6 98927.5 71716.0 79610.2 80612.2 81088.0 83054.6 7889.4 9160.9 9864.0 9923.3 10017.6 37219.6 40913.4 51160.7 53160.5 53702.0 54722.7 68633.0 73939.0 80245.0 82977.6 12117.3 12459.6 12470.9 12613.2 13050.5 13945.4 13973.4 14385.9 14528.6 14668.8 11983.8 12432.0 12898.8 13613.1 13712.0 10346.9 13005.1 13425.7 13642.7 13803.2 12753.4 13117.0 13469.5 13493.5 14081.6 10643.9 10731.1 10925.7 11235.9 11486.9 10113.0 11068.6 11126.2 11308.5 11595.7 08:31:53 INFO - PROCESS | 2325 | -------- Summary: end -------- 08:31:53 INFO - PROCESS | 2325 | 08:31:53 INFO - TEST-INFO | 2325: exit 0 08:31:53 INFO - TEST-OK | dromaeo_css | took 1119125ms 08:31:53 INFO - TEST-START | kraken 08:31:53 INFO - operating with platform_type : mac_ 08:31:53 INFO - Initialising browser for kraken test... 08:31:53 INFO - TEST-INFO | started process 2330 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/tmpUbzc16/profile http://localhost:60491/getInfo.html) 08:31:56 INFO - PROCESS | 2330 | __metrics Screen width/height:1600/1200 08:31:56 INFO - PROCESS | 2330 | colorDepth:24 08:31:56 INFO - PROCESS | 2330 | Browser inner width/height: 1024/689 08:31:56 INFO - PROCESS | 2330 | __metrics 08:31:56 INFO - PROCESS | 2330 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:31:56 INFO - PROCESS | 2330 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:31:57 INFO - TEST-INFO | 2330: exit 0 08:31:57 INFO - Browser initialized. 08:31:57 INFO - Running cycle 1/1 for kraken test... 08:31:57 INFO - TEST-INFO | started process 2332 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/tmpUbzc16/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:32:09 INFO - PROCESS | 2332 | RSS: Main: 172855296 08:32:09 INFO - PROCESS | 2332 | 08:32:12 INFO - PROCESS | 2332 | Cycle 1(1): loaded http://localhost:60491/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60491/tests/kraken/driver.html?testName=audio-beat-detection) 08:32:13 INFO - PROCESS | 2332 | RSS: Main: 222404608 08:32:13 INFO - PROCESS | 2332 | 08:32:15 INFO - PROCESS | 2332 | Cycle 1(1): loaded http://localhost:60491/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60491/tests/kraken/driver.html?testName=audio-dft) 08:32:16 INFO - PROCESS | 2332 | RSS: Main: 234987520 08:32:16 INFO - PROCESS | 2332 | 08:32:19 INFO - PROCESS | 2332 | Cycle 1(1): loaded http://localhost:60491/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60491/tests/kraken/driver.html?testName=audio-fft) 08:32:20 INFO - PROCESS | 2332 | RSS: Main: 331730944 08:32:20 INFO - PROCESS | 2332 | 08:32:21 INFO - PROCESS | 2332 | Cycle 1(1): loaded http://localhost:60491/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60491/tests/kraken/driver.html?testName=audio-oscillator) 08:32:22 INFO - PROCESS | 2332 | RSS: Main: 234991616 08:32:22 INFO - PROCESS | 2332 | 08:32:24 INFO - PROCESS | 2332 | Cycle 1(1): loaded http://localhost:60491/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60491/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:32:25 INFO - PROCESS | 2332 | RSS: Main: 236302336 08:32:25 INFO - PROCESS | 2332 | 08:32:27 INFO - PROCESS | 2332 | Cycle 1(1): loaded http://localhost:60491/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60491/tests/kraken/driver.html?testName=imaging-darkroom) 08:32:28 INFO - PROCESS | 2332 | RSS: Main: 276389888 08:32:28 INFO - PROCESS | 2332 | 08:32:31 INFO - PROCESS | 2332 | Cycle 1(1): loaded http://localhost:60491/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60491/tests/kraken/driver.html?testName=imaging-desaturate) 08:32:32 INFO - PROCESS | 2332 | RSS: Main: 277069824 08:32:32 INFO - PROCESS | 2332 | 08:32:34 INFO - PROCESS | 2332 | Cycle 1(1): loaded http://localhost:60491/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60491/tests/kraken/driver.html?testName=json-parse-financial) 08:32:35 INFO - PROCESS | 2332 | RSS: Main: 276242432 08:32:35 INFO - PROCESS | 2332 | 08:32:37 INFO - PROCESS | 2332 | Cycle 1(1): loaded http://localhost:60491/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60491/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:32:37 INFO - PROCESS | 2332 | RSS: Main: 249606144 08:32:37 INFO - PROCESS | 2332 | 08:32:39 INFO - PROCESS | 2332 | Cycle 1(1): loaded http://localhost:60491/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60491/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:32:40 INFO - PROCESS | 2332 | RSS: Main: 254771200 08:32:40 INFO - PROCESS | 2332 | 08:32:42 INFO - PROCESS | 2332 | Cycle 1(1): loaded http://localhost:60491/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60491/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:32:43 INFO - PROCESS | 2332 | RSS: Main: 255852544 08:32:43 INFO - PROCESS | 2332 | 08:32:45 INFO - PROCESS | 2332 | Cycle 1(1): loaded http://localhost:60491/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60491/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:32:46 INFO - PROCESS | 2332 | RSS: Main: 267161600 08:32:46 INFO - PROCESS | 2332 | 08:32:49 INFO - PROCESS | 2332 | Cycle 1(1): loaded http://localhost:60491/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60491/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:32:50 INFO - PROCESS | 2332 | RSS: Main: 267251712 08:32:50 INFO - PROCESS | 2332 | 08:32:51 INFO - PROCESS | 2332 | Cycle 1(1): loaded http://localhost:60491/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60491/tests/kraken/driver.html?testName=ai-astar) 08:32:52 INFO - PROCESS | 2332 | RSS: Main: 310935552 08:32:52 INFO - PROCESS | 2332 | 08:32:52 INFO - PROCESS | 2332 | __start_tp_report 08:32:52 INFO - PROCESS | 2332 | _x_x_mozilla_page_load 08:32:52 INFO - PROCESS | 2332 | _x_x_mozilla_page_load_details 08:32:52 INFO - PROCESS | 2332 | |i|pagename|runs| 08:32:52 INFO - PROCESS | 2332 | |0;ai-astar;114;114;112;112;114;112;112;113;112;113 08:32:52 INFO - PROCESS | 2332 | |1;audio-beat-detection;144;109;108;144;109;108;108;106;139;104 08:32:52 INFO - PROCESS | 2332 | |2;audio-dft;185;183;183;184;184;182;186;184;184;184 08:32:52 INFO - PROCESS | 2332 | |3;audio-fft;79;58;60;90;60;58;57;57;82;56 08:32:52 INFO - PROCESS | 2332 | |4;audio-oscillator;90;69;93;68;67;68;87;67;69;89 08:32:52 INFO - PROCESS | 2332 | |5;imaging-gaussian-blur;88;84;86;83;86;83;87;83;87;84 08:32:52 INFO - PROCESS | 2332 | |6;imaging-darkroom;116;147;95;95;123;167;102;96;96;96 08:32:52 INFO - PROCESS | 2332 | |7;imaging-desaturate;83;81;79;81;85;83;84;86;83;93 08:32:52 INFO - PROCESS | 2332 | |8;json-parse-financial;54;55;53;40;43;74;83;86;81;84 08:32:52 INFO - PROCESS | 2332 | |9;json-stringify-tinderbox;64;71;76;75;72;69;71;69;75;70 08:32:52 INFO - PROCESS | 2332 | |10;stanford-crypto-aes;83;82;82;82;83;73;74;88;102;103 08:32:52 INFO - PROCESS | 2332 | |11;stanford-crypto-ccm;139;138;136;136;174;156;145;139;184;130 08:32:52 INFO - PROCESS | 2332 | |12;stanford-crypto-pbkdf2;200;256;162;167;162;159;161;163;161;160 08:32:52 INFO - PROCESS | 2332 | |13;stanford-crypto-sha256-iterative;67;67;66;66;64;65;65;65;65;66 08:32:52 INFO - PROCESS | 2332 | __end_tp_report 08:32:52 INFO - PROCESS | 2332 | __start_cc_report 08:32:52 INFO - PROCESS | 2332 | _x_x_mozilla_cycle_collect,2029 08:32:52 INFO - PROCESS | 2332 | __end_cc_report 08:32:52 INFO - PROCESS | 2332 | __startTimestamp1487349172230__endTimestamp 08:32:52 INFO - PROCESS | 2332 | 08:32:52 INFO - PROCESS | 2332 | ------- Summary: start ------- 08:32:52 INFO - PROCESS | 2332 | Number of tests: 14 08:32:52 INFO - PROCESS | 2332 | 08:32:52 INFO - PROCESS | 2332 | [#0] ai-astar Cycles:10 Average:112.80 Median:113.00 stddev:0.92 (0.8%) stddev-sans-first:0.87 08:32:52 INFO - PROCESS | 2332 | Values: 114.0 114.0 112.0 112.0 114.0 112.0 112.0 113.0 112.0 113.0 08:32:52 INFO - PROCESS | 2332 | 08:32:52 INFO - PROCESS | 2332 | [#1] audio-beat-detection Cycles:10 Average:117.90 Median:109.00 stddev:16.98 (15.6%) stddev-sans-first:15.16 08:32:52 INFO - PROCESS | 2332 | Values: 144.0 109.0 108.0 144.0 109.0 108.0 108.0 106.0 139.0 104.0 08:32:52 INFO - PROCESS | 2332 | 08:32:52 INFO - PROCESS | 2332 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.00 stddev:1.10 (0.6%) stddev-sans-first:1.09 08:32:52 INFO - PROCESS | 2332 | Values: 185.0 183.0 183.0 184.0 184.0 182.0 186.0 184.0 184.0 184.0 08:32:52 INFO - PROCESS | 2332 | 08:32:52 INFO - PROCESS | 2332 | [#3] audio-fft Cycles:10 Average:65.70 Median:60.00 stddev:12.75 (21.2%) stddev-sans-first:12.58 08:32:52 INFO - PROCESS | 2332 | Values: 79.0 58.0 60.0 90.0 60.0 58.0 57.0 57.0 82.0 56.0 08:32:52 INFO - PROCESS | 2332 | 08:32:52 INFO - PROCESS | 2332 | [#4] audio-oscillator Cycles:10 Average:76.70 Median:78.00 stddev:11.34 (14.5%) stddev-sans-first:10.96 08:32:52 INFO - PROCESS | 2332 | Values: 90.0 69.0 93.0 68.0 67.0 68.0 87.0 67.0 69.0 89.0 08:32:52 INFO - PROCESS | 2332 | 08:32:52 INFO - PROCESS | 2332 | [#5] imaging-gaussian-blur Cycles:10 Average:85.10 Median:86.00 stddev:1.91 (2.2%) stddev-sans-first:1.72 08:32:52 INFO - PROCESS | 2332 | Values: 88.0 84.0 86.0 83.0 86.0 83.0 87.0 83.0 87.0 84.0 08:32:52 INFO - PROCESS | 2332 | 08:32:52 INFO - PROCESS | 2332 | [#6] imaging-darkroom Cycles:10 Average:113.30 Median:95.00 stddev:25.42 (26.8%) stddev-sans-first:26.94 08:32:52 INFO - PROCESS | 2332 | Values: 116.0 147.0 95.0 95.0 123.0 167.0 102.0 96.0 96.0 96.0 08:32:52 INFO - PROCESS | 2332 | 08:32:52 INFO - PROCESS | 2332 | [#7] imaging-desaturate Cycles:10 Average:83.80 Median:83.50 stddev:3.82 (4.6%) stddev-sans-first:4.04 08:32:52 INFO - PROCESS | 2332 | Values: 83.0 81.0 79.0 81.0 85.0 83.0 84.0 86.0 83.0 93.0 08:32:52 INFO - PROCESS | 2332 | 08:32:52 INFO - PROCESS | 2332 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:77.50 stddev:18.06 (23.3%) stddev-sans-first:18.69 08:32:52 INFO - PROCESS | 2332 | Values: 54.0 55.0 53.0 40.0 43.0 74.0 83.0 86.0 81.0 84.0 08:32:52 INFO - PROCESS | 2332 | 08:32:52 INFO - PROCESS | 2332 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:71.50 stddev:3.58 (5.0%) stddev-sans-first:2.69 08:32:52 INFO - PROCESS | 2332 | Values: 64.0 71.0 76.0 75.0 72.0 69.0 71.0 69.0 75.0 70.0 08:32:52 INFO - PROCESS | 2332 | 08:32:52 INFO - PROCESS | 2332 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:82.00 stddev:10.12 (12.3%) stddev-sans-first:10.70 08:32:52 INFO - PROCESS | 2332 | Values: 83.0 82.0 82.0 82.0 83.0 73.0 74.0 88.0 102.0 103.0 08:32:52 INFO - PROCESS | 2332 | 08:32:52 INFO - PROCESS | 2332 | [#11] stanford-crypto-ccm Cycles:10 Average:147.70 Median:142.00 stddev:18.01 (12.7%) stddev-sans-first:18.82 08:32:52 INFO - PROCESS | 2332 | Values: 139.0 138.0 136.0 136.0 174.0 156.0 145.0 139.0 184.0 130.0 08:32:52 INFO - PROCESS | 2332 | 08:32:52 INFO - PROCESS | 2332 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.10 Median:162.50 stddev:30.92 (19.0%) stddev-sans-first:31.46 08:32:52 INFO - PROCESS | 2332 | Values: 200.0 256.0 162.0 167.0 162.0 159.0 161.0 163.0 161.0 160.0 08:32:52 INFO - PROCESS | 2332 | 08:32:52 INFO - PROCESS | 2332 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:0.97 (1.5%) stddev-sans-first:0.88 08:32:52 INFO - PROCESS | 2332 | Values: 67.0 67.0 66.0 66.0 64.0 65.0 65.0 65.0 65.0 66.0 08:32:52 INFO - PROCESS | 2332 | -------- Summary: end -------- 08:32:52 INFO - PROCESS | 2332 | 08:32:53 INFO - TEST-INFO | 2332: exit 0 08:32:53 INFO - TEST-OK | kraken | took 59369ms 08:32:53 INFO - SUITE-END | took 1178s 08:32:53 INFO - Completed test suite (00:19:38) 08:32:53 INFO - javascript benchmark 08:32:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3463.7402194835386, 3480.1299675081245, 3485.8779942701995, 3510.9122271943215, 3550.6626870447317, 5860.882782344351, 5980.312264089631, 6006.429389208024, 6030.0954856771505, 6035.6982150892445, 5896.764129434828, 5967.701614919259, 5994.340622531518, 5994.520438364932, 6011.939880601192, 5322.0, 5335.573154147678, 5365.061114305001, 5412.539934105586, 5467.0, 5312.884294298202, 5313.1764576490705, 5313.1764576490705, 5445.047116754572, 5445.210444485548, 5404.91892621611, 5408.675479471224, 5409.756560954766, 5411.83764487064, 5413.106837371829, 5422.132458806572, 5422.91865622016, 5430.619856610039, 5435.537979271767, 5436.836894893159, 5262.184361423985, 5365.356157261114, 5366.168243922199, 5374.865628359284, 5382.67703937765, 6034.698265086772, 6035.547333949971, 6038.215032045806, 6039.275286965592, 6044.697765111727, 6302.810915672537, 6318.684065796738, 6346.174997250328, 6348.523860710465, 6353.618782873043, 6250.0, 6276.811695649138, 6302.18071650687, 6307.148534947769, 6335.081413195107, 5898.643312038213, 5935.703214839241, 6012.0681294399, 6012.75948962041, 6055.545834062419, 6263.968680156661, 6427.260865000538, 6486.351364863476, 6493.123428337114, 6573.80278591643, 6124.299866451454, 6186.597871138361, 6206.937930620727, 6213.378662133841, 6344.048392741126, 6300.558960872695, 6331.746730130743, 6354.046892966092, 6358.554901156967, 6377.362263773585, 6271.184745982993, 6274.843128921813, 6276.560640755103, 6286.717097730521, 6309.779157729457, 6210.689465526705, 6261.467775239064, 6261.9373806262265, 6274.905876411857, 6293.2762732285455, 5129.3075434816565, 5132.871678208075, 5138.614603904722, 5144.254083157921, 5168.793248270027, 4508.752018639007, 4592.494825569184, 4596.218642830727, 4598.954010459853, 4608.9308660370125, 5902.0, 5969.373215812364, 6017.608855424383, 6026.939730602726, 6108.908366374508, 6294.276158241769, 6341.873162536724, 6342.8414289642205, 6358.777442789573, 6362.713677884506, 6027.547933904974, 6066.817995460055, 6073.423024812636, 6087.0, 6089.939100609025, 5499.752511137009, 5514.696691681996, 5570.805021824298, 5590.301212348457, 5602.299712535933, 6422.775202867971, 6491.0, 6497.220333560003, 6500.837479063061, 6511.446527045254, 6316.336784637547, 6325.304216536269, 6328.683565821782, 6329.620222786648, 6333.746650133943, 6223.3465486125115, 6353.301136875032, 6378.425941665272, 6403.903941440789, 6451.741930322923, 6122.326544080237, 6291.0, 6306.211723534559, 6308.27454842699, 6311.526635502448, 6298.559100862895, 6304.306526282197, 6316.05259211122, 6317.368263173829, 6337.429631333202, 5930.644161350333, 6134.620279381861, 6236.501079913505, 6242.969909964805, 6297.370262973666, 6205.6586887721605, 6283.088952102011, 6293.307736149111, 6305.873882522415, 6307.936920630735, 6248.094026366242, 6253.437190652863, 6255.812325630239, 6259.499240060693, 6271.96864015677, 6106.521339539896, 6122.5811271886105, 6193.504519638508, 6264.49884009269, 6290.9056364155485, 6117.553376797748, 6133.701927635063, 6230.875382492234, 6256.562040657111, 6270.7491700331475], "value": 5874.571743838344, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [488.93643826302576, 504.8510689346642, 532.75227019436, 543.8803463238089, 554.7974989128967, 26730.797114129862, 31831.68168318319, 40318.0, 41004.38493422601, 41152.382714259234, 43122.78438607811, 43329.7833510832, 43373.783131084376, 43398.783006085, 43553.0, 9467.715968520939, 9611.759706007337, 9628.614855405775, 9629.75925601862, 9630.614775408976, 8772.912270877305, 8912.153345432174, 8914.153155450222, 9063.728088157366, 9414.435133891955, 8986.281097512183, 11364.147688923322, 11535.250208736446, 11540.019098376606, 11839.28964262147, 11715.179937404386, 11765.99989000936, 11787.646370608896, 11787.941060294643, 11800.704982375424, 11607.709807254801, 11676.357800320979, 11692.707682307926, 11706.824397634042, 11725.179237453382, 34484.620615175365, 40143.397849032284, 40588.797056014824, 40878.38682419766, 40977.79511102426, 3209.3420848725955, 3217.742580593547, 3271.9345613087844, 3288.802671839673, 3327.05179023977, 29111.708882911324, 29733.55399669007, 31434.842825785952, 31435.84282078575, 31887.681123188704, 3044.421559903611, 3254.2840575073446, 3255.9348813023607, 3289.1448223461834, 3365.9495107573407, 493967.0, 494621.0, 495267.0, 497211.0, 498057.0, 61153.776924461265, 61552.076718849254, 61606.0, 61609.38390616126, 61673.69163154245, 62392.37607623956, 62427.0, 64237.35762642407, 64255.0, 64353.678231608545, 15332.386704531917, 15516.844831551765, 15578.610534736723, 15583.688326233638, 15585.064896106043, 11973.940130299292, 12055.156139070355, 12063.276203427822, 12063.974562162315, 12064.155509114278, 13714.794278085637, 14814.259287035606, 15152.56050675184, 16737.414190503274, 16890.577735556708, 6284.183056202664, 6297.811065668037, 7533.886991695129, 7569.810754731176, 7636.465447418738, 867.3234876796109, 925.3337596930199, 932.4358762948455, 1033.5865653738565, 1070.0262760887556, 29774.40451190964, 29785.553216701766, 29840.10479685613, 30274.0, 30282.0, 788.6766425765524, 1066.6586692258402, 1100.4387762241315, 1156.2368836567825, 1174.48322737995, 14119.78820317696, 14546.054506457258, 14566.781498277534, 14882.0, 15054.924725376522, 398305.0, 399495.0, 402095.9790402058, 403163.0, 403178.0, 48612.75693621509, 48707.75646121747, 53587.732061340226, 53757.0, 53782.73108634432, 1389.8957578181476, 1392.5474220878255, 1435.5334516282041, 1435.554977956816, 1436.5115860607443, 28571.571426429036, 29083.41833163367, 29427.705722943352, 30153.698463015087, 30162.09513714592, 36244.81877590595, 47489.52510474851, 47522.76238618923, 47581.762091189325, 47892.76053619709, 378289.0, 380774.0961295176, 389793.0, 391017.0, 392012.0, 36296.0, 36873.81563092167, 37173.442398363506, 37221.0, 37345.0, 41750.79124604479, 42179.0, 42676.0, 42874.0, 43000.78499607482, 34593.48109778405, 34975.82512087423, 35033.82483087568, 35130.0, 35986.0, 35079.298414031065, 35154.94535163949, 36101.458478122324, 36226.27547449089, 36332.27335453329, 35073.33715168006, 35378.46932295966, 35402.29195416129, 35501.467477988364, 36269.45595816012, 30279.848600756854, 32177.678223217466, 32213.51679724853, 32250.032499025066, 32264.0, 19139.71290430617, 23676.934537946177, 23872.761272387055, 23888.40278993039, 24099.397515062265], "value": 19305.451856975982, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.77017019618046, 376.9472273881655, 384.1031192166292, 390.585978862406, 403.4835410674338, 18931.810681893177, 20746.481337966557, 21711.6743248851, 21906.78093219067, 21989.34031979041, 11748.882511174887, 12258.957988570959, 12267.447964841582, 12284.201526900746, 20084.0, 5331.946680533193, 5616.101423772197, 5629.817738274967, 5629.971850140764, 5633.380328163898, 5462.562994960414, 5756.395578464264, 6004.459598636122, 6069.908951365733, 6121.296050954131, 6099.634021958675, 6121.632702037892, 6121.785737499188, 6123.173371594845, 6124.265088189423, 5692.146178073281, 5971.223740913697, 6027.8794424111275, 6073.5748497604745, 6082.726277317532, 5733.942660573424, 5850.64896106235, 5852.76588936442, 5864.853378665525, 5873.735681894325, 13548.796768048487, 13803.2408217548, 13804.826589739883, 13815.516456923959, 24122.879385603133, 2120.756113047004, 2213.7896899794496, 2259.920902768395, 2347.178487529351, 2847.8291302521916, 9786.755331116708, 10035.996400359905, 10580.682579522627, 13848.892088632885, 14043.438262469488, 1829.4785985993929, 1840.8251216134445, 1863.57137858292, 1870.2238570993022, 1870.3079860451585, 76116.23883761147, 105334.0, 107492.43957911558, 107892.0, 124019.0, 10663.946680266548, 11754.236864470227, 11897.821532677017, 11930.22453540517, 11951.0, 15163.545093647208, 15192.848071519144, 15208.46770363032, 15224.923875380553, 15242.923785381003, 8250.587470626444, 8319.750407487785, 8374.246317831425, 8504.829903401896, 8576.656933722581, 7309.634518274065, 8103.189681031849, 8106.594670266463, 8262.917370826215, 8276.255137037695, 4554.385158003627, 4631.3516107744945, 4636.2581986882615, 4693.55411235932, 4726.645501587326, 1901.5626405926714, 1951.4243298227057, 1954.589536197386, 1959.294653924586, 1967.7737060237969, 833.995830020846, 843.3211264931666, 930.2697382554662, 932.0008581592447, 970.4129001953858, 17845.46463606094, 20330.0, 21097.68353474699, 21116.0, 21415.892920535298, 821.5686764448593, 917.9678711245208, 921.8571121476182, 938.0947385772625, 941.1294552538874, 10585.41780202081, 10969.561217551209, 11024.944875275733, 11038.061764750086, 11049.005589496985, 501865.0, 508903.0, 508955.0, 612507.0, 618148.0, 130654.69345306425, 136562.31718841344, 142139.28930355283, 143237.0, 149868.0, 973.9074787895139, 985.5515740338129, 1019.3934608907837, 1019.97450063749, 1022.4580972084807, 14002.649933751738, 17924.641507170043, 18228.635427291116, 19248.903755481133, 19366.61266774685, 56502.0, 58005.0, 58163.83672326445, 58837.94067207627, 59117.81764364603, 77308.0, 81297.18702813133, 81539.77690334768, 82154.17845821465, 84074.0, 7786.961065194638, 8188.918110818816, 8538.957305213435, 8693.26107280863, 8698.782530436789, 11373.374464404536, 13161.47354105825, 13174.011949103664, 13560.11859229147, 13652.795208071688, 10050.0, 10690.73273168177, 11213.327200368005, 11364.488598013275, 11826.113041521749, 11323.377214253294, 11445.141614378788, 11474.368909709712, 11692.298462092302, 11875.881241187823, 10321.174306055347, 10639.680809575726, 11047.502862371051, 11604.825927611262, 12140.15018948665, 8207.79480512968, 8228.341732661253, 8365.498070115813, 8499.362547809063, 8581.35639827028, 6627.3372662733345, 10664.573417063231, 11304.9434752829, 11530.423478825858, 11732.296062236293], "value": 9413.427719951416, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1367.0225788561177, 1408.9506867259645, 1480.748272793625, 1592.2914303135103, 1844.6864033114368, 7448.36688881445, 8181.795455113625, 8350.123237060097, 8362.289205417539, 8506.91493085069, 8309.210624990632, 8359.91640083599, 8385.203405676466, 8390.748277551684, 8394.580270986457, 2338.9532209355802, 2384.141708984764, 2385.42749740062, 2385.8687772172525, 2393.198278576679, 2357.6581395697613, 2406.6991626046743, 2407.614781634939, 2409.831311808174, 2419.9516009679796, 2356.163561935514, 2362.444825466014, 2388.3312672451652, 2392.617181251, 2393.56915755164, 1934.7230827653682, 2334.4980829121737, 2362.0433724341583, 2367.3726462487452, 2372.1934542255544, 2361.7874391304695, 2370.7866292033627, 2389.414593424605, 2397.3287479505766, 2405.8315917885757, 6851.931480685179, 8405.873911891265, 8466.74599762008, 8470.534120623362, 8476.83046339076, 4508.571685689854, 5098.847034588968, 5100.617453690988, 5287.47125287472, 5294.311739473882, 3046.6191726034244, 3348.363810875926, 3548.6273941236313, 3574.7140228781636, 3621.004223838439, 1053.836655318427, 1085.8968398002178, 1112.777444511101, 1120.9943950280197, 1125.3360517294836, 10830.241883068189, 10877.0, 10949.507272172772, 10952.288101273392, 10963.122950163968, 4287.828486860491, 4459.955400445954, 4542.160425027869, 4544.2047641662575, 4560.498345182027, 8748.95625521881, 8792.0, 8799.516026618598, 8806.603702833389, 8842.955785221033, 5183.300254465675, 5183.50756678115, 5186.092433824066, 5192.987367463384, 5195.506426889439, 4198.769067701306, 4407.757573333497, 4450.749534194836, 4524.88687782808, 4788.281757736368, 3706.166112624692, 3760.9059773505332, 3855.094052897567, 3857.18999010211, 3859.556151042666, 1164.342146687136, 1173.184636677501, 1180.3744015671707, 1182.781185480689, 1196.3180986837592, 788.940829437783, 913.6117150211134, 921.6589861751061, 940.6707652321769, 947.3889341374775, 4798.352222449925, 5156.561692256125, 5763.682997435181, 5842.152887831241, 5971.790987315423, 847.9019669527976, 990.782027953849, 1005.1807776661997, 1026.9435181065114, 1073.5222825842582, 3854.4411060396087, 3908.159745654698, 3918.8824335269987, 4005.319095753729, 4060.939085913714, 9830.508474576385, 10328.793424131476, 10347.4308913009, 10349.172066234683, 10350.171986241083, 9864.852027219598, 10275.0, 10290.331128476626, 10295.073443389982, 10309.587616495257, 7730.458867879307, 8078.0, 8080.313173380328, 8091.06952700447, 8116.797080073045, 5633.155026746021, 5643.435656434488, 5690.487856092972, 5781.075027995501, 5824.388439213822, 9182.95408522953, 9408.95295523518, 9425.575849086945, 9427.057294270518, 9536.666216682383, 9088.863667045132, 9321.44071355721, 9588.424694518351, 9687.32188746781, 9795.608175672893, 7694.576798276148, 7757.92242077572, 7809.765707028798, 7828.45200835936, 7902.841943161219, 7903.56530390834, 7960.681572737026, 7973.561454120079, 7988.161243069394, 7989.520628762293, 7036.648167591702, 7217.7473788417155, 7275.054242948383, 7320.853582928418, 7356.227596102332, 6977.476689248225, 7047.823804404931, 7070.222275549789, 7135.964320178366, 7140.500164988401, 6718.294579069127, 6757.425618822455, 6864.450843932374, 6864.691088900911, 6880.002399651922, 4842.539958703917, 4947.950520494893, 4951.603871690329, 5035.420926593342, 5054.646174767878, 4827.517248275144, 4912.435069966999, 4958.479359667327, 5030.346055012825, 5132.999065182403], "value": 4461.169853510809, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.7760534809589, 307.46654554348214, 315.29531497103966, 321.1377451542608, 323.2226495278855, 4803.255495398219, 5004.374453193351, 5022.7237501937425, 5052.823151189705, 5083.6187285953565, 3894.4547763313158, 4118.50577930648, 4873.7806798694055, 4897.3388592539995, 4965.62757793166, 3679.521662183926, 3857.9421308680394, 3886.203328317702, 3891.2801131790566, 3904.1996390739973, 2978.91269686565, 3203.5034569641743, 3408.8295585220762, 3898.3567711327737, 3901.161250331178, 3184.570083038783, 3365.293288409437, 3863.130795571002, 3871.9806400968096, 3898.941515877264, 3141.701538353853, 3388.4747864081105, 3465.851172273207, 3822.923541529182, 3843.3082045231986, 2786.7909906757072, 3309.1892486341, 3337.7997320160625, 3362.9742928406827, 3367.44437167867, 4805.519448055202, 4934.087193869145, 4976.054549635558, 4987.850364489072, 4992.926520798046, 3795.7532760370764, 3801.904952376185, 3828.0, 4350.499692535335, 4363.38912552243, 4515.525869783658, 5004.599632029429, 5246.23929530216, 5257.0023391111135, 5266.9992701387, 3070.2784845561273, 3688.5020522229424, 3720.2001569662384, 3724.832382542792, 3736.8505259789576, 5160.354955630546, 5211.905499845037, 5407.621466497386, 5440.183972404131, 5564.777408903639, 2776.7362100600412, 3095.3963977024264, 3547.7228197848754, 3644.5421831267176, 3679.448082787603, 3119.688031196862, 3276.5576647152807, 3734.402495600691, 3759.887203383903, 3761.5486141663177, 4066.877993660195, 4318.546552611993, 4318.589733975267, 4347.7173983690955, 4354.847580334736, 4596.4024676791805, 5129.897402051938, 5261.736913154327, 5293.444188360244, 5317.680939143664, 1009.77816841621, 1175.3662409251149, 1206.5897594817804, 1245.6138597034949, 1247.4074814463238, 808.4260175275621, 821.219841150909, 821.3716506872247, 824.4805772363493, 840.6637345062024, 4280.5505421930875, 4679.438467383936, 4729.233398461938, 4742.33607294979, 4749.762511874393, 4987.102321582078, 5094.2613321068975, 5180.766865491062, 5216.8004756170885, 5286.682799031993, 4781.52184781526, 5016.6237532184505, 5071.746412679425, 5087.0414890266775, 5093.847184584469, 2387.653790200411, 2456.273536374623, 2575.562154433751, 2687.683035312683, 2737.7399147080996, 5028.32117664118, 5281.709505977208, 5413.891722165535, 5421.647592906527, 5459.416769136985, 4545.0, 4771.735490095128, 4843.95156048435, 5397.460253974649, 5645.266115405053, 5348.411674715778, 5702.572307076985, 5712.600117991784, 5735.394089654903, 5741.511971482387, 4397.954950947825, 5297.034399764298, 5466.961277357289, 5525.613207075627, 5565.554755619622, 5143.662647711547, 5428.538574221236, 5440.619156659154, 5468.91796623059, 5505.504504594605, 4876.707397556158, 5618.85952851182, 5676.489115979582, 5684.919865225594, 5715.771369145354, 3539.681428671432, 3692.781382143832, 3719.702423806035, 3734.8879533614036, 3738.8783364990936, 4988.45127036033, 5436.9669762746535, 5456.645318054314, 5461.399246082849, 5486.6982315973, 4716.386869707053, 5368.543673787772, 5403.540699040625, 5411.891762164656, 5416.025115479251, 5065.088284108896, 5329.866753331198, 5376.704281264411, 5384.488473595002, 5420.970015697005, 4679.279972421865, 5182.66779949032, 5221.164613661796, 5308.177232528964, 5323.190115360796, 4592.517785632461, 5117.0043682964415, 5118.8976220476125, 5312.335958005249, 5313.946860531345, 5152.330197074356, 5195.870103247449, 5212.661177023481, 5212.713300768342, 5240.423553409046], "value": 3837.560465600441, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.6642545876144, 711.9750808721695, 726.8582626387856, 734.4748504819054, 749.5165618176277, 14469.421223151074, 15450.613734656612, 15482.84517154828, 15497.845021549796, 15539.22303884804, 13933.651658708537, 13976.860231397683, 13990.790138147935, 14110.858891411108, 14122.435102595884, 685.1880521581942, 708.2704814041546, 709.0109297529942, 822.7326119011316, 833.6248688090353, 841.4194205997873, 846.5809424334932, 855.5251835231444, 855.6662901468401, 859.70769938221, 900.2078171209359, 900.9909900900973, 901.3960646366917, 903.0472851142042, 903.8237543678986, 847.8007668197969, 896.7758060484879, 898.2230370729304, 899.03802930864, 900.4732231644496, 669.8057563306635, 671.5601281160848, 672.2470832667444, 673.0980486148535, 673.7776533743853, 14668.779968300483, 14911.552653420415, 15069.171195584238, 15075.246237688072, 15120.319585618674, 14474.638134046627, 14928.178950157737, 14933.477328293566, 14969.251537423086, 15030.32363543643, 11762.235454695418, 11778.764424711459, 11803.40982950849, 11835.349055801928, 11979.341136237503, 3741.38267185914, 3807.0101773538804, 3854.1135538825947, 4010.939835902464, 4016.5380981186954, 73833.0, 101408.98591014069, 101569.0, 104661.0, 105223.4738826301, 10420.478976051167, 10549.84175237372, 10566.31318964265, 10603.575856965635, 10844.295120817122, 22674.773252267598, 22697.319080427613, 23002.079916803475, 23009.309720708407, 23040.308790736304, 7692.653830577638, 7872.763817085496, 7929.246721561442, 8064.717734879368, 8291.295239904675, 4272.5727427257025, 4303.569643035671, 4350.869473915787, 4472.530384309665, 4515.209838278288, 2842.332051967786, 3235.2397186661115, 3338.9332213355597, 3344.2308269098244, 3345.749068819848, 537.4088502647057, 588.5174157191062, 617.3209469583422, 632.6177302593848, 639.5810743962712, 514.208119495972, 619.7706848466006, 638.7540796793268, 658.7826017414242, 695.8051745511265, 8612.354073444516, 8867.512286824287, 9134.451932883916, 9391.812163756687, 9418.529073546295, 596.9820905372759, 649.6816559885716, 674.6862708840413, 681.9624920629313, 692.9064576282238, 3735.402335626287, 4269.594388533084, 4411.647068234533, 4592.747398893093, 4641.443026836733, 67764.6611766938, 68356.0, 94458.0554194463, 101456.49271753593, 102183.0, 93012.0, 95756.04243957471, 96269.51865240629, 97723.55691107638, 98927.50536247417, 71716.0, 79610.20389796144, 80612.19387806047, 81088.0, 83054.58472707598, 7889.368850491832, 9160.862587061067, 9863.950680246553, 9923.255755818198, 10017.599296028076, 37219.62780372162, 40913.44032444404, 51160.74419627878, 53160.468395315555, 53702.0, 54722.726386367816, 68633.0, 73939.0, 80245.0, 82977.58511207406, 12117.333546654667, 12459.626211213677, 12470.937645311715, 12613.180143290656, 13050.477980880658, 13945.442182312594, 13973.371198295898, 14385.928070359581, 14528.636784080483, 14668.779968300698, 11983.76032479363, 12432.0, 12898.80651790205, 13613.11514751538, 13711.97160213008, 10346.896531034894, 13005.089643724848, 13425.66435839112, 13642.727145457235, 13803.2408217549, 12753.362331883183, 13117.0, 13469.528566500125, 13493.460261589427, 14081.647958800702, 10643.911082952629, 10731.141508679442, 10925.726856828644, 11235.87710604559, 11486.885131148916, 10113.0, 11068.612598559012, 11126.16418290973, 11308.547658093585, 11595.652130436101], "value": 7338.567061270115, "unit": "score"}], "name": "dromaeo_css", "value": 7154.7513643390075, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 112.0, 112.0, 114.0, 112.0, 112.0, 113.0, 112.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 109.0, 108.0, 144.0, 109.0, 108.0, 108.0, 106.0, 139.0, 104.0], "value": 117.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 183.0, 184.0, 184.0, 182.0, 186.0, 184.0, 184.0, 184.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 60.0, 90.0, 60.0, 58.0, 57.0, 57.0, 82.0, 56.0], "value": 65.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 69.0, 93.0, 68.0, 67.0, 68.0, 87.0, 67.0, 69.0, 89.0], "value": 76.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 86.0, 83.0, 86.0, 83.0, 87.0, 83.0, 87.0, 84.0], "value": 85.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 147.0, 95.0, 95.0, 123.0, 167.0, 102.0, 96.0, 96.0, 96.0], "value": 113.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 79.0, 81.0, 85.0, 83.0, 84.0, 86.0, 83.0, 93.0], "value": 83.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 53.0, 40.0, 43.0, 74.0, 83.0, 86.0, 81.0, 84.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 71.0, 76.0, 75.0, 72.0, 69.0, 71.0, 69.0, 75.0, 70.0], "value": 71.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 82.0, 82.0, 83.0, 73.0, 74.0, 88.0, 102.0, 103.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 136.0, 136.0, 174.0, 156.0, 145.0, 139.0, 184.0, 130.0], "value": 147.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 256.0, 162.0, 167.0, 162.0, 159.0, 161.0, 163.0, 161.0, 160.0], "value": 175.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 66.0, 64.0, 65.0, 65.0, 65.0, 65.0, 66.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1449.2999999999997, "alertThreshold": 2.0}]} 08:32:53 INFO - Return code: 0 08:32:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:32:53 INFO - # TBPL SUCCESS # 08:32:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:32:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:32:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:32:53 INFO - 2017-02-17 08:32:53.569 screenresolution[2336:77440] starting screenresolution argv=screenresolution get 08:32:53 INFO - 2017-02-17 08:32:53.572 screenresolution[2336:77440] Display 0: 1600x1200x32@60 08:32:53 INFO - 2017-02-17 08:32:53.578 screenresolution[2337:77444] starting screenresolution argv=screenresolution list 08:32:53 INFO - Available Modes on Display 0 08:32:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:32:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:32:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:32:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:32:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:32:53 INFO - Intel Iris: 08:32:53 INFO - Chipset Model: Intel Iris 08:32:53 INFO - Type: GPU 08:32:53 INFO - Bus: Built-In 08:32:53 INFO - VRAM (Dynamic, Max): 1536 MB 08:32:53 INFO - Vendor: Intel (0x8086) 08:32:53 INFO - Device ID: 0x0a2e 08:32:53 INFO - Revision ID: 0x0009 08:32:53 INFO - Displays: 08:32:53 INFO - Display: 08:32:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:32:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:32:53 INFO - Display Serial Number: 1600x1200 60 08:32:53 INFO - Main Display: Yes 08:32:53 INFO - Mirror: Off 08:32:53 INFO - Online: Yes 08:32:53 INFO - Rotation: Supported 08:32:53 INFO - Return code: 0 08:32:53 INFO - Running post-action listener: _resource_record_post_action 08:32:53 INFO - [mozharness: 2017-02-17 16:32:53.821648Z] Finished run-tests step (success) 08:32:53 INFO - Running post-run listener: _resource_record_post_run 08:32:53 INFO - Total resource usage - Wall time: 1200s; CPU: 53.0%; Read bytes: 1609728; Write bytes: 501535232; Read time: 10; Write time: 1592 08:32:53 INFO - TinderboxPrint: CPU usage
53.3% 08:32:53 INFO - TinderboxPrint: I/O read bytes / time
1,609,728 / 10 08:32:53 INFO - TinderboxPrint: I/O write bytes / time
501,535,232 / 1,592 08:32:53 INFO - TinderboxPrint: CPU idle
2,241.4 (46.7%) 08:32:53 INFO - TinderboxPrint: CPU system
959.0 (20.0%) 08:32:53 INFO - TinderboxPrint: CPU user
1,601.3 (33.3%) 08:32:53 INFO - TinderboxPrint: Swap in / out
192,913,408 / 0 08:32:53 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 187664896; Write bytes: 188187136; Read time: 17079; Write time: 423 08:32:53 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 1609728; Write bytes: 306376704; Read time: 10; Write time: 1137 08:32:54 INFO - Running post-run listener: _upload_blobber_files 08:32:54 INFO - Blob upload gear active. 08:32:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:32:54 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:32:54 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'] 08:32:54 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 08:32:54 INFO - (blobuploader) - INFO - Open directory for files ... 08:32:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:32:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:32:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:32:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:32:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:32:55 INFO - (blobuploader) - INFO - Done attempting. 08:32:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:32:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:32:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:32:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:32:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:32:56 INFO - (blobuploader) - INFO - Done attempting. 08:32:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:32:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:32:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:32:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:32:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:32:58 INFO - (blobuploader) - INFO - Done attempting. 08:32:58 INFO - (blobuploader) - INFO - Iteration through files over. 08:32:58 INFO - Return code: 0 08:32:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:32:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:32:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fa36f34bdf119866ede35bfbcf3503a8bb5509a2f3ff1a2af79345e2b7b3d0e5b8d02a685ce62767aa2d9c163cc6d0e23bfe251bbeda82b6e3b4a08771e08c3a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dfc4879583c3737daf7525b68ddf3a393e46374fba976211ead21cc523c38a1d97fc1034604209563392a0530af6789c5607ea498d8847e6822fec4cdc33938d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/36e045343c3cf69087082004137891c9e8af54c97b9a3eaa0fbe5e7c31268f224759f81f99d31bf2a218666f66e0510953507a7f839234f9cbf989a90f3edd73"} 08:32:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:32:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:32:58 INFO - Contents: 08:32:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fa36f34bdf119866ede35bfbcf3503a8bb5509a2f3ff1a2af79345e2b7b3d0e5b8d02a685ce62767aa2d9c163cc6d0e23bfe251bbeda82b6e3b4a08771e08c3a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dfc4879583c3737daf7525b68ddf3a393e46374fba976211ead21cc523c38a1d97fc1034604209563392a0530af6789c5607ea498d8847e6822fec4cdc33938d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/36e045343c3cf69087082004137891c9e8af54c97b9a3eaa0fbe5e7c31268f224759f81f99d31bf2a218666f66e0510953507a7f839234f9cbf989a90f3edd73"} 08:32:58 INFO - Running post-run listener: copy_logs_to_upload_dir 08:32:58 INFO - Copying logs to upload dir... 08:32:58 INFO - mkdir: /builds/slave/test/build/upload/logs 08:32:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.065708 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-17 08:32:58.583982) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-17 08:32:58.587920) ========= 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.kMaiYpvaaF/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.CdUdADfdoi/Listeners TMPDIR=/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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/fa36f34bdf119866ede35bfbcf3503a8bb5509a2f3ff1a2af79345e2b7b3d0e5b8d02a685ce62767aa2d9c163cc6d0e23bfe251bbeda82b6e3b4a08771e08c3a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dfc4879583c3737daf7525b68ddf3a393e46374fba976211ead21cc523c38a1d97fc1034604209563392a0530af6789c5607ea498d8847e6822fec4cdc33938d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/36e045343c3cf69087082004137891c9e8af54c97b9a3eaa0fbe5e7c31268f224759f81f99d31bf2a218666f66e0510953507a7f839234f9cbf989a90f3edd73"} build_url:https://queue.taskcluster.net/v1/task/IrV7ePewRYmMaRPuHkUP8Q/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011108 build_url: 'https://queue.taskcluster.net/v1/task/IrV7ePewRYmMaRPuHkUP8Q/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/fa36f34bdf119866ede35bfbcf3503a8bb5509a2f3ff1a2af79345e2b7b3d0e5b8d02a685ce62767aa2d9c163cc6d0e23bfe251bbeda82b6e3b4a08771e08c3a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dfc4879583c3737daf7525b68ddf3a393e46374fba976211ead21cc523c38a1d97fc1034604209563392a0530af6789c5607ea498d8847e6822fec4cdc33938d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/36e045343c3cf69087082004137891c9e8af54c97b9a3eaa0fbe5e7c31268f224759f81f99d31bf2a218666f66e0510953507a7f839234f9cbf989a90f3edd73"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-17 08:32:58.630656) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 08:32:58.631000) ========= 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.kMaiYpvaaF/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.CdUdADfdoi/Listeners TMPDIR=/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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.005191 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 08:32:58.680884) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-17 08:32:58.681241) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-17 08:32:58.681655) ========= ========= Total master_lag: 0.20 =========