builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0062 starttime: 1494548218.38 results: success (0) revision: 7e0e20683d5ab7ac8238251fa411ef3027daa22e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-11 17:16:58.381899) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-11 17:16:58.382392) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-11 17:16:58.382693) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-11 17:16:58.408719) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 17:16:58.409129) ========= 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.PdtxviW2FT/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.uAajBC7xUc/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-05-11 17:16:58-- 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% 8.91M=0.001s 2017-05-11 17:16:58 (8.91 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.102958 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 17:16:58.535145) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 17:16:58.535463) ========= 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.PdtxviW2FT/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.uAajBC7xUc/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.034769 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 17:16:58.591512) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-11 17:16:58.591898) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7e0e20683d5ab7ac8238251fa411ef3027daa22e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 7e0e20683d5ab7ac8238251fa411ef3027daa22e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PdtxviW2FT/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.uAajBC7xUc/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-05-11 17:16:58,690 truncating revision to first 12 chars 2017-05-11 17:16:58,690 Setting DEBUG logging. 2017-05-11 17:16:58,690 attempt 1/10 2017-05-11 17:16:58,690 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7e0e20683d5a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-11 17:16:59,992 unpacking tar archive at: mozilla-central-7e0e20683d5a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.571004 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-11 17:17:00.185298) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-11 17:17:00.185617) ========= script_repo_revision: 7e0e20683d5ab7ac8238251fa411ef3027daa22e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-11 17:17:00.186020) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-11 17:17:00.186297) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-11 17:17:00.205333) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 41 mins, 26 secs) (at 2017-05-11 17:17:00.205692) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PdtxviW2FT/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.uAajBC7xUc/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 17:17:00 INFO - MultiFileLogger online at 20170511 17:17:00 in /builds/slave/test 17:17:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:17:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:17:00 INFO - {'append_to_log': False, 17:17:00 INFO - 'base_work_dir': '/builds/slave/test', 17:17:00 INFO - 'blob_upload_branch': 'Firefox', 17:17:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:17:00 INFO - 'branch': 'Firefox', 17:17:00 INFO - 'buildbot_json_path': 'buildprops.json', 17:17:00 INFO - 'config_files': ('talos/mac_config.py',), 17:17:00 INFO - 'default_actions': ('clobber', 17:17:00 INFO - 'read-buildbot-config', 17:17:00 INFO - 'download-and-extract', 17:17:00 INFO - 'populate-webroot', 17:17:00 INFO - 'create-virtualenv', 17:17:00 INFO - 'install', 17:17:00 INFO - 'run-tests'), 17:17:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:17:00 INFO - 'download_minidump_stackwalk': True, 17:17:00 INFO - 'download_symbols': 'ondemand', 17:17:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:17:00 INFO - 'tooltool.py': '/tools/tooltool.py', 17:17:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:17:00 INFO - '/tools/misc-python/virtualenv.py')}, 17:17:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:17:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:17:00 INFO - 'gecko_profile': False, 17:17:00 INFO - 'gecko_profile_interval': 0, 17:17:00 INFO - 'installer_path': 'installer.exe', 17:17:00 INFO - 'log_level': 'info', 17:17:00 INFO - 'log_name': 'talos', 17:17:00 INFO - 'log_to_console': True, 17:17:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:17:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:17:00 INFO - 'opt_config_files': (), 17:17:00 INFO - 'pip_index': False, 17:17:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:17:00 INFO - 'cmd': ('bash', 17:17:00 INFO - '-c', 17:17:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:17:00 INFO - 'enabled': True, 17:17:00 INFO - 'halt_on_failure': False, 17:17:00 INFO - 'name': 'check_screen_resolution'},), 17:17:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:17:00 INFO - 'cmd': ('bash', 17:17:00 INFO - '-c', 17:17:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:17:00 INFO - 'enabled': True, 17:17:00 INFO - 'halt_on_failure': False, 17:17:00 INFO - 'name': 'check_screen_resolution'},), 17:17:00 INFO - 'run_cmd_checks_enabled': True, 17:17:00 INFO - 'suite': 'dromaeojs', 17:17:00 INFO - 'system_bits': '32', 17:17:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:17:00 INFO - 'title': 't-yosemite-r7-0062', 17:17:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:17:00 INFO - 'use_talos_json': True, 17:17:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:17:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:17:00 INFO - 'work_dir': 'build'} 17:17:00 INFO - [mozharness: 2017-05-12 00:17:00.415000Z] Running clobber step. 17:17:00 INFO - Running pre-action listener: _resource_record_pre_action 17:17:00 INFO - Running main action method: clobber 17:17:00 INFO - rmtree: /builds/slave/test/build 17:17:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:17:02 INFO - Running post-action listener: _resource_record_post_action 17:17:02 INFO - [mozharness: 2017-05-12 00:17:02.966640Z] Finished clobber step (success) 17:17:02 INFO - [mozharness: 2017-05-12 00:17:02.966825Z] Running read-buildbot-config step. 17:17:02 INFO - Running pre-action listener: _resource_record_pre_action 17:17:02 INFO - Running main action method: read_buildbot_config 17:17:02 INFO - Using buildbot properties: 17:17:02 INFO - { 17:17:02 INFO - "project": "", 17:17:02 INFO - "product": "firefox", 17:17:02 INFO - "who": "eakhgari@mozilla.com", 17:17:02 INFO - "installer_path": "public/build/firefox-55.0a1.en-US.mac.dmg", 17:17:02 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 17:17:02 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 17:17:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 17:17:02 INFO - "stage_platform": "macosx64", 17:17:02 INFO - "basedir": "/builds/slave/test", 17:17:02 INFO - "buildnumber": 32, 17:17:02 INFO - "platform": "yosemite_r7", 17:17:02 INFO - "parent_task_id": "FqKUAENdSTOt7TyVMIohig", 17:17:02 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 17:17:02 INFO - "slavebuilddir": "test", 17:17:02 INFO - "taskId": "M7GqSeaiTS2kVM4AoiNE-Q", 17:17:02 INFO - "branch": "mozilla-central", 17:17:02 INFO - "script_repo_revision": "production", 17:17:02 INFO - "revision": "7e0e20683d5ab7ac8238251fa411ef3027daa22e", 17:17:02 INFO - "slavename": "t-yosemite-r7-0062", 17:17:02 INFO - "repo_path": "mozilla-central" 17:17:02 INFO - } 17:17:02 INFO - Finding installer, test and symbols from parent task. 17:17:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M7GqSeaiTS2kVM4AoiNE-Q'}, attempt #1 17:17:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M7GqSeaiTS2kVM4AoiNE-Q'}, attempt #1 17:17:03 INFO - Task dependencies: WYRzbGkxTNSckRZMCZ7L9Q 17:17:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FqKUAENdSTOt7TyVMIohig'}, attempt #1 17:17:04 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FqKUAENdSTOt7TyVMIohig/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:17:04 INFO - Set test_url: https://queue.taskcluster.net/v1/task/FqKUAENdSTOt7TyVMIohig/artifacts/public/build/test_packages.json 17:17:04 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FqKUAENdSTOt7TyVMIohig/artifacts/public/build/target.crashreporter-symbols.zip 17:17:04 INFO - Running post-action listener: _resource_record_post_action 17:17:04 INFO - [mozharness: 2017-05-12 00:17:04.337103Z] Finished read-buildbot-config step (success) 17:17:04 INFO - [mozharness: 2017-05-12 00:17:04.337246Z] Running download-and-extract step. 17:17:04 INFO - Running pre-action listener: _resource_record_pre_action 17:17:04 INFO - Running main action method: download_and_extract 17:17:04 INFO - mkdir: /builds/slave/test/build/tests 17:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:04 INFO - trying https://queue.taskcluster.net/v1/task/FqKUAENdSTOt7TyVMIohig/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 17:17:04 INFO - Downloading https://queue.taskcluster.net/v1/task/FqKUAENdSTOt7TyVMIohig/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 17:17:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FqKUAENdSTOt7TyVMIohig/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 17:17:05 INFO - Downloaded 1325 bytes. 17:17:05 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 17:17:05 INFO - Using the following test package requirements: 17:17:05 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:17:05 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 17:17:05 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:17:05 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:17:05 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 17:17:05 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:17:05 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 17:17:05 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:17:05 INFO - u'jsshell-mac.zip'], 17:17:05 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:17:05 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 17:17:05 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:17:05 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:17:05 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 17:17:05 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:17:05 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 17:17:05 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:17:05 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 17:17:05 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:17:05 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 17:17:05 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:17:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FqKUAENdSTOt7TyVMIohig/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 17:17:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FqKUAENdSTOt7TyVMIohig/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:17:05 INFO - Fetch https://queue.taskcluster.net/v1/task/FqKUAENdSTOt7TyVMIohig/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:17:06 INFO - Content-Length response header: 52709560 17:17:06 INFO - Bytes received: 52709560 17:17:23 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:17:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FqKUAENdSTOt7TyVMIohig/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 17:17:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FqKUAENdSTOt7TyVMIohig/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:17:23 INFO - Fetch https://queue.taskcluster.net/v1/task/FqKUAENdSTOt7TyVMIohig/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:17:25 INFO - Content-Length response header: 52709560 17:17:25 INFO - Bytes received: 52709560 17:17:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FqKUAENdSTOt7TyVMIohig/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 17:17:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FqKUAENdSTOt7TyVMIohig/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:17:40 INFO - Fetch https://queue.taskcluster.net/v1/task/FqKUAENdSTOt7TyVMIohig/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 17:17:41 INFO - Content-Length response header: 14409411 17:17:41 INFO - Bytes received: 14409411 17:17: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')]} 17:17:42 INFO - trying https://queue.taskcluster.net/v1/task/FqKUAENdSTOt7TyVMIohig/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:17:42 INFO - Downloading https://queue.taskcluster.net/v1/task/FqKUAENdSTOt7TyVMIohig/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 17:17:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FqKUAENdSTOt7TyVMIohig/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 17:17:45 INFO - Downloaded 75541162 bytes. 17:17:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FqKUAENdSTOt7TyVMIohig/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:17:45 INFO - mkdir: /builds/slave/test/properties 17:17:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:17:45 INFO - Writing to file /builds/slave/test/properties/build_url 17:17:45 INFO - Contents: 17:17:45 INFO - build_url:https://queue.taskcluster.net/v1/task/FqKUAENdSTOt7TyVMIohig/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:17:45 INFO - Running post-action listener: _resource_record_post_action 17:17:45 INFO - Running post-action listener: set_extra_try_arguments 17:17:45 INFO - [mozharness: 2017-05-12 00:17:45.504736Z] Finished download-and-extract step (success) 17:17:45 INFO - [mozharness: 2017-05-12 00:17:45.504872Z] Running populate-webroot step. 17:17:45 INFO - Running pre-action listener: _resource_record_pre_action 17:17:45 INFO - Running main action method: populate_webroot 17:17:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:17:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:17:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:17:45 INFO - '--tppagecycles', 17:17:45 INFO - '7'], 17:17:45 INFO - 'tests': ['tsvgm']}}, 17:17:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:17:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:17:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:17:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:17:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:17:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:17:45 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:17:45 INFO - 'talos_options': ['--disable-e10s'], 17:17:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:17:45 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:17:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:17:45 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:17:45 INFO - 'talos_options': ['--disable-e10s'], 17:17:45 INFO - 'tests': ['damp', 'tps']}, 17:17:45 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:17:45 INFO - 'tests': ['damp', 'tps']}, 17:17:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:17:45 INFO - 'tests': ['dromaeo_dom']}, 17:17:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:17:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:17:45 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:17:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:17:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:17:45 INFO - 'tests': ['a11yr', 17:17:45 INFO - 'ts_paint', 17:17:45 INFO - 'tpaint', 17:17:45 INFO - 'sessionrestore', 17:17:45 INFO - 'sessionrestore_no_auto_restore', 17:17:45 INFO - 'tabpaint']}, 17:17:45 INFO - 'other-e10s': {'tests': ['a11yr', 17:17:45 INFO - 'ts_paint', 17:17:45 INFO - 'tpaint', 17:17:45 INFO - 'sessionrestore', 17:17:45 INFO - 'sessionrestore_no_auto_restore', 17:17:45 INFO - 'tabpaint']}, 17:17:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:17:45 INFO - 'ts_paint', 17:17:45 INFO - 'tpaint', 17:17:45 INFO - 'sessionrestore', 17:17:45 INFO - 'sessionrestore_no_auto_restore', 17:17:45 INFO - 'tabpaint']}, 17:17:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:17:45 INFO - 'ts_paint', 17:17:45 INFO - 'tpaint', 17:17:45 INFO - 'sessionrestore', 17:17:45 INFO - 'sessionrestore_no_auto_restore', 17:17:45 INFO - 'tabpaint']}, 17:17:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:17:45 INFO - 'tests': ['a11yr', 17:17:45 INFO - 'ts_paint', 17:17:45 INFO - 'tpaint', 17:17:45 INFO - 'sessionrestore', 17:17:45 INFO - 'sessionrestore_no_auto_restore', 17:17:45 INFO - 'tabpaint']}, 17:17:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:17:45 INFO - 'tests': ['a11yr', 17:17:45 INFO - 'ts_paint', 17:17:45 INFO - 'tpaint', 17:17:45 INFO - 'sessionrestore', 17:17:45 INFO - 'sessionrestore_no_auto_restore', 17:17:45 INFO - 'tabpaint']}, 17:17:45 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 17:17:45 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 17:17:45 INFO - 'bloom_basic_ref']}, 17:17:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:17:45 INFO - 'tests': ['tsvgx', 17:17:45 INFO - 'tsvgr_opacity', 17:17:45 INFO - 'tart', 17:17:45 INFO - 'tscrollx', 17:17:45 INFO - 'cart', 17:17:45 INFO - 'tsvg_static']}, 17:17:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:17:45 INFO - 'tsvgr_opacity', 17:17:45 INFO - 'tart', 17:17:45 INFO - 'tscrollx', 17:17:45 INFO - 'cart', 17:17:45 INFO - 'tsvg_static']}, 17:17:45 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:17:45 INFO - 'talos_options': ['--disable-e10s'], 17:17:45 INFO - 'tests': ['tp5o']}, 17:17:45 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:17:45 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:17:45 INFO - 'talos_options': ['--disable-e10s', 17:17:45 INFO - '--xperf_path', 17:17:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:17:45 INFO - 'tests': ['tp5n']}, 17:17:45 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:17:45 INFO - 'talos_options': ['--xperf_path', 17:17:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:17:45 INFO - 'tests': ['tp5n']}}, 17:17:45 INFO - 'talos.zip': {'path': '', 17:17:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:17:45 INFO - Running post-action listener: _resource_record_post_action 17:17:45 INFO - [mozharness: 2017-05-12 00:17:45.525717Z] Finished populate-webroot step (success) 17:17:45 INFO - [mozharness: 2017-05-12 00:17:45.525854Z] Running create-virtualenv step. 17:17:45 INFO - Running pre-action listener: _resource_record_pre_action 17:17:45 INFO - Running main action method: create_virtualenv 17:17:45 INFO - Creating virtualenv /builds/slave/test/build/venv 17:17:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:17:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:17:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:17:45 INFO - Using real prefix '/tools/python27' 17:17:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:17:46 INFO - Installing distribute.............................................................................................................................................................................................done. 17:17:49 INFO - Installing pip.................done. 17:17:49 INFO - Return code: 0 17:17:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:17:49 INFO - Reading from file tmpfile_stdout 17:17:49 INFO - Output received: 17:17:49 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 17:17:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:49 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 0x10c7f0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6994c89f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c501d30>, '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 0x10c4b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c4f5be8>, '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.PdtxviW2FT/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.uAajBC7xUc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:17:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:17:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PdtxviW2FT/Render', 17:17:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:49 INFO - 'HOME': '/Users/cltbld', 17:17:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:49 INFO - 'LOGNAME': 'cltbld', 17:17:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:49 INFO - 'MOZ_NO_REMOTE': '1', 17:17:49 INFO - 'NO_EM_RESTART': '1', 17:17:49 INFO - 'PAGER': '/bin/cat', 17:17:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:49 INFO - 'PWD': '/builds/slave/test', 17:17:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:49 INFO - 'SHELL': '/bin/bash', 17:17:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uAajBC7xUc/Listeners', 17:17:49 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 17:17:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:49 INFO - 'USER': 'cltbld', 17:17:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:49 INFO - 'XPC_FLAGS': '0x0', 17:17:49 INFO - 'XPC_SERVICE_NAME': '0', 17:17:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:17:49 INFO - Cleaning up... 17:17:49 INFO - Return code: 0 17:17:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:49 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 0x10c7f0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6994c89f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c501d30>, '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 0x10c4b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c4f5be8>, '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.PdtxviW2FT/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.uAajBC7xUc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:17:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:17:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PdtxviW2FT/Render', 17:17:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:49 INFO - 'HOME': '/Users/cltbld', 17:17:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:49 INFO - 'LOGNAME': 'cltbld', 17:17:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:49 INFO - 'MOZ_NO_REMOTE': '1', 17:17:49 INFO - 'NO_EM_RESTART': '1', 17:17:49 INFO - 'PAGER': '/bin/cat', 17:17:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:49 INFO - 'PWD': '/builds/slave/test', 17:17:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:49 INFO - 'SHELL': '/bin/bash', 17:17:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uAajBC7xUc/Listeners', 17:17:49 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 17:17:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:49 INFO - 'USER': 'cltbld', 17:17:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:49 INFO - 'XPC_FLAGS': '0x0', 17:17:49 INFO - 'XPC_SERVICE_NAME': '0', 17:17:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:50 INFO - Downloading/unpacking psutil>=3.1.1 17:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:20:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:20:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:20:22 INFO - Installing collected packages: psutil 17:20:22 INFO - Running setup.py install for psutil 17:20:22 INFO - building 'psutil._psutil_osx' extension 17:20:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 17:20:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 17:20:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 17:20:23 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 17:20:23 INFO - building 'psutil._psutil_posix' extension 17:20:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 17:20:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:20:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:20:23 INFO - ^ 17:20:23 INFO - 1 warning generated. 17:20:23 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 17:20:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:20:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:20:23 INFO - Successfully installed psutil 17:20:23 INFO - Cleaning up... 17:20:24 INFO - Return code: 0 17:20:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:20: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')]} 17:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20: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')]} 17:20:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6994c89f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c501d30>, '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 0x10c4b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c4f5be8>, '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.PdtxviW2FT/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.uAajBC7xUc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:20: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:20: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 mozsystemmonitor==0.3 17:20:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PdtxviW2FT/Render', 17:20:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:20:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:20:24 INFO - 'HOME': '/Users/cltbld', 17:20:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:20:24 INFO - 'LOGNAME': 'cltbld', 17:20:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:24 INFO - 'MOZ_NO_REMOTE': '1', 17:20:24 INFO - 'NO_EM_RESTART': '1', 17:20:24 INFO - 'PAGER': '/bin/cat', 17:20:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:20:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:24 INFO - 'PWD': '/builds/slave/test', 17:20:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:20:24 INFO - 'SHELL': '/bin/bash', 17:20:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uAajBC7xUc/Listeners', 17:20:24 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 17:20:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:20:24 INFO - 'USER': 'cltbld', 17:20:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:20:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:20:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:24 INFO - 'XPC_FLAGS': '0x0', 17:20:24 INFO - 'XPC_SERVICE_NAME': '0', 17:20:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:20:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:20: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 17:20: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 17:20: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 17:20: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 17:20: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 17:20: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 17:22:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:22:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:22:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:22:57 INFO - Installing collected packages: mozsystemmonitor 17:22:57 INFO - Running setup.py install for mozsystemmonitor 17:22:57 INFO - Successfully installed mozsystemmonitor 17:22:57 INFO - Cleaning up... 17:22:57 INFO - Return code: 0 17:22:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c7f0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6994c89f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c501d30>, '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 0x10c4b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c4f5be8>, '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.PdtxviW2FT/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.uAajBC7xUc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:22:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:22:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:22:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PdtxviW2FT/Render', 17:22:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:22:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:22:58 INFO - 'HOME': '/Users/cltbld', 17:22:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:22:58 INFO - 'LOGNAME': 'cltbld', 17:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:58 INFO - 'MOZ_NO_REMOTE': '1', 17:22:58 INFO - 'NO_EM_RESTART': '1', 17:22:58 INFO - 'PAGER': '/bin/cat', 17:22:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:58 INFO - 'PWD': '/builds/slave/test', 17:22:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:22:58 INFO - 'SHELL': '/bin/bash', 17:22:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uAajBC7xUc/Listeners', 17:22:58 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 17:22:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:22:58 INFO - 'USER': 'cltbld', 17:22:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:22:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:58 INFO - 'XPC_FLAGS': '0x0', 17:22:58 INFO - 'XPC_SERVICE_NAME': '0', 17:22:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:22:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:59 INFO - Downloading/unpacking jsonschema==2.5.1 17:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:22:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:22:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:22:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:22:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:25:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:25:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:01 INFO - Downloading functools32-3.2.3-2.tar.gz 17:28:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:28:01 INFO - warning: no files found matching '*.txt' 17:28:01 INFO - no previously-included directories found matching 'build' 17:28:01 INFO - no previously-included directories found matching 'dist' 17:28:01 INFO - no previously-included directories found matching '.git*' 17:28:01 INFO - Installing collected packages: jsonschema, functools32 17:28:01 INFO - Running setup.py install for functools32 17:28:02 INFO - warning: no files found matching '*.txt' 17:28:02 INFO - no previously-included directories found matching 'build' 17:28:02 INFO - no previously-included directories found matching 'dist' 17:28:02 INFO - no previously-included directories found matching '.git*' 17:28:02 INFO - Successfully installed jsonschema functools32 17:28:02 INFO - Cleaning up... 17:28:02 INFO - Return code: 0 17:28:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:28:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c7f0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6994c89f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c501d30>, '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 0x10c4b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c4f5be8>, '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.PdtxviW2FT/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.uAajBC7xUc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:28:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:28:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:28:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PdtxviW2FT/Render', 17:28:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:28:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:28:03 INFO - 'HOME': '/Users/cltbld', 17:28:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:28:03 INFO - 'LOGNAME': 'cltbld', 17:28:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:03 INFO - 'MOZ_NO_REMOTE': '1', 17:28:03 INFO - 'NO_EM_RESTART': '1', 17:28:03 INFO - 'PAGER': '/bin/cat', 17:28:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:28:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:03 INFO - 'PWD': '/builds/slave/test', 17:28:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:28:03 INFO - 'SHELL': '/bin/bash', 17:28:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uAajBC7xUc/Listeners', 17:28:03 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 17:28:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:28:03 INFO - 'USER': 'cltbld', 17:28:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:28:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:28:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:03 INFO - 'XPC_FLAGS': '0x0', 17:28:03 INFO - 'XPC_SERVICE_NAME': '0', 17:28:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:28:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:28:03 INFO - Cleaning up... 17:28:04 INFO - Return code: 0 17:28:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c7f0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6994c89f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c501d30>, '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 0x10c4b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c4f5be8>, '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.PdtxviW2FT/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.uAajBC7xUc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:28:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:28:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:28:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PdtxviW2FT/Render', 17:28:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:28:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:28:04 INFO - 'HOME': '/Users/cltbld', 17:28:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:28:04 INFO - 'LOGNAME': 'cltbld', 17:28:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:04 INFO - 'MOZ_NO_REMOTE': '1', 17:28:04 INFO - 'NO_EM_RESTART': '1', 17:28:04 INFO - 'PAGER': '/bin/cat', 17:28:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:28:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:04 INFO - 'PWD': '/builds/slave/test', 17:28:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:28:04 INFO - 'SHELL': '/bin/bash', 17:28:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uAajBC7xUc/Listeners', 17:28:04 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 17:28:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:28:04 INFO - 'USER': 'cltbld', 17:28:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:28:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:28:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:04 INFO - 'XPC_FLAGS': '0x0', 17:28:04 INFO - 'XPC_SERVICE_NAME': '0', 17:28:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:28:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:04 INFO - Downloading/unpacking blobuploader==1.2.4 17:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:30:36 INFO - Downloading blobuploader-1.2.4.tar.gz 17:30:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:30:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:30:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:30:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:30:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:30:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:33:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:33:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:33:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:33:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:37 INFO - Downloading docopt-0.6.1.tar.gz 17:35:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:35:37 INFO - Installing collected packages: blobuploader, requests, docopt 17:35:37 INFO - Running setup.py install for blobuploader 17:35:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:35:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:35:38 INFO - Running setup.py install for requests 17:35:38 INFO - Running setup.py install for docopt 17:35:38 INFO - Successfully installed blobuploader requests docopt 17:35:38 INFO - Cleaning up... 17:35:38 INFO - Return code: 0 17:35:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:39 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 0x10c7f0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6994c89f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c501d30>, '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 0x10c4b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c4f5be8>, '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.PdtxviW2FT/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.uAajBC7xUc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:35:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:35:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:35:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PdtxviW2FT/Render', 17:35:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:35:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:35:39 INFO - 'HOME': '/Users/cltbld', 17:35:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:35:39 INFO - 'LOGNAME': 'cltbld', 17:35:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:39 INFO - 'MOZ_NO_REMOTE': '1', 17:35:39 INFO - 'NO_EM_RESTART': '1', 17:35:39 INFO - 'PAGER': '/bin/cat', 17:35:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:35:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:39 INFO - 'PWD': '/builds/slave/test', 17:35:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:35:39 INFO - 'SHELL': '/bin/bash', 17:35:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uAajBC7xUc/Listeners', 17:35:39 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 17:35:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:35:39 INFO - 'USER': 'cltbld', 17:35:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:35:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:35:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:39 INFO - 'XPC_FLAGS': '0x0', 17:35:39 INFO - 'XPC_SERVICE_NAME': '0', 17:35:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:35:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:35:40 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-7A5o3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:35:40 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-O7Mtpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:35:40 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-ue2qzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:35:40 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-o3bYLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:35:40 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-oHwatz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:35:40 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-TXrl7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:35:40 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-TKV7T4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:35:40 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-Rlp4gQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:35:40 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-8f3Nf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:35:40 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-FRYCfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:35:41 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-pkp5pN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:35:41 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-DrotEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:35:41 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-EOb4Ib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:35:41 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-OQAU8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:41 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-qiCUNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:35:41 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-axYxW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:35:41 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-ECtHpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:35:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:35:41 INFO - Running setup.py install for manifestparser 17:35:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:35:41 INFO - Running setup.py install for mozcrash 17:35:42 INFO - Running setup.py install for mozdebug 17:35:42 INFO - Running setup.py install for mozdevice 17:35:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:35:42 INFO - Running setup.py install for mozfile 17:35:42 INFO - Running setup.py install for mozhttpd 17:35:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:35:42 INFO - Running setup.py install for mozinfo 17:35:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:35:42 INFO - Running setup.py install for mozInstall 17:35:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:35:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:35:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:35:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:35:42 INFO - Running setup.py install for mozleak 17:35:43 INFO - Running setup.py install for mozlog 17:35:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:35:43 INFO - Running setup.py install for moznetwork 17:35:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:35:43 INFO - Running setup.py install for mozprocess 17:35:43 INFO - Running setup.py install for mozprofile 17:35:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:35:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:35:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:35:43 INFO - Running setup.py install for mozrunner 17:35:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:35:43 INFO - Running setup.py install for mozscreenshot 17:35:44 INFO - Running setup.py install for moztest 17:35:44 INFO - Running setup.py install for mozversion 17:35:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:35:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:35:44 INFO - Cleaning up... 17:35:44 INFO - Return code: 0 17:35:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:35:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:44 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 0x10c7f0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6994c89f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c501d30>, '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 0x10c4b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c4f5be8>, '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.PdtxviW2FT/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.uAajBC7xUc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:35:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:35:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:35:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PdtxviW2FT/Render', 17:35:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:35:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:35:44 INFO - 'HOME': '/Users/cltbld', 17:35:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:35:44 INFO - 'LOGNAME': 'cltbld', 17:35:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:44 INFO - 'MOZ_NO_REMOTE': '1', 17:35:44 INFO - 'NO_EM_RESTART': '1', 17:35:44 INFO - 'PAGER': '/bin/cat', 17:35:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:35:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:44 INFO - 'PWD': '/builds/slave/test', 17:35:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:35:44 INFO - 'SHELL': '/bin/bash', 17:35:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uAajBC7xUc/Listeners', 17:35:44 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 17:35:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:35:44 INFO - 'USER': 'cltbld', 17:35:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:35:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:35:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:44 INFO - 'XPC_FLAGS': '0x0', 17:35:44 INFO - 'XPC_SERVICE_NAME': '0', 17:35:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:35:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:35:44 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-bMMJm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:35:44 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-FayKGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:35:44 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-YwMqra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:35:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:35:45 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-uMnNxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:35:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:35:45 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-j_i8Vm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:35:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:35:45 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-_VwHhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:35:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:35:45 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-DPXfuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:35:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:35:45 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-99WlUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:35:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:35:45 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-CtoDT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:35:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:35:45 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-4nBuVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:35:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:35:45 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-TErvwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:35:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:35:45 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-I1Fu_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:35:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:35:45 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-kWYxxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:35:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:35:46 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-uo5nRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:35:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:46 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-EYSXSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:35:46 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-jkanWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:35:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:35:46 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-SHJCrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:35:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:35:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:35:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:35:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:35:46 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:35:46 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:35:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:35:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:18 INFO - Downloading blessings-1.6.tar.gz 17:38:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:38:18 INFO - Installing collected packages: blessings 17:38:18 INFO - Running setup.py install for blessings 17:38:19 INFO - Successfully installed blessings 17:38:19 INFO - Cleaning up... 17:38:19 INFO - Return code: 0 17:38:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:38:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:38:19 INFO - Reading from file tmpfile_stdout 17:38:19 INFO - Current package versions: 17:38:19 INFO - blessings == 1.6 17:38:19 INFO - blobuploader == 1.2.4 17:38:19 INFO - docopt == 0.6.1 17:38:19 INFO - functools32 == 3.2.3-2 17:38:19 INFO - jsonschema == 2.5.1 17:38:19 INFO - manifestparser == 1.1 17:38:19 INFO - mozInstall == 1.12 17:38:19 INFO - mozcrash == 1.0 17:38:19 INFO - mozdebug == 0.1 17:38:19 INFO - mozdevice == 0.50 17:38:19 INFO - mozfile == 1.2 17:38:19 INFO - mozhttpd == 0.7 17:38:19 INFO - mozinfo == 0.9 17:38:19 INFO - mozleak == 0.1 17:38:19 INFO - mozlog == 3.4 17:38:19 INFO - moznetwork == 0.27 17:38:19 INFO - mozprocess == 0.25 17:38:19 INFO - mozprofile == 0.28 17:38:19 INFO - mozrunner == 6.13 17:38:19 INFO - mozscreenshot == 0.1 17:38:19 INFO - mozsystemmonitor == 0.3 17:38:19 INFO - moztest == 0.8 17:38:19 INFO - mozversion == 1.4 17:38:19 INFO - psutil == 3.1.1 17:38:19 INFO - requests == 1.2.3 17:38:19 INFO - wsgiref == 0.1.2 17:38:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:20 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 0x10c7f0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6994c89f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c501d30>, '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 0x10c4b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c4f5be8>, '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.PdtxviW2FT/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.uAajBC7xUc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:38:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:38:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:38:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PdtxviW2FT/Render', 17:38:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:20 INFO - 'HOME': '/Users/cltbld', 17:38:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:20 INFO - 'LOGNAME': 'cltbld', 17:38:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:20 INFO - 'MOZ_NO_REMOTE': '1', 17:38:20 INFO - 'NO_EM_RESTART': '1', 17:38:20 INFO - 'PAGER': '/bin/cat', 17:38:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:20 INFO - 'PWD': '/builds/slave/test', 17:38:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:20 INFO - 'SHELL': '/bin/bash', 17:38:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uAajBC7xUc/Listeners', 17:38:20 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 17:38:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:20 INFO - 'USER': 'cltbld', 17:38:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:20 INFO - 'XPC_FLAGS': '0x0', 17:38:20 INFO - 'XPC_SERVICE_NAME': '0', 17:38:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:38:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:38:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:38:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:38:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:38:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:38:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:38:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:38:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:38:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:38:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:38:20 INFO - Cleaning up... 17:38:21 INFO - Return code: 0 17:38:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:38:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6994c89f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c501d30>, '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 0x10c4b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c4f5be8>, '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.PdtxviW2FT/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.uAajBC7xUc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:38:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:38:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:38:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PdtxviW2FT/Render', 17:38:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:21 INFO - 'HOME': '/Users/cltbld', 17:38:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:21 INFO - 'LOGNAME': 'cltbld', 17:38:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:21 INFO - 'MOZ_NO_REMOTE': '1', 17:38:21 INFO - 'NO_EM_RESTART': '1', 17:38:21 INFO - 'PAGER': '/bin/cat', 17:38:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:21 INFO - 'PWD': '/builds/slave/test', 17:38:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:21 INFO - 'SHELL': '/bin/bash', 17:38:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uAajBC7xUc/Listeners', 17:38:21 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 17:38:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:21 INFO - 'USER': 'cltbld', 17:38:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:21 INFO - 'XPC_FLAGS': '0x0', 17:38:21 INFO - 'XPC_SERVICE_NAME': '0', 17:38:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:38:21 INFO - Cleaning up... 17:38:21 INFO - Return code: 0 17:38:21 INFO - Running post-action listener: _resource_record_post_action 17:38:21 INFO - Running post-action listener: _start_resource_monitoring 17:38:21 INFO - Starting resource monitoring. 17:38:21 INFO - [mozharness: 2017-05-12 00:38:21.309636Z] Finished create-virtualenv step (success) 17:38:21 INFO - [mozharness: 2017-05-12 00:38:21.310679Z] Running install step. 17:38:21 INFO - Running pre-action listener: _resource_record_pre_action 17:38:21 INFO - Running main action method: install 17:38:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:38:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:38:21 INFO - Reading from file tmpfile_stdout 17:38:21 INFO - Detecting whether we're running mozinstall >=1.0... 17:38:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:38:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:38:21 INFO - Reading from file tmpfile_stdout 17:38:21 INFO - Output received: 17:38:21 INFO - Usage: mozinstall [options] installer 17:38:21 INFO - Options: 17:38:21 INFO - -h, --help show this help message and exit 17:38:21 INFO - -d DEST, --destination=DEST 17:38:21 INFO - Directory to install application into. [default: 17:38:21 INFO - "/builds/slave/test"] 17:38:21 INFO - --app=APP Application being installed. [default: firefox] 17:38:21 INFO - mkdir: /builds/slave/test/build/application 17:38:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:38:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:38:42 INFO - Reading from file tmpfile_stdout 17:38:42 INFO - Output received: 17:38:42 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:38:42 INFO - Running post-action listener: _resource_record_post_action 17:38:42 INFO - [mozharness: 2017-05-12 00:38:42.056258Z] Finished install step (success) 17:38:42 INFO - [mozharness: 2017-05-12 00:38:42.056390Z] Running run-tests step. 17:38:42 INFO - Running pre-action listener: _resource_record_pre_action 17:38:42 INFO - Running main action method: run_tests 17:38:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:38:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:38:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:38:42 INFO - 2017-05-11 17:38:42.070 screenresolution[1643:9342] starting screenresolution argv=screenresolution get 17:38:42 INFO - 2017-05-11 17:38:42.073 screenresolution[1643:9342] Display 0: 1600x1200x32@60 17:38:42 INFO - 2017-05-11 17:38:42.079 screenresolution[1644:9345] starting screenresolution argv=screenresolution list 17:38:42 INFO - Available Modes on Display 0 17:38:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:38:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:38:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:38:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:38:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:38:42 INFO - Intel Iris: 17:38:42 INFO - Chipset Model: Intel Iris 17:38:42 INFO - Type: GPU 17:38:42 INFO - Bus: Built-In 17:38:42 INFO - VRAM (Dynamic, Max): 1536 MB 17:38:42 INFO - Vendor: Intel (0x8086) 17:38:42 INFO - Device ID: 0x0a2e 17:38:42 INFO - Revision ID: 0x0009 17:38:42 INFO - Displays: 17:38:42 INFO - Display: 17:38:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:38:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:38:42 INFO - Display Serial Number: 1600x1200 60 17:38:42 INFO - Main Display: Yes 17:38:42 INFO - Mirror: Off 17:38:42 INFO - Online: Yes 17:38:42 INFO - Rotation: Supported 17:38:42 INFO - Return code: 0 17:38:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:38:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:38:42 INFO - Python 2.7.3 17:38:42 INFO - Return code: 0 17:38:42 INFO - grabbing minidump binary from tooltool 17:38: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')]} 17:38:42 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 0x10c501d30>, '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 0x10c4b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c4f5be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:38:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:38:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 17:38:42 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:38:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:38:42 INFO - Return code: 0 17:38:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:38:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:38:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:38:42 INFO - ENV: RUST_BACKTRACE is now 1 17:38:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:38:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:38:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FqKUAENdSTOt7TyVMIohig/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:38:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FqKUAENdSTOt7TyVMIohig/artifacts/public/build/target.crashreporter-symbols.zip --title t-yosemite-r7-0062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:38:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PdtxviW2FT/Render', 17:38:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:42 INFO - 'HOME': '/Users/cltbld', 17:38:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:42 INFO - 'LOGNAME': 'cltbld', 17:38:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:38:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:38:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:42 INFO - 'MOZ_NO_REMOTE': '1', 17:38:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:38:42 INFO - 'NO_EM_RESTART': '1', 17:38:42 INFO - 'PAGER': '/bin/cat', 17:38:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:42 INFO - 'PWD': '/builds/slave/test', 17:38:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:38:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:42 INFO - 'RUST_BACKTRACE': '1', 17:38:42 INFO - 'SHELL': '/bin/bash', 17:38:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uAajBC7xUc/Listeners', 17:38:42 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 17:38:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:42 INFO - 'USER': 'cltbld', 17:38:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:42 INFO - 'XPC_FLAGS': '0x0', 17:38:42 INFO - 'XPC_SERVICE_NAME': '0', 17:38:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FqKUAENdSTOt7TyVMIohig/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:38:42 INFO - mozversion application_buildid: 20170511160457 17:38:42 INFO - mozversion application_changeset: 7e0e20683d5ab7ac8238251fa411ef3027daa22e 17:38:42 INFO - mozversion application_display_name: Nightly 17:38:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:38:42 INFO - mozversion application_name: Firefox 17:38:42 INFO - mozversion application_remotingname: firefox 17:38:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:38:42 INFO - mozversion application_vendor: Mozilla 17:38:42 INFO - mozversion application_version: 55.0a1 17:38:42 INFO - mozversion platform_buildid: 20170511160457 17:38:42 INFO - mozversion platform_changeset: 7e0e20683d5ab7ac8238251fa411ef3027daa22e 17:38:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:38:42 INFO - mozversion platform_version: 55.0a1 17:38:42 INFO - using testdate: 1494549522 17:38:42 INFO - actual date: 1494549522 17:38:42 INFO - starting webserver on 'localhost:49254' 17:38:42 INFO - SUITE-START | Running 2 tests 17:38:42 INFO - TEST-START | dromaeo_css 17:38:42 INFO - operating with platform_type : mac_ 17:38:42 INFO - Initialising browser for dromaeo_css test... 17:38:42 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmp_KDW6n/profile http://localhost:49254/getInfo.html) 17:38:45 INFO - PID 1654 | __metrics Screen width/height:1600/1200 17:38:45 INFO - PID 1654 | colorDepth:24 17:38:45 INFO - PID 1654 | Browser inner width/height: 1024/691 17:38:45 INFO - PID 1654 | __metrics 17:38:45 INFO - PID 1654 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:38:45 INFO - PID 1654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:38:46 INFO - TEST-INFO | 1654: exit 0 17:38:46 INFO - Browser initialized. 17:38:46 INFO - Running cycle 1/1 for dromaeo_css test... 17:38:46 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmp_KDW6n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:38:57 INFO - PID 1657 | RSS: Main: 231972864 17:38:57 INFO - PID 1657 | 17:42:02 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49254/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49254/tests/dromaeo/cssquery-ext.html) 17:42:04 INFO - PID 1657 | RSS: Main: 407138304 17:42:04 INFO - PID 1657 | 17:45:06 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49254/tests/dromaeo/cssquery-ext.html (next: http://localhost:49254/tests/dromaeo/cssquery-jquery.html) 17:45:07 INFO - PID 1657 | RSS: Main: 368807936 17:45:07 INFO - PID 1657 | 17:48:09 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49254/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49254/tests/dromaeo/cssquery-mootools.html) 17:48:10 INFO - PID 1657 | RSS: Main: 313786368 17:48:10 INFO - PID 1657 | 17:51:12 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49254/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49254/tests/dromaeo/cssquery-prototype.html) 17:51:13 INFO - PID 1657 | RSS: Main: 322174976 17:51:13 INFO - PID 1657 | 17:54:16 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49254/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49254/tests/dromaeo/cssquery-yui.html) 17:54:17 INFO - PID 1657 | RSS: Main: 329138176 17:54:17 INFO - PID 1657 | 17:57:19 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49254/tests/dromaeo/cssquery-yui.html (next: http://localhost:49254/tests/dromaeo/cssquery-dojo.html) 17:57:19 INFO - PID 1657 | RSS: Main: 373432320 17:57:19 INFO - PID 1657 | 17:57:19 INFO - PID 1657 | __start_tp_report 17:57:19 INFO - PID 1657 | _x_x_mozilla_page_load 17:57:19 INFO - PID 1657 | _x_x_mozilla_page_load_details 17:57:19 INFO - PID 1657 | |i|pagename|runs| 17:57:19 INFO - PID 1657 | |0;dojo.html;3511.192425742079;3512.718982481402;3514.5606799150105;3540.752147349686;3595.6224596417374;6016.669083200422;6114.419025732089;6247.843803904899;6252.437280644746;6285.654289014103;6100.27841329238;6147.323794382625;6172.969135154318;6195.938040619592;6211.844703882394;4482.462104547459;5222.712750798704;5275.129603615399;5347.786088556453;5384.40771515135;5435.483629055253;5469.124940009599;5474;5488.69812160331;5545.029619816516;5284.894302113936;5369.087255166631;5388.568914486871;5414.7834086636485;5418.295621569171;5356.839294821161;5413.2150838128255;5424.83725488236;5448.591355648342;5460.153676180198;5366.302380690485;5383;5388.622796404214;5401.918971215396;5414.972925135349;5352.464753524655;5981.730822113015;6216.564840461169;6231.719572619243;6237.189165408513;5365.302510673627;6386.9680651596445;6432.356764323577;6437.0988061671405;6573.375529324707;6677.632730199837;6706.497012724017;6721.529492935497;6728.158980127484;6735.191776986744;6216.906746398718;6255.749770009194;6271.404216599416;6300.558960872695;6312.779052733133;6573.605583664996;6680.86638267232;6758.189017317855;6840.281770414035;6848.178218613798;6497.252815926135;6511.34886511345;6515.283318834924;6516.771912983023;6519.511036672268;6629.204495460575;6671.232808227019;6679.432248258952;6685.130932978682;6686;6389.233292004989;6512.837179070466;6584.473242140713;6594.7032383542855;6601.735930562723;6479;6527.54307198501;6641.767538136142;6644.700988455531;6646.567973081735;5285.418603953562;5291.074062039128;5296.973515132399;5308.761105750251;5313.946860531422;4668.194031401687;4685.554872287127;4723.338732577442;4751.3348131261655;4769.73766442842;6122.969385153046;6147.678249176449;6150.50795936324;6158.983767678283;6231.158793562811;5869.853253668607;6484.703059388141;6686.231083425371;6709.295523969913;6716.093327400738;6249.6875156242;6257.311695713468;6263.342349053375;6272.874542509125;6288.371162883675;4716.669833111718;5733.713314334266;5770.88458230833;5804.129380592861;5818.359980402152;6742.258351581322;6772.52592318533;6797.796066118024;6894.345037221456;6922.169339679271;6478.449331806661;6570.704318305592;6681.498887583548;6688.230853451915;6700.128983232149;6709.024391461218;6766.458683305422;6774.356436138559;6777.118974533476;6899.655017249218;6562.212534495891;6595.307492713196;6614.801555953329;6620.536562440583;6627.237867645283;6442.806715798533;6695.966520167368;6702.296258892746;6705.698243579148;6713.227978782307;6367.90448143269;6386.105945167587;6395.776147834804;6450.064740612679;6467.191601049869;5448.83653490396;5627.690477023803;5829.834033193463;6488.847759352491;6503.154589903283;6321.051842223519;6321.462675672619;6355.807540602751;6375.5537112403545;6393.424591786761;6293.496520278458;6346.4605508532295;6352.174217351715;6405.103285539935;6406.1031455597185;6299.874002520016;6323.873522529431;6345.841353966003;6349.68251587428;6356.078368636614 17:57:19 INFO - PID 1657 | |1;ext.html;748.1994266135234;796.8764841449575;803.9638216280267;1129.7627498225372;1130.3782919394337;26303.210903672873;26834.329141771443;33879.66120338796;37220.62779372205;37270.44094338587;38287;38725.61274387255;38790.030249243784;38866.805665971704;38888.80555597225;8329.541875196861;8458.788530286762;8477.915220847804;8487.787805304855;8500.829983400328;5961.701914904259;6033.728482218311;8253.050899146616;8381.916180838174;8394.45436046655;8388.161183881624;8452.28155606771;8468.068512463624;8473.830523389528;8533.914660853374;8344.249017588416;8411.200935911078;8425.915740842605;8427.536485493296;8432.873506897402;5051.318072060261;5510.9448905511235;5736.110902810029;8179.222973817477;8305;37143.44284835702;37404.251914961824;37410.69062582796;37481.62518374809;37558.62441375606;3568.1793187567005;3598.784072955631;3606.963930360689;3607.6211997740384;3614.2410093880317;30875.22811929697;30903.536446953312;30910.381792364253;30923.690763092305;30924.845375773202;3074.4158609864053;3155.0534839548045;3159.2575744699975;3159.3207460396125;3170.080676603782;301592.96814063593;302249.488752557;302275;302737;302855;49483.25775113376;49602.255966160534;49711.50288497141;49748.751256243486;49771.50228497741;52224.21663674972;52231.73884130631;52243;52367.73816130971;52427;12911.612651620466;12926.289054101926;12987.350632468528;12996.090273680751;13019.414126364147;9322.580483878242;10425.426601536836;10461.215408844368;10574.735631609117;10576.101031412261;11094.057005154653;11190.440477976232;12456.688582785502;12626.621201363974;12629.43167557462;5212.296339994053;5236.1098613235845;5244.790208391698;5254.316938798008;5255.448177941261;1017.2726500552141;1018.6536577563664;1025.5743866295552;1050.9842352364722;1055.2718624149313;19173.137208825636;22541.4364640882;22719.545609088058;24293.878530607235;24315.878420607783;1004.9899501004896;1091.1270983213396;1113.7661091170944;1129.8813624569302;1160.8200728887036;10889.183311251687;11041.227114101936;12548.309842958543;12552.623421297376;12652.683682907817;271761;304601;304928.4260736091;306085;307366;52445.213321800205;52615;52637;52667.73666131645;52684.73657631687;1469.390203065737;1495.7382458069576;1537.1238394115471;1538.9461368852037;1557.9221038948008;23787.048518059775;23858.642120368557;23907.282781516584;23954.40113997164;23958.88020559886;38176.61823381731;38189.61810381972;38222.42666360062;38261.617383825804;38316.61683383131;270773;271430;271566;271630.6418467895;271866;30171.849140754155;34237.14407139841;34459.655403446646;34495;35103;37058.444123337635;37205;43596.60218688002;43686.126277474905;44386.778066109466;25024.498530088254;27614.44771104607;27771.44457110806;27862.582061269502;30580.694193058676;30002.24994375158;30115;30810.229744255677;31207.687923120477;31373.686263137988;36539;37408.251834963696;37430.251394972496;37485.06287342838;37629.247415052094;27763.861180693966;30347.544786827773;31230.843845781535;31312.590933407595;31353.372932540766;22728.090876365422;23403;23855;24241.6971587385;24257.15099971563 17:57:19 INFO - PID 1657 | |2;jquery.html;426.80959825305825;431.3055979872403;438.822276977824;440.96031357177856;449.2766645700424;19344.613107737856;20784.376468705945;21226.787732122673;21431.357059288228;21464.819434931072;21267.04298306576;22598.20906268281;23049.04083152934;23359.766402335972;23561.29316120519;6081.48307393871;6277.089821975811;6295.2760432550385;6304.779332723356;6305.243370795511;5798.565107616945;6149.354317796634;6204.844878878019;6221.471174950135;6222.502199824004;5938.435848594377;6174.197354343952;6182.752689892399;6190.78332258371;6193.6283822970545;6101.9389806102035;6198.783042593533;6204.9999999999545;6211.565190436671;6214.228944750769;5392.164214546751;5473.589480788917;5478.726063696839;5484.862878428032;5546.805861794818;27245.72754272452;27337;27456.725432745618;27554.5866811998;27856.721432785616;2200.6368949123535;2250.3923940535965;2255.639097744353;2256.131389415087;2256.142665787007;17336.653266934718;17552.736708949375;17676.91161544184;18103.456896293;18295.268189272414;1955.8435325173953;2089.8014688604558;2098.8845613491253;2107.9789202107936;2155.9245426410002;141124;146465;147998.26000870034;149562;153442.46557534393;10217.948910255549;11849.111316651113;12334.876651233551;12392.876071239352;12396.194247373893;13546.91624670024;13982.6716461938;16076.517704468884;16350.182490875408;16397.91801040987;8266.504009759434;8406.327493800482;8478.915210847812;8537.487750734976;8606.397552171287;7750.496217745828;7843.803904902309;7856.842863142705;7934.166912474223;7937.2459616336355;7601;7733;7744;7758.7672369829;7760.223977602308;1947.74679291694;2051.302557130583;2160.9783902161093;2162.7729088445803;2309.46420630279;865.6623916672377;925.8518637018045;938.779386844091;942.6088173407959;943.7593413679468;19701.50746231327;20440.488987775127;20833.791662083488;20912.163513459596;25805;976.5800705696619;985.9260555458369;990.3513198854762;1004.8045021627767;1008.2488546033252;10299.601131626545;10879;10921.399323037309;10942.890571094347;10949.397783122005;417076;541019;547309;557615;559675;55283.44469630819;127861.36069319594;133735.33132334275;135333.3233333827;138643.30678346544;1132.5186795611833;1181.8818118188112;1226.3561630144245;1226.834377359063;1230.163488827588;16489.505314840575;19503.902480487508;20786.68819967732;21445.892770536047;21648.458788529784;56520;57174.856502868875;57500.1374979384;57552.71223643855;57843.71078144582;62064.06903896355;76576.61711691406;76956.61521692356;76997.61501192459;77369;8307.460015098999;8729.91270087291;8781.29749620016;8930.285577153682;9188;14073.507427239998;14246.501372451914;14249.216293103978;14637.780433293721;14642.487512936996;11860.110491712983;11875.406229688308;12020.278783273032;12230.633081007583;12313.507459701512;10195.7451063724;10292.691219263434;11163.330200188015;11270.83093753578;11603.419829008348;11742.119341049285;11924.284542927453;12262.38688065611;12315.076369272161;12331.69170770738;8538.44500107491;8614.267787238156;8726.127387261224;9066.95466522663;9135.132162444557;11491;11506.123469132717;11906.285622862655;12012.939935300268;12342.382880856101 17:57:19 INFO - PID 1657 | |3;mootools.html;1376.6351916742065;1431.4846655204124;1446.5154173351932;1450.499577645712;1454.3164712585085;11114.277571957828;11678.12414068946;11683.182177247596;11692.123090768195;11698.415079246046;11069.00378965893;11353.886461135386;11757.294562326246;11770;11780;2510.1716433576876;2555.118484122984;2558.565043942525;2558.6289987951736;2560.436703925143;2487.6890388701413;2525.671662683858;2531.265932879472;2532.898684052636;2538.70804857441;1984.732061171745;2082.8542002059785;2083.5207902182506;2086.457521044532;2089.300084471704;2477.9876100619563;2488.415222422729;2513.7611926866916;2524.861132637704;2526.1411120219122;2500.4749002709455;2518.26970178648;2527.0776166699206;2529.949401011988;2532.7720505154625;11217;11432.771344573062;11452.370119643416;11459.197856150073;11471.713207169887;6539.215294164683;6779.796606101825;6789.626570538619;6800.353966373186;6809.0467334573195;3882.8058597070035;4222.387753775716;4261.893452663678;4289.1636130954475;4304.870853874389;1202.6392082375253;1212.8423304970386;1243.7251816887672;1259.785836407813;1272.650021244156;13028.80456793149;15197.848021519754;15200.087994720352;15750.369985200578;16265.430709925215;5289.603279754034;5482.533984611353;5488.53347465462;5495.313085864267;5504;11242.66272011841;11260.605878794202;11261.943690281496;11268.605598804003;11280.379579123228;5361.651492652965;5437.782488700408;5505.587080968943;6369.968150159312;6373.490120790419;5799.246098007232;5983.670898100646;6216.4405203531;6274.027525733519;6287;4194.727342722713;4317.503487098961;4343.370211319341;4386.122775444924;4406.691531592758;1221.993890030562;1227.5274019502556;1245.582729785532;1247.7042242274078;1248.6940699528493;777.7511196417092;807.935365170785;819.3568049081442;820.5445977482555;846.8729690546468;6024.457798798129;6027.36712645166;6215.34738852423;6321.715522801485;6394.392532709385;588.7792077970761;603.806781829819;606.960740630726;610.4261993725884;612.2377639838429;3777.9244415111543;3875.205582855508;3930.76415415076;3932.5674175840636;4221.704480686322;12274.877251227374;14608.853911460961;14714.55856324312;14971.850281497263;14976.400943962119;14700.191489468181;14873.776893346609;14882.330295136528;14893.180875051976;14926.179060151579;8104.635291411901;8440.74677759656;8604.8709269361;8619.78450538729;8631.007434145155;6645.468362531083;6736.663166841737;6752.5948443093575;6939.826504337432;7001.684924178322;13165.341732913508;13326.93336533311;13473.191608503521;13594.252316122709;13608.251546165056;12022;12060;14049.438022479395;14147.292635368396;14207.147571145764;9177.265818734619;9251.953740231256;9292.72121836346;9304.16262536375;9386.812263754824;10617.362958222531;10712.410817404805;10762.784744305227;10764.40795756241;10771.246012779031;7487.6630551626395;8826.735197944072;8926.68756593516;9005.414648047856;9148.862767058632;8735.213830755263;8844.867326990228;8846.601902914255;8856.64573417056;8928.73213803561;7880.408969327209;7986.321162701235;8062.072861620989;8062.55655938929;8085.231902969209;5874.5887787854435;5997.55018373615;6025.939740602713;6041.728122234422;6114.847128821815;5890.617109887844;5935.080062590306;6041.761438904926;6102.206713127265;6265.749370025148 17:57:19 INFO - PID 1657 | |4;prototype.html;398.08440586650704;400.6274165026524;405.07642574929173;405.5619930475086;410.5894105894104;5181.248718935752;5280.445553216915;5950.226470558827;5978.342382337944;6052.152698622185;5617.899900314845;5675.2622159119255;5768.625039372438;5876.735546900389;5894.469497745202;4524.140413321458;4533.433320834895;4535.229011068118;4540.387047748562;4544.659150563704;3838.9442903201702;4474.858910977696;4545.477270113946;4548.363229147905;4568.291914753202;4408.052268762215;4412.8455504057365;4482.193205223059;4498.280275155976;4516.412866327373;3674.3202507535925;4448.4884238312525;4499.298233346161;4502.6172775314135;4505.594496495331;3987.9232607195895;3994.400839874013;4004.519457665099;4014.136960553466;4037.5154981402125;4201.4538110045805;5675.559509410951;5748.5975981681295;5777.653340799566;5814.360420353758;5347.679139251657;5358.3837858645975;5391.3799913009725;5409.837704868821;5432.511074003359;6063.878722425571;6283.5287353448675;6327;6338;6353.936460635381;4454.955450445519;4539;4545.795439205243;4557.30858005017;4576.610988066019;6388.968055159741;6580.86838263232;6588.93411065888;6591.209054913441;6613.173353330833;4028.771224776471;4089.8977525561504;4747.406574178228;4748.525147485293;4755.405574303212;4452.0873220989615;4558.293464513005;4832.782524786393;4838.419389673261;4842.612590992712;4211.1998720243055;5056.696598204119;5217.634765566374;5453.700046497481;5459.481349271813;5748.223989761329;6287.987843889911;6289.433950944345;6293.496520278367;6296.748130074838;1497.5657059452853;1579.9763003554956;1637.5660449980764;1650.2243945345667;1654.2555849867608;1163.586926641047;1164.8194529847888;1167.0138732770795;1171.543098191706;1173.677238759348;5871.823845284563;5879.265616643101;5886.970565147147;5905.954421221477;5918.2898052234;5095.770690318945;5343.973280133574;6481.967590162019;6510.014445594044;6524.706388212542;4969.453360130383;5852.180694702745;5890.49930755882;5894.410558944157;5925.40745925404;2891.438623143479;3326.900192994214;3371.275175837158;3380.256343604403;3401.132711158639;5403.378611459732;5620.325560932714;5954.285485741739;5972.522198224132;6718.294579069225;5463.399026107125;5763.106718458645;6090.1327656938165;6101.877962440726;6558.475321974231;5637.295338082739;6183.938160618336;6424.550281480251;6575.27671956094;6664.7000884959325;6439.517036222396;6450.193725784277;6455.515836312202;6458.935410645833;6469.935300646934;5916.467517923407;5954.642721436728;6345.7144428499905;6358.237011558643;6363.4002078170915;5841.744025034638;5868.970655146697;6677.497563048275;6727.764528241488;6802.319768023356;4000.439938408567;4706.599939005223;4729.763511824326;4751.786169622306;4760.4763476016915;6296.212973378328;6384.329645387354;6506.707198176188;6528.836779080561;6552.27924928248;5278.5513231374225;6289.559730818799;6327.3356297589935;6332.720220720629;6360.9644913629045;5223.806001479464;5718.685472299064;6009.008513595208;6322.209723784527;6375.74497020114;5133.435322114639;5174.948250517597;6198.845028874314;6201.782937597162;6222.191115155001;5411.945880541301;6231.283402408781;6293.276273228637;6311.463525600376;6357.682115894279;6057.001189607331;6128.50971922254;6146.631202127886;6149.325043606045;6162.753489860355 17:57:19 INFO - PID 1657 | |5;yui.html;732.4396836420137;833.9666413343466;850.4557083466583;857.9914200857993;867.1198733285717;16487.093209873467;16790.32838686454;16864.494065178034;16896.746548801748;16936.407225747087;15382.153981531012;15701.685966280667;15833.841661583381;15849.92075039626;15861.52415427539;985.6106837799065;991.5984026469256;991.7322322972793;991.7768502087044;992.3351354592404;993.8360170571847;1016.6543375252413;1026.0047753678919;1028.0644613401805;1032.6230925712098;1074.2158224496122;1075.876274228462;1076.5101878645237;1077.288989267084;1084.799312127255;1068.1828401273033;1068.6580294305825;1068.9251752377336;1068.941747669809;1075.688050465364;786.9055713314382;790.9288164065262;792.9881051784228;795.9692198602824;808.5957021489255;16915.3233870645;17159.914200429044;17318;17324.22041008145;17614.735778963324;17158.914205428893;17336.479905602853;17602.735958960628;17635.38276160341;17710.91144544269;13114.082014259006;13313.86686133136;13996;14033.71932561343;14265.286735663176;3491.5635545556806;3516.5252690886914;3518.4546395308766;3518.9472157917653;3519.7008254298416;94441.5277923606;123780;126127.73872261343;127743.36128319392;128576;11103.05624021951;11353.659390218307;13340.933295333462;13781.51764688231;13877.514286999907;19985.60028799416;25101;25574.616380754305;25928.351791205372;26034;7696.11494678108;7740.729074482479;7771;7780.066392032993;7792.220777922163;3860.6332398422105;3908.9609103909165;3911.6088391161225;3954.2289253595272;3956.2878681837547;3516.9824150879595;4066.79666016698;4142.896427589334;4149.6265336119895;4152.169566086734;885.6103314541581;921.1111277617132;922.9769255768525;929.6885543343055;929.9256059515222;652.2759736692268;672.0993868216614;681.4888833374969;683.480554778372;693.414065114977;11074.224804263624;11801.88198118025;11898.691143974156;11994.160408771302;12199.451024703909;651.6937039591385;658.8781075501048;659.650385295794;673.8483841135705;690.0925283252507;5350.411454739976;5386.192071189274;5470.206820011076;5509.173623956439;5617.971910140505;101625;103312;105272.94727052785;105888.41167382496;107242;89829.55085224663;90513.54743226242;90889;91353;91760;57408.71295643495;80981.78527322094;81408.59295703602;81536.58487811711;83336.58331708303;9564.46718629158;10305.814831294498;10827.40449275266;11045.779084418427;11363.715907102389;34680.30639387148;37727;38352;38352.6164738349;38529;59081.40918590759;66769;68298;69458.65270673615;72657;15912.283947222171;16320.755188671941;16508.917455412648;16549;16603.916980415503;17850.55373615618;18129.747229485743;18331.35840245585;18595.628087438447;18632.627347453246;16251.024938503728;16399.754003689715;16646.833531665012;16816.747748784022;16897.577560561083;16278.67442651164;16467.505974820775;16530.66938661244;16567.50297491077;16672.16639168061;15804.36782528686;16048.598785030468;16456.75314870254;16612.335506579602;16638.584035399213;11171.66485005451;11613.3612651305;11661.300321980709;11708.238964467282;11974;10423.530941107516;10693.679189624323;11086.946740059682;12549.99600031977;12672.936635316764 17:57:19 INFO - PID 1657 | __end_tp_report 17:57:19 INFO - PID 1657 | __start_cc_report 17:57:19 INFO - PID 1657 | _x_x_mozilla_cycle_collect,1929 17:57:19 INFO - PID 1657 | __end_cc_report 17:57:19 INFO - PID 1657 | __startTimestamp1494550639501__endTimestamp 17:57:19 INFO - PID 1657 | 17:57:19 INFO - PID 1657 | ------- Summary: start ------- 17:57:19 INFO - PID 1657 | Number of tests: 6 17:57:19 INFO - PID 1657 | 17:57:19 INFO - PID 1657 | [#0] dojo.html Cycles:165 Average:6073.14 Median:6321.05 stddev:725.13 (11.5%) stddev-sans-first:698.94 17:57:19 INFO - PID 1657 | Values: 3511.2 3512.7 3514.6 3540.8 3595.6 6016.7 6114.4 6247.8 6252.4 6285.7 6100.3 6147.3 6173.0 6195.9 6211.8 4482.5 5222.7 5275.1 5347.8 5384.4 5435.5 5469.1 5474.0 5488.7 5545.0 5284.9 5369.1 5388.6 5414.8 5418.3 5356.8 5413.2 5424.8 5448.6 5460.2 5366.3 5383.0 5388.6 5401.9 5415.0 5352.5 5981.7 6216.6 6231.7 6237.2 5365.3 6387.0 6432.4 6437.1 6573.4 6677.6 6706.5 6721.5 6728.2 6735.2 6216.9 6255.7 6271.4 6300.6 6312.8 6573.6 6680.9 6758.2 6840.3 6848.2 6497.3 6511.3 6515.3 6516.8 6519.5 6629.2 6671.2 6679.4 6685.1 6686.0 6389.2 6512.8 6584.5 6594.7 6601.7 6479.0 6527.5 6641.8 6644.7 6646.6 5285.4 5291.1 5297.0 5308.8 5313.9 4668.2 4685.6 4723.3 4751.3 4769.7 6123.0 6147.7 6150.5 6159.0 6231.2 5869.9 6484.7 6686.2 6709.3 6716.1 6249.7 6257.3 6263.3 6272.9 6288.4 4716.7 5733.7 5770.9 5804.1 5818.4 6742.3 6772.5 6797.8 6894.3 6922.2 6478.4 6570.7 6681.5 6688.2 6700.1 6709.0 6766.5 6774.4 6777.1 6899.7 6562.2 6595.3 6614.8 6620.5 6627.2 6442.8 6696.0 6702.3 6705.7 6713.2 6367.9 6386.1 6395.8 6450.1 6467.2 5448.8 5627.7 5829.8 6488.8 6503.2 6321.1 6321.5 6355.8 6375.6 6393.4 6293.5 6346.5 6352.2 6405.1 6406.1 6299.9 6323.9 6345.8 6349.7 6356.1 17:57:19 INFO - PID 1657 | 17:57:19 INFO - PID 1657 | [#1] ext.html Cycles:180 Average:43865.00 Median:3157.16 stddev:76442.44 (2421.2%) stddev-sans-first:76588.33 17:57:19 INFO - PID 1657 | Values: 748.2 796.9 804.0 1129.8 1130.4 26303.2 26834.3 33879.7 37220.6 37270.4 38287.0 38725.6 38790.0 38866.8 38888.8 8329.5 8458.8 8477.9 8487.8 8500.8 5961.7 6033.7 8253.1 8381.9 8394.5 8388.2 8452.3 8468.1 8473.8 8533.9 8344.2 8411.2 8425.9 8427.5 8432.9 5051.3 5510.9 5736.1 8179.2 8305.0 37143.4 37404.3 37410.7 37481.6 37558.6 3568.2 3598.8 3607.0 3607.6 3614.2 30875.2 30903.5 30910.4 30923.7 30924.8 3074.4 3155.1 3159.3 3159.3 3170.1 301593.0 302249.5 302275.0 302737.0 302855.0 49483.3 49602.3 49711.5 49748.8 49771.5 52224.2 52231.7 52243.0 52367.7 52427.0 12911.6 12926.3 12987.4 12996.1 13019.4 9322.6 10425.4 10461.2 10574.7 10576.1 11094.1 11190.4 12456.7 12626.6 12629.4 5212.3 5236.1 5244.8 5254.3 5255.4 1017.3 1018.7 1025.6 1051.0 1055.3 19173.1 22541.4 22719.5 24293.9 24315.9 1005.0 1091.1 1113.8 1129.9 1160.8 10889.2 11041.2 12548.3 12552.6 12652.7 271761.0 304601.0 304928.4 306085.0 307366.0 52445.2 52615.0 52637.0 52667.7 52684.7 1469.4 1495.7 1537.1 1538.9 1557.9 23787.0 23858.6 23907.3 23954.4 23958.9 38176.6 38189.6 38222.4 38261.6 38316.6 270773.0 271430.0 271566.0 271630.6 271866.0 30171.8 34237.1 34459.7 34495.0 35103.0 37058.4 37205.0 43596.6 43686.1 44386.8 25024.5 27614.4 27771.4 27862.6 30580.7 30002.2 30115.0 30810.2 31207.7 31373.7 36539.0 37408.3 37430.3 37485.1 37629.2 27763.9 30347.5 31230.8 31312.6 31353.4 22728.1 23403.0 23855.0 24241.7 24257.2 17:57:19 INFO - PID 1657 | 17:57:19 INFO - PID 1657 | [#2] jquery.html Cycles:180 Average:34255.13 Median:22823.62 stddev:89400.07 (391.7%) stddev-sans-first:89614.78 17:57:19 INFO - PID 1657 | Values: 426.8 431.3 438.8 441.0 449.3 19344.6 20784.4 21226.8 21431.4 21464.8 21267.0 22598.2 23049.0 23359.8 23561.3 6081.5 6277.1 6295.3 6304.8 6305.2 5798.6 6149.4 6204.8 6221.5 6222.5 5938.4 6174.2 6182.8 6190.8 6193.6 6101.9 6198.8 6205.0 6211.6 6214.2 5392.2 5473.6 5478.7 5484.9 5546.8 27245.7 27337.0 27456.7 27554.6 27856.7 2200.6 2250.4 2255.6 2256.1 2256.1 17336.7 17552.7 17676.9 18103.5 18295.3 1955.8 2089.8 2098.9 2108.0 2155.9 141124.0 146465.0 147998.3 149562.0 153442.5 10217.9 11849.1 12334.9 12392.9 12396.2 13546.9 13982.7 16076.5 16350.2 16397.9 8266.5 8406.3 8478.9 8537.5 8606.4 7750.5 7843.8 7856.8 7934.2 7937.2 7601.0 7733.0 7744.0 7758.8 7760.2 1947.7 2051.3 2161.0 2162.8 2309.5 865.7 925.9 938.8 942.6 943.8 19701.5 20440.5 20833.8 20912.2 25805.0 976.6 985.9 990.4 1004.8 1008.2 10299.6 10879.0 10921.4 10942.9 10949.4 417076.0 541019.0 547309.0 557615.0 559675.0 55283.4 127861.4 133735.3 135333.3 138643.3 1132.5 1181.9 1226.4 1226.8 1230.2 16489.5 19503.9 20786.7 21445.9 21648.5 56520.0 57174.9 57500.1 57552.7 57843.7 62064.1 76576.6 76956.6 76997.6 77369.0 8307.5 8729.9 8781.3 8930.3 9188.0 14073.5 14246.5 14249.2 14637.8 14642.5 11860.1 11875.4 12020.3 12230.6 12313.5 10195.7 10292.7 11163.3 11270.8 11603.4 11742.1 11924.3 12262.4 12315.1 12331.7 8538.4 8614.3 8726.1 9067.0 9135.1 11491.0 11506.1 11906.3 12012.9 12342.4 17:57:19 INFO - PID 1657 | 17:57:19 INFO - PID 1657 | [#3] mootools.html Cycles:180 Average:6942.98 Median:3826.57 stddev:4377.70 (114.4%) stddev-sans-first:4369.99 17:57:19 INFO - PID 1657 | Values: 1376.6 1431.5 1446.5 1450.5 1454.3 11114.3 11678.1 11683.2 11692.1 11698.4 11069.0 11353.9 11757.3 11770.0 11780.0 2510.2 2555.1 2558.6 2558.6 2560.4 2487.7 2525.7 2531.3 2532.9 2538.7 1984.7 2082.9 2083.5 2086.5 2089.3 2478.0 2488.4 2513.8 2524.9 2526.1 2500.5 2518.3 2527.1 2529.9 2532.8 11217.0 11432.8 11452.4 11459.2 11471.7 6539.2 6779.8 6789.6 6800.4 6809.0 3882.8 4222.4 4261.9 4289.2 4304.9 1202.6 1212.8 1243.7 1259.8 1272.7 13028.8 15197.8 15200.1 15750.4 16265.4 5289.6 5482.5 5488.5 5495.3 5504.0 11242.7 11260.6 11261.9 11268.6 11280.4 5361.7 5437.8 5505.6 6370.0 6373.5 5799.2 5983.7 6216.4 6274.0 6287.0 4194.7 4317.5 4343.4 4386.1 4406.7 1222.0 1227.5 1245.6 1247.7 1248.7 777.8 807.9 819.4 820.5 846.9 6024.5 6027.4 6215.3 6321.7 6394.4 588.8 603.8 607.0 610.4 612.2 3777.9 3875.2 3930.8 3932.6 4221.7 12274.9 14608.9 14714.6 14971.9 14976.4 14700.2 14873.8 14882.3 14893.2 14926.2 8104.6 8440.7 8604.9 8619.8 8631.0 6645.5 6736.7 6752.6 6939.8 7001.7 13165.3 13326.9 13473.2 13594.3 13608.3 12022.0 12060.0 14049.4 14147.3 14207.1 9177.3 9252.0 9292.7 9304.2 9386.8 10617.4 10712.4 10762.8 10764.4 10771.2 7487.7 8826.7 8926.7 9005.4 9148.9 8735.2 8844.9 8846.6 8856.6 8928.7 7880.4 7986.3 8062.1 8062.6 8085.2 5874.6 5997.6 6025.9 6041.7 6114.8 5890.6 5935.1 6041.8 6102.2 6265.7 17:57:19 INFO - PID 1657 | 17:57:19 INFO - PID 1657 | [#4] prototype.html Cycles:180 Average:5117.70 Median:5656.28 stddev:1510.17 (26.7%) stddev-sans-first:1472.27 17:57:19 INFO - PID 1657 | Values: 398.1 400.6 405.1 405.6 410.6 5181.2 5280.4 5950.2 5978.3 6052.2 5617.9 5675.3 5768.6 5876.7 5894.5 4524.1 4533.4 4535.2 4540.4 4544.7 3838.9 4474.9 4545.5 4548.4 4568.3 4408.1 4412.8 4482.2 4498.3 4516.4 3674.3 4448.5 4499.3 4502.6 4505.6 3987.9 3994.4 4004.5 4014.1 4037.5 4201.5 5675.6 5748.6 5777.7 5814.4 5347.7 5358.4 5391.4 5409.8 5432.5 6063.9 6283.5 6327.0 6338.0 6353.9 4455.0 4539.0 4545.8 4557.3 4576.6 6389.0 6580.9 6588.9 6591.2 6613.2 4028.8 4089.9 4747.4 4748.5 4755.4 4452.1 4558.3 4832.8 4838.4 4842.6 4211.2 5056.7 5217.6 5453.7 5459.5 5748.2 6288.0 6289.4 6293.5 6296.7 1497.6 1580.0 1637.6 1650.2 1654.3 1163.6 1164.8 1167.0 1171.5 1173.7 5871.8 5879.3 5887.0 5906.0 5918.3 5095.8 5344.0 6482.0 6510.0 6524.7 4969.5 5852.2 5890.5 5894.4 5925.4 2891.4 3326.9 3371.3 3380.3 3401.1 5403.4 5620.3 5954.3 5972.5 6718.3 5463.4 5763.1 6090.1 6101.9 6558.5 5637.3 6183.9 6424.6 6575.3 6664.7 6439.5 6450.2 6455.5 6458.9 6469.9 5916.5 5954.6 6345.7 6358.2 6363.4 5841.7 5869.0 6677.5 6727.8 6802.3 4000.4 4706.6 4729.8 4751.8 4760.5 6296.2 6384.3 6506.7 6528.8 6552.3 5278.6 6289.6 6327.3 6332.7 6361.0 5223.8 5718.7 6009.0 6322.2 6375.7 5133.4 5174.9 6198.8 6201.8 6222.2 5411.9 6231.3 6293.3 6311.5 6357.7 6057.0 6128.5 6146.6 6149.3 6162.8 17:57:19 INFO - PID 1657 | 17:57:19 INFO - PID 1657 | [#5] yui.html Cycles:180 Average:21609.90 Median:17673.15 stddev:30427.77 (172.2%) stddev-sans-first:30472.74 17:57:19 INFO - PID 1657 | Values: 732.4 834.0 850.5 858.0 867.1 16487.1 16790.3 16864.5 16896.7 16936.4 15382.2 15701.7 15833.8 15849.9 15861.5 985.6 991.6 991.7 991.8 992.3 993.8 1016.7 1026.0 1028.1 1032.6 1074.2 1075.9 1076.5 1077.3 1084.8 1068.2 1068.7 1068.9 1068.9 1075.7 786.9 790.9 793.0 796.0 808.6 16915.3 17159.9 17318.0 17324.2 17614.7 17158.9 17336.5 17602.7 17635.4 17710.9 13114.1 13313.9 13996.0 14033.7 14265.3 3491.6 3516.5 3518.5 3518.9 3519.7 94441.5 123780.0 126127.7 127743.4 128576.0 11103.1 11353.7 13340.9 13781.5 13877.5 19985.6 25101.0 25574.6 25928.4 26034.0 7696.1 7740.7 7771.0 7780.1 7792.2 3860.6 3909.0 3911.6 3954.2 3956.3 3517.0 4066.8 4142.9 4149.6 4152.2 885.6 921.1 923.0 929.7 929.9 652.3 672.1 681.5 683.5 693.4 11074.2 11801.9 11898.7 11994.2 12199.5 651.7 658.9 659.7 673.8 690.1 5350.4 5386.2 5470.2 5509.2 5618.0 101625.0 103312.0 105272.9 105888.4 107242.0 89829.6 90513.5 90889.0 91353.0 91760.0 57408.7 80981.8 81408.6 81536.6 83336.6 9564.5 10305.8 10827.4 11045.8 11363.7 34680.3 37727.0 38352.0 38352.6 38529.0 59081.4 66769.0 68298.0 69458.7 72657.0 15912.3 16320.8 16508.9 16549.0 16603.9 17850.6 18129.7 18331.4 18595.6 18632.6 16251.0 16399.8 16646.8 16816.7 16897.6 16278.7 16467.5 16530.7 16567.5 16672.2 15804.4 16048.6 16456.8 16612.3 16638.6 11171.7 11613.4 11661.3 11708.2 11974.0 10423.5 10693.7 11086.9 12550.0 12672.9 17:57:19 INFO - PID 1657 | -------- Summary: end -------- 17:57:19 INFO - PID 1657 | 17:57:20 INFO - TEST-INFO | 1657: exit 0 17:57:20 INFO - TEST-OK | dromaeo_css | took 1117596ms 17:57:20 INFO - TEST-START | kraken 17:57:20 INFO - operating with platform_type : mac_ 17:57:20 INFO - Initialising browser for kraken test... 17:57:20 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpme93eI/profile http://localhost:49254/getInfo.html) 17:57:22 INFO - PID 1664 | __metrics Screen width/height:1600/1200 17:57:22 INFO - PID 1664 | colorDepth:24 17:57:22 INFO - PID 1664 | Browser inner width/height: 1024/691 17:57:22 INFO - PID 1664 | __metrics 17:57:22 INFO - PID 1664 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:57:22 INFO - PID 1664 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:57:23 INFO - TEST-INFO | 1664: exit 0 17:57:23 INFO - Browser initialized. 17:57:23 INFO - Running cycle 1/1 for kraken test... 17:57:23 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpme93eI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:57:35 INFO - PID 1665 | RSS: Main: 233775104 17:57:35 INFO - PID 1665 | 17:57:38 INFO - PID 1665 | Cycle 1(1): loaded http://localhost:49254/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49254/tests/kraken/driver.html?testName=audio-beat-detection) 17:57:39 INFO - PID 1665 | RSS: Main: 304369664 17:57:39 INFO - PID 1665 | 17:57:41 INFO - PID 1665 | Cycle 1(1): loaded http://localhost:49254/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49254/tests/kraken/driver.html?testName=audio-dft) 17:57:42 INFO - PID 1665 | RSS: Main: 287514624 17:57:42 INFO - PID 1665 | 17:57:45 INFO - PID 1665 | Cycle 1(1): loaded http://localhost:49254/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49254/tests/kraken/driver.html?testName=audio-fft) 17:57:46 INFO - PID 1665 | RSS: Main: 377131008 17:57:46 INFO - PID 1665 | 17:57:48 INFO - PID 1665 | Cycle 1(1): loaded http://localhost:49254/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49254/tests/kraken/driver.html?testName=audio-oscillator) 17:57:48 INFO - PID 1665 | RSS: Main: 281903104 17:57:48 INFO - PID 1665 | 17:57:50 INFO - PID 1665 | Cycle 1(1): loaded http://localhost:49254/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49254/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:57:51 INFO - PID 1665 | RSS: Main: 284311552 17:57:51 INFO - PID 1665 | 17:57:54 INFO - PID 1665 | Cycle 1(1): loaded http://localhost:49254/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49254/tests/kraken/driver.html?testName=imaging-darkroom) 17:57:54 INFO - PID 1665 | RSS: Main: 348925952 17:57:54 INFO - PID 1665 | 17:57:57 INFO - PID 1665 | Cycle 1(1): loaded http://localhost:49254/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49254/tests/kraken/driver.html?testName=imaging-desaturate) 17:57:58 INFO - PID 1665 | RSS: Main: 368885760 17:57:58 INFO - PID 1665 | 17:58:00 INFO - PID 1665 | Cycle 1(1): loaded http://localhost:49254/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49254/tests/kraken/driver.html?testName=json-parse-financial) 17:58:01 INFO - PID 1665 | RSS: Main: 381939712 17:58:01 INFO - PID 1665 | 17:58:03 INFO - PID 1665 | Cycle 1(1): loaded http://localhost:49254/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49254/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:58:03 INFO - PID 1665 | RSS: Main: 326422528 17:58:03 INFO - PID 1665 | 17:58:05 INFO - PID 1665 | Cycle 1(1): loaded http://localhost:49254/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49254/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:58:06 INFO - PID 1665 | RSS: Main: 327159808 17:58:06 INFO - PID 1665 | 17:58:08 INFO - PID 1665 | Cycle 1(1): loaded http://localhost:49254/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49254/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:58:08 INFO - PID 1665 | RSS: Main: 329035776 17:58:08 INFO - PID 1665 | 17:58:11 INFO - PID 1665 | Cycle 1(1): loaded http://localhost:49254/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49254/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:58:12 INFO - PID 1665 | RSS: Main: 341102592 17:58:12 INFO - PID 1665 | 17:58:15 INFO - PID 1665 | Cycle 1(1): loaded http://localhost:49254/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49254/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:58:16 INFO - PID 1665 | RSS: Main: 339316736 17:58:16 INFO - PID 1665 | 17:58:17 INFO - PID 1665 | Cycle 1(1): loaded http://localhost:49254/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49254/tests/kraken/driver.html?testName=ai-astar) 17:58:18 INFO - PID 1665 | RSS: Main: 381874176 17:58:18 INFO - PID 1665 | 17:58:18 INFO - PID 1665 | __start_tp_report 17:58:18 INFO - PID 1665 | _x_x_mozilla_page_load 17:58:18 INFO - PID 1665 | _x_x_mozilla_page_load_details 17:58:18 INFO - PID 1665 | |i|pagename|runs| 17:58:18 INFO - PID 1665 | |0;ai-astar;111;111;109;110;116;161;115;109;109;109 17:58:18 INFO - PID 1665 | |1;audio-beat-detection;142;106;102;146;108;108;107;107;134;104 17:58:18 INFO - PID 1665 | |2;audio-dft;183;186;183;183;180;183;183;183;183;179 17:58:18 INFO - PID 1665 | |3;audio-fft;80;57;58;91;59;58;57;56;82;57 17:58:18 INFO - PID 1665 | |4;audio-oscillator;94;68;84;68;69;68;89;69;68;89 17:58:18 INFO - PID 1665 | |5;imaging-gaussian-blur;88;86;88;87;87;86;88;86;86;86 17:58:18 INFO - PID 1665 | |6;imaging-darkroom;94;94;94;95;94;95;94;93;94;94 17:58:18 INFO - PID 1665 | |7;imaging-desaturate;85;86;86;85;88;83;84;82;86;83 17:58:18 INFO - PID 1665 | |8;json-parse-financial;49;48;46;47;49;48;49;47;47;49 17:58:18 INFO - PID 1665 | |9;json-stringify-tinderbox;54;53;59;62;67;63;58;57;57;58 17:58:18 INFO - PID 1665 | |10;stanford-crypto-aes;82;81;82;81;83;83;81;87;102;102 17:58:18 INFO - PID 1665 | |11;stanford-crypto-ccm;140;136;135;136;142;136;138;150;216;136 17:58:18 INFO - PID 1665 | |12;stanford-crypto-pbkdf2;183;184;187;184;185;182;182;181;184;184 17:58:18 INFO - PID 1665 | |13;stanford-crypto-sha256-iterative;69;68;66;67;66;67;67;68;70;79 17:58:18 INFO - PID 1665 | __end_tp_report 17:58:18 INFO - PID 1665 | __start_cc_report 17:58:18 INFO - PID 1665 | _x_x_mozilla_cycle_collect,2158 17:58:18 INFO - PID 1665 | __end_cc_report 17:58:18 INFO - PID 1665 | __startTimestamp1494550698033__endTimestamp 17:58:18 INFO - PID 1665 | 17:58:18 INFO - PID 1665 | ------- Summary: start ------- 17:58:18 INFO - PID 1665 | Number of tests: 14 17:58:18 INFO - PID 1665 | 17:58:18 INFO - PID 1665 | [#0] ai-astar Cycles:10 Average:116.00 Median:111.00 stddev:16.01 (14.4%) stddev-sans-first:16.88 17:58:18 INFO - PID 1665 | Values: 111.0 111.0 109.0 110.0 116.0 161.0 115.0 109.0 109.0 109.0 17:58:18 INFO - PID 1665 | 17:58:18 INFO - PID 1665 | [#1] audio-beat-detection Cycles:10 Average:116.40 Median:108.00 stddev:17.09 (15.8%) stddev-sans-first:15.41 17:58:18 INFO - PID 1665 | Values: 142.0 106.0 102.0 146.0 108.0 108.0 107.0 107.0 134.0 104.0 17:58:18 INFO - PID 1665 | 17:58:18 INFO - PID 1665 | [#2] audio-dft Cycles:10 Average:182.60 Median:183.00 stddev:1.90 (1.0%) stddev-sans-first:2.01 17:58:18 INFO - PID 1665 | Values: 183.0 186.0 183.0 183.0 180.0 183.0 183.0 183.0 183.0 179.0 17:58:18 INFO - PID 1665 | 17:58:18 INFO - PID 1665 | [#3] audio-fft Cycles:10 Average:65.50 Median:58.50 stddev:13.31 (22.8%) stddev-sans-first:13.04 17:58:18 INFO - PID 1665 | Values: 80.0 57.0 58.0 91.0 59.0 58.0 57.0 56.0 82.0 57.0 17:58:18 INFO - PID 1665 | 17:58:18 INFO - PID 1665 | [#4] audio-oscillator Cycles:10 Average:76.60 Median:76.50 stddev:10.94 (14.3%) stddev-sans-first:9.62 17:58:18 INFO - PID 1665 | Values: 94.0 68.0 84.0 68.0 69.0 68.0 89.0 69.0 68.0 89.0 17:58:18 INFO - PID 1665 | 17:58:18 INFO - PID 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:86.80 Median:87.00 stddev:0.92 (1.1%) stddev-sans-first:0.87 17:58:18 INFO - PID 1665 | Values: 88.0 86.0 88.0 87.0 87.0 86.0 88.0 86.0 86.0 86.0 17:58:18 INFO - PID 1665 | 17:58:18 INFO - PID 1665 | [#6] imaging-darkroom Cycles:10 Average:94.10 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 17:58:18 INFO - PID 1665 | Values: 94.0 94.0 94.0 95.0 94.0 95.0 94.0 93.0 94.0 94.0 17:58:18 INFO - PID 1665 | 17:58:18 INFO - PID 1665 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.50 stddev:1.81 (2.1%) stddev-sans-first:1.92 17:58:18 INFO - PID 1665 | Values: 85.0 86.0 86.0 85.0 88.0 83.0 84.0 82.0 86.0 83.0 17:58:18 INFO - PID 1665 | 17:58:18 INFO - PID 1665 | [#8] json-parse-financial Cycles:10 Average:47.90 Median:48.50 stddev:1.10 (2.3%) stddev-sans-first:1.09 17:58:18 INFO - PID 1665 | Values: 49.0 48.0 46.0 47.0 49.0 48.0 49.0 47.0 47.0 49.0 17:58:18 INFO - PID 1665 | 17:58:18 INFO - PID 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:58.50 stddev:4.21 (7.2%) stddev-sans-first:4.09 17:58:18 INFO - PID 1665 | Values: 54.0 53.0 59.0 62.0 67.0 63.0 58.0 57.0 57.0 58.0 17:58:18 INFO - PID 1665 | 17:58:18 INFO - PID 1665 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:82.00 stddev:8.41 (10.3%) stddev-sans-first:8.77 17:58:18 INFO - PID 1665 | Values: 82.0 81.0 82.0 81.0 83.0 83.0 81.0 87.0 102.0 102.0 17:58:18 INFO - PID 1665 | 17:58:18 INFO - PID 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:146.50 Median:139.00 stddev:24.83 (17.9%) stddev-sans-first:26.23 17:58:18 INFO - PID 1665 | Values: 140.0 136.0 135.0 136.0 142.0 136.0 138.0 150.0 216.0 136.0 17:58:18 INFO - PID 1665 | 17:58:18 INFO - PID 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.60 Median:184.00 stddev:1.71 (0.9%) stddev-sans-first:1.80 17:58:18 INFO - PID 1665 | Values: 183.0 184.0 187.0 184.0 185.0 182.0 182.0 181.0 184.0 184.0 17:58:18 INFO - PID 1665 | 17:58:18 INFO - PID 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:68.00 stddev:3.83 (5.6%) stddev-sans-first:4.06 17:58:18 INFO - PID 1665 | Values: 69.0 68.0 66.0 67.0 66.0 67.0 67.0 68.0 70.0 79.0 17:58:18 INFO - PID 1665 | -------- Summary: end -------- 17:58:18 INFO - PID 1665 | 17:58:19 INFO - TEST-INFO | 1665: exit 0 17:58:19 INFO - TEST-OK | kraken | took 58793ms 17:58:19 INFO - SUITE-END | took 1176s 17:58:19 INFO - Completed test suite (00:19:36) 17:58:19 INFO - javascript benchmark 17:58:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7727.432106063736, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3511.192425742079, 3512.718982481402, 3514.5606799150105, 3540.752147349686, 3595.6224596417374, 6016.669083200422, 6114.419025732089, 6247.843803904899, 6252.437280644746, 6285.654289014103, 6100.27841329238, 6147.323794382625, 6172.969135154318, 6195.938040619592, 6211.844703882394, 4482.462104547459, 5222.712750798704, 5275.129603615399, 5347.786088556453, 5384.40771515135, 5435.483629055253, 5469.124940009599, 5474.0, 5488.69812160331, 5545.029619816516, 5284.894302113936, 5369.087255166631, 5388.568914486871, 5414.7834086636485, 5418.295621569171, 5356.839294821161, 5413.2150838128255, 5424.83725488236, 5448.591355648342, 5460.153676180198, 5366.302380690485, 5383.0, 5388.622796404214, 5401.918971215396, 5414.972925135349, 5352.464753524655, 5981.730822113015, 6216.564840461169, 6231.719572619243, 6237.189165408513, 5365.302510673627, 6386.9680651596445, 6432.356764323577, 6437.0988061671405, 6573.375529324707, 6677.632730199837, 6706.497012724017, 6721.529492935497, 6728.158980127484, 6735.191776986744, 6216.906746398718, 6255.749770009194, 6271.404216599416, 6300.558960872695, 6312.779052733133, 6573.605583664996, 6680.86638267232, 6758.189017317855, 6840.281770414035, 6848.178218613798, 6497.252815926135, 6511.34886511345, 6515.283318834924, 6516.771912983023, 6519.511036672268, 6629.204495460575, 6671.232808227019, 6679.432248258952, 6685.130932978682, 6686.0, 6389.233292004989, 6512.837179070466, 6584.473242140713, 6594.7032383542855, 6601.735930562723, 6479.0, 6527.54307198501, 6641.767538136142, 6644.700988455531, 6646.567973081735, 5285.418603953562, 5291.074062039128, 5296.973515132399, 5308.761105750251, 5313.946860531422, 4668.194031401687, 4685.554872287127, 4723.338732577442, 4751.3348131261655, 4769.73766442842, 6122.969385153046, 6147.678249176449, 6150.50795936324, 6158.983767678283, 6231.158793562811, 5869.853253668607, 6484.703059388141, 6686.231083425371, 6709.295523969913, 6716.093327400738, 6249.6875156242, 6257.311695713468, 6263.342349053375, 6272.874542509125, 6288.371162883675, 4716.669833111718, 5733.713314334266, 5770.88458230833, 5804.129380592861, 5818.359980402152, 6742.258351581322, 6772.52592318533, 6797.796066118024, 6894.345037221456, 6922.169339679271, 6478.449331806661, 6570.704318305592, 6681.498887583548, 6688.230853451915, 6700.128983232149, 6709.024391461218, 6766.458683305422, 6774.356436138559, 6777.118974533476, 6899.655017249218, 6562.212534495891, 6595.307492713196, 6614.801555953329, 6620.536562440583, 6627.237867645283, 6442.806715798533, 6695.966520167368, 6702.296258892746, 6705.698243579148, 6713.227978782307, 6367.90448143269, 6386.105945167587, 6395.776147834804, 6450.064740612679, 6467.191601049869, 5448.83653490396, 5627.690477023803, 5829.834033193463, 6488.847759352491, 6503.154589903283, 6321.051842223519, 6321.462675672619, 6355.807540602751, 6375.5537112403545, 6393.424591786761, 6293.496520278458, 6346.4605508532295, 6352.174217351715, 6405.103285539935, 6406.1031455597185, 6299.874002520016, 6323.873522529431, 6345.841353966003, 6349.68251587428, 6356.078368636614], "value": 6025.224398450296, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [748.1994266135234, 796.8764841449575, 803.9638216280267, 1129.7627498225372, 1130.3782919394337, 26303.210903672873, 26834.329141771443, 33879.66120338796, 37220.62779372205, 37270.44094338587, 38287.0, 38725.61274387255, 38790.030249243784, 38866.805665971704, 38888.80555597225, 8329.541875196861, 8458.788530286762, 8477.915220847804, 8487.787805304855, 8500.829983400328, 5961.701914904259, 6033.728482218311, 8253.050899146616, 8381.916180838174, 8394.45436046655, 8388.161183881624, 8452.28155606771, 8468.068512463624, 8473.830523389528, 8533.914660853374, 8344.249017588416, 8411.200935911078, 8425.915740842605, 8427.536485493296, 8432.873506897402, 5051.318072060261, 5510.9448905511235, 5736.110902810029, 8179.222973817477, 8305.0, 37143.44284835702, 37404.251914961824, 37410.69062582796, 37481.62518374809, 37558.62441375606, 3568.1793187567005, 3598.784072955631, 3606.963930360689, 3607.6211997740384, 3614.2410093880317, 30875.22811929697, 30903.536446953312, 30910.381792364253, 30923.690763092305, 30924.845375773202, 3074.4158609864053, 3155.0534839548045, 3159.2575744699975, 3159.3207460396125, 3170.080676603782, 301592.96814063593, 302249.488752557, 302275.0, 302737.0, 302855.0, 49483.25775113376, 49602.255966160534, 49711.50288497141, 49748.751256243486, 49771.50228497741, 52224.21663674972, 52231.73884130631, 52243.0, 52367.73816130971, 52427.0, 12911.612651620466, 12926.289054101926, 12987.350632468528, 12996.090273680751, 13019.414126364147, 9322.580483878242, 10425.426601536836, 10461.215408844368, 10574.735631609117, 10576.101031412261, 11094.057005154653, 11190.440477976232, 12456.688582785502, 12626.621201363974, 12629.43167557462, 5212.296339994053, 5236.1098613235845, 5244.790208391698, 5254.316938798008, 5255.448177941261, 1017.2726500552141, 1018.6536577563664, 1025.5743866295552, 1050.9842352364722, 1055.2718624149313, 19173.137208825636, 22541.4364640882, 22719.545609088058, 24293.878530607235, 24315.878420607783, 1004.9899501004896, 1091.1270983213396, 1113.7661091170944, 1129.8813624569302, 1160.8200728887036, 10889.183311251687, 11041.227114101936, 12548.309842958543, 12552.623421297376, 12652.683682907817, 271761.0, 304601.0, 304928.4260736091, 306085.0, 307366.0, 52445.213321800205, 52615.0, 52637.0, 52667.73666131645, 52684.73657631687, 1469.390203065737, 1495.7382458069576, 1537.1238394115471, 1538.9461368852037, 1557.9221038948008, 23787.048518059775, 23858.642120368557, 23907.282781516584, 23954.40113997164, 23958.88020559886, 38176.61823381731, 38189.61810381972, 38222.42666360062, 38261.617383825804, 38316.61683383131, 270773.0, 271430.0, 271566.0, 271630.6418467895, 271866.0, 30171.849140754155, 34237.14407139841, 34459.655403446646, 34495.0, 35103.0, 37058.444123337635, 37205.0, 43596.60218688002, 43686.126277474905, 44386.778066109466, 25024.498530088254, 27614.44771104607, 27771.44457110806, 27862.582061269502, 30580.694193058676, 30002.24994375158, 30115.0, 30810.229744255677, 31207.687923120477, 31373.686263137988, 36539.0, 37408.251834963696, 37430.251394972496, 37485.06287342838, 37629.247415052094, 27763.861180693966, 30347.544786827773, 31230.843845781535, 31312.590933407595, 31353.372932540766, 22728.090876365422, 23403.0, 23855.0, 24241.6971587385, 24257.15099971563], "value": 16923.36008674397, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.80959825305825, 431.3055979872403, 438.822276977824, 440.96031357177856, 449.2766645700424, 19344.613107737856, 20784.376468705945, 21226.787732122673, 21431.357059288228, 21464.819434931072, 21267.04298306576, 22598.20906268281, 23049.04083152934, 23359.766402335972, 23561.29316120519, 6081.48307393871, 6277.089821975811, 6295.2760432550385, 6304.779332723356, 6305.243370795511, 5798.565107616945, 6149.354317796634, 6204.844878878019, 6221.471174950135, 6222.502199824004, 5938.435848594377, 6174.197354343952, 6182.752689892399, 6190.78332258371, 6193.6283822970545, 6101.9389806102035, 6198.783042593533, 6204.9999999999545, 6211.565190436671, 6214.228944750769, 5392.164214546751, 5473.589480788917, 5478.726063696839, 5484.862878428032, 5546.805861794818, 27245.72754272452, 27337.0, 27456.725432745618, 27554.5866811998, 27856.721432785616, 2200.6368949123535, 2250.3923940535965, 2255.639097744353, 2256.131389415087, 2256.142665787007, 17336.653266934718, 17552.736708949375, 17676.91161544184, 18103.456896293, 18295.268189272414, 1955.8435325173953, 2089.8014688604558, 2098.8845613491253, 2107.9789202107936, 2155.9245426410002, 141124.0, 146465.0, 147998.26000870034, 149562.0, 153442.46557534393, 10217.948910255549, 11849.111316651113, 12334.876651233551, 12392.876071239352, 12396.194247373893, 13546.91624670024, 13982.6716461938, 16076.517704468884, 16350.182490875408, 16397.91801040987, 8266.504009759434, 8406.327493800482, 8478.915210847812, 8537.487750734976, 8606.397552171287, 7750.496217745828, 7843.803904902309, 7856.842863142705, 7934.166912474223, 7937.2459616336355, 7601.0, 7733.0, 7744.0, 7758.7672369829, 7760.223977602308, 1947.74679291694, 2051.302557130583, 2160.9783902161093, 2162.7729088445803, 2309.46420630279, 865.6623916672377, 925.8518637018045, 938.779386844091, 942.6088173407959, 943.7593413679468, 19701.50746231327, 20440.488987775127, 20833.791662083488, 20912.163513459596, 25805.0, 976.5800705696619, 985.9260555458369, 990.3513198854762, 1004.8045021627767, 1008.2488546033252, 10299.601131626545, 10879.0, 10921.399323037309, 10942.890571094347, 10949.397783122005, 417076.0, 541019.0, 547309.0, 557615.0, 559675.0, 55283.44469630819, 127861.36069319594, 133735.33132334275, 135333.3233333827, 138643.30678346544, 1132.5186795611833, 1181.8818118188112, 1226.3561630144245, 1226.834377359063, 1230.163488827588, 16489.505314840575, 19503.902480487508, 20786.68819967732, 21445.892770536047, 21648.458788529784, 56520.0, 57174.856502868875, 57500.1374979384, 57552.71223643855, 57843.71078144582, 62064.06903896355, 76576.61711691406, 76956.61521692356, 76997.61501192459, 77369.0, 8307.460015098999, 8729.91270087291, 8781.29749620016, 8930.285577153682, 9188.0, 14073.507427239998, 14246.501372451914, 14249.216293103978, 14637.780433293721, 14642.487512936996, 11860.110491712983, 11875.406229688308, 12020.278783273032, 12230.633081007583, 12313.507459701512, 10195.7451063724, 10292.691219263434, 11163.330200188015, 11270.83093753578, 11603.419829008348, 11742.119341049285, 11924.284542927453, 12262.38688065611, 12315.076369272161, 12331.69170770738, 8538.44500107491, 8614.267787238156, 8726.127387261224, 9066.95466522663, 9135.132162444557, 11491.0, 11506.123469132717, 11906.285622862655, 12012.939935300268, 12342.382880856101], "value": 10321.538337804514, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1376.6351916742065, 1431.4846655204124, 1446.5154173351932, 1450.499577645712, 1454.3164712585085, 11114.277571957828, 11678.12414068946, 11683.182177247596, 11692.123090768195, 11698.415079246046, 11069.00378965893, 11353.886461135386, 11757.294562326246, 11770.0, 11780.0, 2510.1716433576876, 2555.118484122984, 2558.565043942525, 2558.6289987951736, 2560.436703925143, 2487.6890388701413, 2525.671662683858, 2531.265932879472, 2532.898684052636, 2538.70804857441, 1984.732061171745, 2082.8542002059785, 2083.5207902182506, 2086.457521044532, 2089.300084471704, 2477.9876100619563, 2488.415222422729, 2513.7611926866916, 2524.861132637704, 2526.1411120219122, 2500.4749002709455, 2518.26970178648, 2527.0776166699206, 2529.949401011988, 2532.7720505154625, 11217.0, 11432.771344573062, 11452.370119643416, 11459.197856150073, 11471.713207169887, 6539.215294164683, 6779.796606101825, 6789.626570538619, 6800.353966373186, 6809.0467334573195, 3882.8058597070035, 4222.387753775716, 4261.893452663678, 4289.1636130954475, 4304.870853874389, 1202.6392082375253, 1212.8423304970386, 1243.7251816887672, 1259.785836407813, 1272.650021244156, 13028.80456793149, 15197.848021519754, 15200.087994720352, 15750.369985200578, 16265.430709925215, 5289.603279754034, 5482.533984611353, 5488.53347465462, 5495.313085864267, 5504.0, 11242.66272011841, 11260.605878794202, 11261.943690281496, 11268.605598804003, 11280.379579123228, 5361.651492652965, 5437.782488700408, 5505.587080968943, 6369.968150159312, 6373.490120790419, 5799.246098007232, 5983.670898100646, 6216.4405203531, 6274.027525733519, 6287.0, 4194.727342722713, 4317.503487098961, 4343.370211319341, 4386.122775444924, 4406.691531592758, 1221.993890030562, 1227.5274019502556, 1245.582729785532, 1247.7042242274078, 1248.6940699528493, 777.7511196417092, 807.935365170785, 819.3568049081442, 820.5445977482555, 846.8729690546468, 6024.457798798129, 6027.36712645166, 6215.34738852423, 6321.715522801485, 6394.392532709385, 588.7792077970761, 603.806781829819, 606.960740630726, 610.4261993725884, 612.2377639838429, 3777.9244415111543, 3875.205582855508, 3930.76415415076, 3932.5674175840636, 4221.704480686322, 12274.877251227374, 14608.853911460961, 14714.55856324312, 14971.850281497263, 14976.400943962119, 14700.191489468181, 14873.776893346609, 14882.330295136528, 14893.180875051976, 14926.179060151579, 8104.635291411901, 8440.74677759656, 8604.8709269361, 8619.78450538729, 8631.007434145155, 6645.468362531083, 6736.663166841737, 6752.5948443093575, 6939.826504337432, 7001.684924178322, 13165.341732913508, 13326.93336533311, 13473.191608503521, 13594.252316122709, 13608.251546165056, 12022.0, 12060.0, 14049.438022479395, 14147.292635368396, 14207.147571145764, 9177.265818734619, 9251.953740231256, 9292.72121836346, 9304.16262536375, 9386.812263754824, 10617.362958222531, 10712.410817404805, 10762.784744305227, 10764.40795756241, 10771.246012779031, 7487.6630551626395, 8826.735197944072, 8926.68756593516, 9005.414648047856, 9148.862767058632, 8735.213830755263, 8844.867326990228, 8846.601902914255, 8856.64573417056, 8928.73213803561, 7880.408969327209, 7986.321162701235, 8062.072861620989, 8062.55655938929, 8085.231902969209, 5874.5887787854435, 5997.55018373615, 6025.939740602713, 6041.728122234422, 6114.847128821815, 5890.617109887844, 5935.080062590306, 6041.761438904926, 6102.206713127265, 6265.749370025148], "value": 5216.223971398289, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.08440586650704, 400.6274165026524, 405.07642574929173, 405.5619930475086, 410.5894105894104, 5181.248718935752, 5280.445553216915, 5950.226470558827, 5978.342382337944, 6052.152698622185, 5617.899900314845, 5675.2622159119255, 5768.625039372438, 5876.735546900389, 5894.469497745202, 4524.140413321458, 4533.433320834895, 4535.229011068118, 4540.387047748562, 4544.659150563704, 3838.9442903201702, 4474.858910977696, 4545.477270113946, 4548.363229147905, 4568.291914753202, 4408.052268762215, 4412.8455504057365, 4482.193205223059, 4498.280275155976, 4516.412866327373, 3674.3202507535925, 4448.4884238312525, 4499.298233346161, 4502.6172775314135, 4505.594496495331, 3987.9232607195895, 3994.400839874013, 4004.519457665099, 4014.136960553466, 4037.5154981402125, 4201.4538110045805, 5675.559509410951, 5748.5975981681295, 5777.653340799566, 5814.360420353758, 5347.679139251657, 5358.3837858645975, 5391.3799913009725, 5409.837704868821, 5432.511074003359, 6063.878722425571, 6283.5287353448675, 6327.0, 6338.0, 6353.936460635381, 4454.955450445519, 4539.0, 4545.795439205243, 4557.30858005017, 4576.610988066019, 6388.968055159741, 6580.86838263232, 6588.93411065888, 6591.209054913441, 6613.173353330833, 4028.771224776471, 4089.8977525561504, 4747.406574178228, 4748.525147485293, 4755.405574303212, 4452.0873220989615, 4558.293464513005, 4832.782524786393, 4838.419389673261, 4842.612590992712, 4211.1998720243055, 5056.696598204119, 5217.634765566374, 5453.700046497481, 5459.481349271813, 5748.223989761329, 6287.987843889911, 6289.433950944345, 6293.496520278367, 6296.748130074838, 1497.5657059452853, 1579.9763003554956, 1637.5660449980764, 1650.2243945345667, 1654.2555849867608, 1163.586926641047, 1164.8194529847888, 1167.0138732770795, 1171.543098191706, 1173.677238759348, 5871.823845284563, 5879.265616643101, 5886.970565147147, 5905.954421221477, 5918.2898052234, 5095.770690318945, 5343.973280133574, 6481.967590162019, 6510.014445594044, 6524.706388212542, 4969.453360130383, 5852.180694702745, 5890.49930755882, 5894.410558944157, 5925.40745925404, 2891.438623143479, 3326.900192994214, 3371.275175837158, 3380.256343604403, 3401.132711158639, 5403.378611459732, 5620.325560932714, 5954.285485741739, 5972.522198224132, 6718.294579069225, 5463.399026107125, 5763.106718458645, 6090.1327656938165, 6101.877962440726, 6558.475321974231, 5637.295338082739, 6183.938160618336, 6424.550281480251, 6575.27671956094, 6664.7000884959325, 6439.517036222396, 6450.193725784277, 6455.515836312202, 6458.935410645833, 6469.935300646934, 5916.467517923407, 5954.642721436728, 6345.7144428499905, 6358.237011558643, 6363.4002078170915, 5841.744025034638, 5868.970655146697, 6677.497563048275, 6727.764528241488, 6802.319768023356, 4000.439938408567, 4706.599939005223, 4729.763511824326, 4751.786169622306, 4760.4763476016915, 6296.212973378328, 6384.329645387354, 6506.707198176188, 6528.836779080561, 6552.27924928248, 5278.5513231374225, 6289.559730818799, 6327.3356297589935, 6332.720220720629, 6360.9644913629045, 5223.806001479464, 5718.685472299064, 6009.008513595208, 6322.209723784527, 6375.74497020114, 5133.435322114639, 5174.948250517597, 6198.845028874314, 6201.782937597162, 6222.191115155001, 5411.945880541301, 6231.283402408781, 6293.276273228637, 6311.463525600376, 6357.682115894279, 6057.001189607331, 6128.50971922254, 6146.631202127886, 6149.325043606045, 6162.753489860355], "value": 4667.268366286398, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.4396836420137, 833.9666413343466, 850.4557083466583, 857.9914200857993, 867.1198733285717, 16487.093209873467, 16790.32838686454, 16864.494065178034, 16896.746548801748, 16936.407225747087, 15382.153981531012, 15701.685966280667, 15833.841661583381, 15849.92075039626, 15861.52415427539, 985.6106837799065, 991.5984026469256, 991.7322322972793, 991.7768502087044, 992.3351354592404, 993.8360170571847, 1016.6543375252413, 1026.0047753678919, 1028.0644613401805, 1032.6230925712098, 1074.2158224496122, 1075.876274228462, 1076.5101878645237, 1077.288989267084, 1084.799312127255, 1068.1828401273033, 1068.6580294305825, 1068.9251752377336, 1068.941747669809, 1075.688050465364, 786.9055713314382, 790.9288164065262, 792.9881051784228, 795.9692198602824, 808.5957021489255, 16915.3233870645, 17159.914200429044, 17318.0, 17324.22041008145, 17614.735778963324, 17158.914205428893, 17336.479905602853, 17602.735958960628, 17635.38276160341, 17710.91144544269, 13114.082014259006, 13313.86686133136, 13996.0, 14033.71932561343, 14265.286735663176, 3491.5635545556806, 3516.5252690886914, 3518.4546395308766, 3518.9472157917653, 3519.7008254298416, 94441.5277923606, 123780.0, 126127.73872261343, 127743.36128319392, 128576.0, 11103.05624021951, 11353.659390218307, 13340.933295333462, 13781.51764688231, 13877.514286999907, 19985.60028799416, 25101.0, 25574.616380754305, 25928.351791205372, 26034.0, 7696.11494678108, 7740.729074482479, 7771.0, 7780.066392032993, 7792.220777922163, 3860.6332398422105, 3908.9609103909165, 3911.6088391161225, 3954.2289253595272, 3956.2878681837547, 3516.9824150879595, 4066.79666016698, 4142.896427589334, 4149.6265336119895, 4152.169566086734, 885.6103314541581, 921.1111277617132, 922.9769255768525, 929.6885543343055, 929.9256059515222, 652.2759736692268, 672.0993868216614, 681.4888833374969, 683.480554778372, 693.414065114977, 11074.224804263624, 11801.88198118025, 11898.691143974156, 11994.160408771302, 12199.451024703909, 651.6937039591385, 658.8781075501048, 659.650385295794, 673.8483841135705, 690.0925283252507, 5350.411454739976, 5386.192071189274, 5470.206820011076, 5509.173623956439, 5617.971910140505, 101625.0, 103312.0, 105272.94727052785, 105888.41167382496, 107242.0, 89829.55085224663, 90513.54743226242, 90889.0, 91353.0, 91760.0, 57408.71295643495, 80981.78527322094, 81408.59295703602, 81536.58487811711, 83336.58331708303, 9564.46718629158, 10305.814831294498, 10827.40449275266, 11045.779084418427, 11363.715907102389, 34680.30639387148, 37727.0, 38352.0, 38352.6164738349, 38529.0, 59081.40918590759, 66769.0, 68298.0, 69458.65270673615, 72657.0, 15912.283947222171, 16320.755188671941, 16508.917455412648, 16549.0, 16603.916980415503, 17850.55373615618, 18129.747229485743, 18331.35840245585, 18595.628087438447, 18632.627347453246, 16251.024938503728, 16399.754003689715, 16646.833531665012, 16816.747748784022, 16897.577560561083, 16278.67442651164, 16467.505974820775, 16530.66938661244, 16567.50297491077, 16672.16639168061, 15804.36782528686, 16048.598785030468, 16456.75314870254, 16612.335506579602, 16638.584035399213, 11171.66485005451, 11613.3612651305, 11661.300321980709, 11708.238964467282, 11974.0, 10423.530941107516, 10693.679189624323, 11086.946740059682, 12549.99600031977, 12672.936635316764], "value": 8309.152998505258, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1414.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 109.0, 110.0, 116.0, 161.0, 115.0, 109.0, 109.0, 109.0], "value": 116.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 106.0, 102.0, 146.0, 108.0, 108.0, 107.0, 107.0, 134.0, 104.0], "value": 116.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 186.0, 183.0, 183.0, 180.0, 183.0, 183.0, 183.0, 183.0, 179.0], "value": 182.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 57.0, 58.0, 91.0, 59.0, 58.0, 57.0, 56.0, 82.0, 57.0], "value": 65.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 68.0, 84.0, 68.0, 69.0, 68.0, 89.0, 69.0, 68.0, 89.0], "value": 76.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 87.0, 87.0, 86.0, 88.0, 86.0, 86.0, 86.0], "value": 86.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 93.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 86.0, 85.0, 88.0, 83.0, 84.0, 82.0, 86.0, 83.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 48.0, 46.0, 47.0, 49.0, 48.0, 49.0, 47.0, 47.0, 49.0], "value": 47.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 59.0, 62.0, 67.0, 63.0, 58.0, 57.0, 57.0, 58.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 82.0, 81.0, 83.0, 83.0, 81.0, 87.0, 102.0, 102.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 136.0, 135.0, 136.0, 142.0, 136.0, 138.0, 150.0, 216.0, 136.0], "value": 146.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 187.0, 184.0, 185.0, 182.0, 182.0, 181.0, 184.0, 184.0], "value": 183.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 66.0, 67.0, 66.0, 67.0, 67.0, 68.0, 70.0, 79.0], "value": 68.7, "unit": "score"}]}]} 17:58:19 INFO - Return code: 0 17:58:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:58:19 INFO - # TBPL SUCCESS # 17:58:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:58:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:58:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:58:19 INFO - 2017-05-11 17:58:19.340 screenresolution[1670:11594] starting screenresolution argv=screenresolution get 17:58:19 INFO - 2017-05-11 17:58:19.342 screenresolution[1670:11594] Display 0: 1600x1200x32@60 17:58:19 INFO - 2017-05-11 17:58:19.349 screenresolution[1671:11597] starting screenresolution argv=screenresolution list 17:58:19 INFO - Available Modes on Display 0 17:58:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:58:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:58:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:58:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:58:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:58:19 INFO - Intel Iris: 17:58:19 INFO - Chipset Model: Intel Iris 17:58:19 INFO - Type: GPU 17:58:19 INFO - Bus: Built-In 17:58:19 INFO - VRAM (Dynamic, Max): 1536 MB 17:58:19 INFO - Vendor: Intel (0x8086) 17:58:19 INFO - Device ID: 0x0a2e 17:58:19 INFO - Revision ID: 0x0009 17:58:19 INFO - Displays: 17:58:19 INFO - Display: 17:58:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:58:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:58:19 INFO - Display Serial Number: 1600x1200 60 17:58:19 INFO - Main Display: Yes 17:58:19 INFO - Mirror: Off 17:58:19 INFO - Online: Yes 17:58:19 INFO - Rotation: Supported 17:58:19 INFO - Return code: 0 17:58:19 INFO - Running post-action listener: _resource_record_post_action 17:58:19 INFO - [mozharness: 2017-05-12 00:58:19.580401Z] Finished run-tests step (success) 17:58:19 INFO - Running post-run listener: _resource_record_post_run 17:58:19 INFO - Total resource usage - Wall time: 1197s; CPU: 53.0%; Read bytes: 33754624; Write bytes: 528097280; Read time: 311; Write time: 1793 17:58:19 INFO - TinderboxPrint: CPU usage
53.2% 17:58:19 INFO - TinderboxPrint: I/O read bytes / time
33,754,624 / 311 17:58:19 INFO - TinderboxPrint: I/O write bytes / time
528,097,280 / 1,793 17:58:19 INFO - TinderboxPrint: CPU idle
2,241.1 (46.8%) 17:58:19 INFO - TinderboxPrint: CPU system
950.6 (19.8%) 17:58:19 INFO - TinderboxPrint: CPU user
1,597.9 (33.4%) 17:58:19 INFO - TinderboxPrint: Swap in / out
243,863,552 / 0 17:58:19 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 205779456; Write bytes: 206485504; Read time: 15769; Write time: 462 17:58:19 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 32763392; Write bytes: 311719936; Read time: 296; Write time: 1298 17:58:20 INFO - Running post-run listener: _upload_blobber_files 17:58:20 INFO - Blob upload gear active. 17:58:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:58:20 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 17:58:20 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:58:20 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:58:20 INFO - (blobuploader) - INFO - Open directory for files ... 17:58:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:58:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:58:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:58:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:58:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:58:21 INFO - (blobuploader) - INFO - Done attempting. 17:58:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:58:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:58:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:58:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:58:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:58:22 INFO - (blobuploader) - INFO - Done attempting. 17:58:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:58:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:58:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:58:23 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:58:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:58:23 INFO - (blobuploader) - INFO - Done attempting. 17:58:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:58:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:58:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:58:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:58:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:58:26 INFO - (blobuploader) - INFO - Done attempting. 17:58:26 INFO - (blobuploader) - INFO - Iteration through files over. 17:58:26 INFO - Return code: 0 17:58:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:58:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:58:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1b5cae533a5d03967759ba97523e3373064604da4bfa49f41e985bb7f2f5a83f9a3d8a56d57c257c7a675c59db7c828066e438c83f2ded4146ae4083fa06652", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/117edf47b215fec353218edf5edcf808244ec57ea60389c9352050876490f6c7b958e8a690dcf9c0b91e938036ce7d07b98042a9031b0082ff39fbdc5606a5ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f40790b1e2c95ede13cec787b0f30aa52ffbfc4dc45fffad1ebf30d10e94d78882e24e07bfcd1a50bc61cd7f2253703726879528cf72e567e0b33ba082d4f724", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca6b03b79c765243985b98fe6d5c6e447296f68a47966238d9625a9b82b6c5e113016b7649532f6bec55c3f89947dd1d8bceab93784f4c92230aa0b80075ca07"} 17:58:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:58:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:58:26 INFO - Contents: 17:58:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1b5cae533a5d03967759ba97523e3373064604da4bfa49f41e985bb7f2f5a83f9a3d8a56d57c257c7a675c59db7c828066e438c83f2ded4146ae4083fa06652", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/117edf47b215fec353218edf5edcf808244ec57ea60389c9352050876490f6c7b958e8a690dcf9c0b91e938036ce7d07b98042a9031b0082ff39fbdc5606a5ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f40790b1e2c95ede13cec787b0f30aa52ffbfc4dc45fffad1ebf30d10e94d78882e24e07bfcd1a50bc61cd7f2253703726879528cf72e567e0b33ba082d4f724", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca6b03b79c765243985b98fe6d5c6e447296f68a47966238d9625a9b82b6c5e113016b7649532f6bec55c3f89947dd1d8bceab93784f4c92230aa0b80075ca07"} 17:58:26 INFO - Running post-run listener: copy_logs_to_upload_dir 17:58:26 INFO - Copying logs to upload dir... 17:58:26 INFO - mkdir: /builds/slave/test/build/upload/logs 17:58:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=2486.392964 ========= master_lag: 0.13 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 41 mins, 26 secs) (at 2017-05-11 17:58:26.725621) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-11 17:58:26.729671) ========= 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.PdtxviW2FT/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.uAajBC7xUc/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1b5cae533a5d03967759ba97523e3373064604da4bfa49f41e985bb7f2f5a83f9a3d8a56d57c257c7a675c59db7c828066e438c83f2ded4146ae4083fa06652", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/117edf47b215fec353218edf5edcf808244ec57ea60389c9352050876490f6c7b958e8a690dcf9c0b91e938036ce7d07b98042a9031b0082ff39fbdc5606a5ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f40790b1e2c95ede13cec787b0f30aa52ffbfc4dc45fffad1ebf30d10e94d78882e24e07bfcd1a50bc61cd7f2253703726879528cf72e567e0b33ba082d4f724", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca6b03b79c765243985b98fe6d5c6e447296f68a47966238d9625a9b82b6c5e113016b7649532f6bec55c3f89947dd1d8bceab93784f4c92230aa0b80075ca07"} build_url:https://queue.taskcluster.net/v1/task/FqKUAENdSTOt7TyVMIohig/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010592 build_url: 'https://queue.taskcluster.net/v1/task/FqKUAENdSTOt7TyVMIohig/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1b5cae533a5d03967759ba97523e3373064604da4bfa49f41e985bb7f2f5a83f9a3d8a56d57c257c7a675c59db7c828066e438c83f2ded4146ae4083fa06652", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/117edf47b215fec353218edf5edcf808244ec57ea60389c9352050876490f6c7b958e8a690dcf9c0b91e938036ce7d07b98042a9031b0082ff39fbdc5606a5ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f40790b1e2c95ede13cec787b0f30aa52ffbfc4dc45fffad1ebf30d10e94d78882e24e07bfcd1a50bc61cd7f2253703726879528cf72e567e0b33ba082d4f724", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca6b03b79c765243985b98fe6d5c6e447296f68a47966238d9625a9b82b6c5e113016b7649532f6bec55c3f89947dd1d8bceab93784f4c92230aa0b80075ca07"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-11 17:58:26.764631) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 17:58:26.765019) ========= 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.PdtxviW2FT/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.uAajBC7xUc/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005044 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 17:58:26.814245) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-11 17:58:26.814622) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-11 17:58:26.814973) ========= ========= Total master_lag: 0.26 =========