builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0216 starttime: 1494370426.15 results: success (0) revision: 120d8562d4a53e4f78bd86c6f5076f6db265e5a3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-09 15:53:46.155187) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-09 15:53:46.155582) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-09 15:53:46.155853) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-09 15:53:46.179530) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 15:53:46.179859) ========= 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.3dUrUUHhpk/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.xMU3b98zfJ/Listeners TMPDIR=/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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-09 15:53:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.19M=0.001s 2017-05-09 15:53:46 (8.19 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094260 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 15:53:46.371586) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 15:53:46.371897) ========= 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.3dUrUUHhpk/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.xMU3b98zfJ/Listeners TMPDIR=/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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.021319 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 15:53:46.413621) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 15:53:46.413992) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 120d8562d4a53e4f78bd86c6f5076f6db265e5a3 --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 120d8562d4a53e4f78bd86c6f5076f6db265e5a3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3dUrUUHhpk/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.xMU3b98zfJ/Listeners TMPDIR=/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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-09 15:53:46,500 truncating revision to first 12 chars 2017-05-09 15:53:46,500 Setting DEBUG logging. 2017-05-09 15:53:46,501 attempt 1/10 2017-05-09 15:53:46,501 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/120d8562d4a5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-09 15:53:47,062 unpacking tar archive at: mozilla-central-120d8562d4a5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.834744 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 15:53:47.272946) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-09 15:53:47.273461) ========= script_repo_revision: 120d8562d4a53e4f78bd86c6f5076f6db265e5a3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-09 15:53:47.273881) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-09 15:53:47.274186) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-09 15:53:47.293584) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-05-09 15:53:47.294004) ========= /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.3dUrUUHhpk/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.xMU3b98zfJ/Listeners TMPDIR=/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 15:53:47 INFO - MultiFileLogger online at 20170509 15:53:47 in /builds/slave/test 15:53:47 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 15:53:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:53:47 INFO - {'append_to_log': False, 15:53:47 INFO - 'base_work_dir': '/builds/slave/test', 15:53:47 INFO - 'blob_upload_branch': 'Firefox', 15:53:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:53:47 INFO - 'branch': 'Firefox', 15:53:47 INFO - 'buildbot_json_path': 'buildprops.json', 15:53:47 INFO - 'config_files': ('talos/mac_config.py',), 15:53:47 INFO - 'default_actions': ('clobber', 15:53:47 INFO - 'read-buildbot-config', 15:53:47 INFO - 'download-and-extract', 15:53:47 INFO - 'populate-webroot', 15:53:47 INFO - 'create-virtualenv', 15:53:47 INFO - 'install', 15:53:47 INFO - 'run-tests'), 15:53:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:53:47 INFO - 'download_minidump_stackwalk': True, 15:53:47 INFO - 'download_symbols': 'ondemand', 15:53:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:53:47 INFO - 'tooltool.py': '/tools/tooltool.py', 15:53:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:53:47 INFO - '/tools/misc-python/virtualenv.py')}, 15:53:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:53:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:53:47 INFO - 'gecko_profile': False, 15:53:47 INFO - 'gecko_profile_interval': 0, 15:53:47 INFO - 'installer_path': 'installer.exe', 15:53:47 INFO - 'log_level': 'info', 15:53:47 INFO - 'log_name': 'talos', 15:53:47 INFO - 'log_to_console': True, 15:53:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:53:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:53:47 INFO - 'opt_config_files': (), 15:53:47 INFO - 'pip_index': False, 15:53:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:53:47 INFO - 'cmd': ('bash', 15:53:47 INFO - '-c', 15:53:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:53:47 INFO - 'enabled': True, 15:53:47 INFO - 'halt_on_failure': False, 15:53:47 INFO - 'name': 'check_screen_resolution'},), 15:53:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:53:47 INFO - 'cmd': ('bash', 15:53:47 INFO - '-c', 15:53:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:53:47 INFO - 'enabled': True, 15:53:47 INFO - 'halt_on_failure': False, 15:53:47 INFO - 'name': 'check_screen_resolution'},), 15:53:47 INFO - 'run_cmd_checks_enabled': True, 15:53:47 INFO - 'suite': 'dromaeojs', 15:53:47 INFO - 'system_bits': '32', 15:53:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:53:47 INFO - 'title': 't-yosemite-r7-0216', 15:53:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:53:47 INFO - 'use_talos_json': True, 15:53:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:53:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:53:47 INFO - 'work_dir': 'build'} 15:53:47 INFO - [mozharness: 2017-05-09 22:53:47.502620Z] Running clobber step. 15:53:47 INFO - Running pre-action listener: _resource_record_pre_action 15:53:47 INFO - Running main action method: clobber 15:53:47 INFO - rmtree: /builds/slave/test/build 15:53:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:53:49 INFO - Running post-action listener: _resource_record_post_action 15:53:49 INFO - [mozharness: 2017-05-09 22:53:49.299787Z] Finished clobber step (success) 15:53:49 INFO - [mozharness: 2017-05-09 22:53:49.299957Z] Running read-buildbot-config step. 15:53:49 INFO - Running pre-action listener: _resource_record_pre_action 15:53:49 INFO - Running main action method: read_buildbot_config 15:53:49 INFO - Using buildbot properties: 15:53:49 INFO - { 15:53:49 INFO - "project": "", 15:53:49 INFO - "product": "firefox", 15:53:49 INFO - "who": "kwierso@gmail.com", 15:53:49 INFO - "installer_path": "public/build/firefox-55.0a1.en-US.mac.dmg", 15:53:49 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 15:53:49 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 15:53:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 15:53:49 INFO - "stage_platform": "macosx64", 15:53:49 INFO - "basedir": "/builds/slave/test", 15:53:49 INFO - "buildnumber": 118, 15:53:49 INFO - "platform": "yosemite_r7", 15:53:49 INFO - "parent_task_id": "UNuUHLe6SWqH8Lt5SgBjGg", 15:53:49 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 15:53:49 INFO - "slavebuilddir": "test", 15:53:49 INFO - "taskId": "cQkXV53oQTOLZmvgZDbS_A", 15:53:49 INFO - "branch": "mozilla-central", 15:53:49 INFO - "script_repo_revision": "production", 15:53:49 INFO - "revision": "120d8562d4a53e4f78bd86c6f5076f6db265e5a3", 15:53:49 INFO - "slavename": "t-yosemite-r7-0216", 15:53:49 INFO - "repo_path": "mozilla-central" 15:53:49 INFO - } 15:53:49 INFO - Finding installer, test and symbols from parent task. 15:53:49 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cQkXV53oQTOLZmvgZDbS_A'}, attempt #1 15:53:49 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cQkXV53oQTOLZmvgZDbS_A'}, attempt #1 15:53:50 INFO - Task dependencies: QSIrxZcNTSSZgeg2YRuShQ 15:53:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UNuUHLe6SWqH8Lt5SgBjGg'}, attempt #1 15:53:50 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/UNuUHLe6SWqH8Lt5SgBjGg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:53:50 INFO - Set test_url: https://queue.taskcluster.net/v1/task/UNuUHLe6SWqH8Lt5SgBjGg/artifacts/public/build/test_packages.json 15:53:50 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/UNuUHLe6SWqH8Lt5SgBjGg/artifacts/public/build/target.crashreporter-symbols.zip 15:53:50 INFO - Running post-action listener: _resource_record_post_action 15:53:50 INFO - [mozharness: 2017-05-09 22:53:50.684194Z] Finished read-buildbot-config step (success) 15:53:50 INFO - [mozharness: 2017-05-09 22:53:50.684338Z] Running download-and-extract step. 15:53:50 INFO - Running pre-action listener: _resource_record_pre_action 15:53:50 INFO - Running main action method: download_and_extract 15:53:50 INFO - mkdir: /builds/slave/test/build/tests 15:53:50 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')]} 15:53:50 INFO - trying https://queue.taskcluster.net/v1/task/UNuUHLe6SWqH8Lt5SgBjGg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 15:53:50 INFO - Downloading https://queue.taskcluster.net/v1/task/UNuUHLe6SWqH8Lt5SgBjGg/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 15:53:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UNuUHLe6SWqH8Lt5SgBjGg/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 15:53:51 INFO - Downloaded 1325 bytes. 15:53:51 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 15:53:51 INFO - Using the following test package requirements: 15:53:51 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:53:51 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 15:53:51 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 15:53:51 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:53:51 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 15:53:51 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:53:51 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 15:53:51 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:53:51 INFO - u'jsshell-mac.zip'], 15:53:51 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:53:51 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 15:53:51 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 15:53:51 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:53:51 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 15:53:51 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:53:51 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 15:53:51 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:53:51 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 15:53:51 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:53:51 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 15:53:51 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:53:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UNuUHLe6SWqH8Lt5SgBjGg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 15:53:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UNuUHLe6SWqH8Lt5SgBjGg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:53:51 INFO - Fetch https://queue.taskcluster.net/v1/task/UNuUHLe6SWqH8Lt5SgBjGg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 15:53:53 INFO - Content-Length response header: 52707419 15:53:53 INFO - Bytes received: 52707419 15:54:09 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 15:54:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UNuUHLe6SWqH8Lt5SgBjGg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 15:54:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UNuUHLe6SWqH8Lt5SgBjGg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:54:09 INFO - Fetch https://queue.taskcluster.net/v1/task/UNuUHLe6SWqH8Lt5SgBjGg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 15:54:12 INFO - Content-Length response header: 52707419 15:54:12 INFO - Bytes received: 52707419 15:54:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UNuUHLe6SWqH8Lt5SgBjGg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 15:54:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UNuUHLe6SWqH8Lt5SgBjGg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:54:27 INFO - Fetch https://queue.taskcluster.net/v1/task/UNuUHLe6SWqH8Lt5SgBjGg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 15:54:28 INFO - Content-Length response header: 14409362 15:54:28 INFO - Bytes received: 14409362 15:54:28 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')]} 15:54:28 INFO - trying https://queue.taskcluster.net/v1/task/UNuUHLe6SWqH8Lt5SgBjGg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:54:28 INFO - Downloading https://queue.taskcluster.net/v1/task/UNuUHLe6SWqH8Lt5SgBjGg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 15:54:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UNuUHLe6SWqH8Lt5SgBjGg/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 15:54:30 INFO - Downloaded 75528034 bytes. 15:54:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UNuUHLe6SWqH8Lt5SgBjGg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:54:30 INFO - mkdir: /builds/slave/test/properties 15:54:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:54:30 INFO - Writing to file /builds/slave/test/properties/build_url 15:54:30 INFO - Contents: 15:54:30 INFO - build_url:https://queue.taskcluster.net/v1/task/UNuUHLe6SWqH8Lt5SgBjGg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:54:30 INFO - Running post-action listener: _resource_record_post_action 15:54:30 INFO - Running post-action listener: set_extra_try_arguments 15:54:30 INFO - [mozharness: 2017-05-09 22:54:30.920161Z] Finished download-and-extract step (success) 15:54:30 INFO - [mozharness: 2017-05-09 22:54:30.920265Z] Running populate-webroot step. 15:54:30 INFO - Running pre-action listener: _resource_record_pre_action 15:54:30 INFO - Running main action method: populate_webroot 15:54:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:54:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:54:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:54:30 INFO - '--tppagecycles', 15:54:30 INFO - '7'], 15:54:30 INFO - 'tests': ['tsvgm']}}, 15:54:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:54:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:54:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:54:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:54:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:54:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:54:30 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:54:30 INFO - 'talos_options': ['--disable-e10s'], 15:54:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:54:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:54:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:54:30 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:54:30 INFO - 'talos_options': ['--disable-e10s'], 15:54:30 INFO - 'tests': ['damp', 'tps']}, 15:54:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:54:30 INFO - 'tests': ['damp', 'tps']}, 15:54:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:54:30 INFO - 'tests': ['dromaeo_dom']}, 15:54:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:54:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:54:30 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 15:54:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:54:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:54:30 INFO - 'tests': ['a11yr', 15:54:30 INFO - 'ts_paint', 15:54:30 INFO - 'tpaint', 15:54:30 INFO - 'sessionrestore', 15:54:30 INFO - 'sessionrestore_no_auto_restore', 15:54:30 INFO - 'tabpaint']}, 15:54:30 INFO - 'other-e10s': {'tests': ['a11yr', 15:54:30 INFO - 'ts_paint', 15:54:30 INFO - 'tpaint', 15:54:30 INFO - 'sessionrestore', 15:54:30 INFO - 'sessionrestore_no_auto_restore', 15:54:30 INFO - 'tabpaint']}, 15:54:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:54:30 INFO - 'ts_paint', 15:54:30 INFO - 'tpaint', 15:54:30 INFO - 'sessionrestore', 15:54:30 INFO - 'sessionrestore_no_auto_restore', 15:54:30 INFO - 'tabpaint']}, 15:54:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:54:30 INFO - 'ts_paint', 15:54:30 INFO - 'tpaint', 15:54:30 INFO - 'sessionrestore', 15:54:30 INFO - 'sessionrestore_no_auto_restore', 15:54:30 INFO - 'tabpaint']}, 15:54:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:54:30 INFO - 'tests': ['a11yr', 15:54:30 INFO - 'ts_paint', 15:54:30 INFO - 'tpaint', 15:54:30 INFO - 'sessionrestore', 15:54:30 INFO - 'sessionrestore_no_auto_restore', 15:54:30 INFO - 'tabpaint']}, 15:54:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:54:30 INFO - 'tests': ['a11yr', 15:54:30 INFO - 'ts_paint', 15:54:30 INFO - 'tpaint', 15:54:30 INFO - 'sessionrestore', 15:54:30 INFO - 'sessionrestore_no_auto_restore', 15:54:30 INFO - 'tabpaint']}, 15:54:30 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 15:54:30 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 15:54:30 INFO - 'bloom_basic_ref']}, 15:54:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:54:30 INFO - 'tests': ['tsvgx', 15:54:30 INFO - 'tsvgr_opacity', 15:54:30 INFO - 'tart', 15:54:30 INFO - 'tscrollx', 15:54:30 INFO - 'cart', 15:54:30 INFO - 'tsvg_static']}, 15:54:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:54:30 INFO - 'tsvgr_opacity', 15:54:30 INFO - 'tart', 15:54:30 INFO - 'tscrollx', 15:54:30 INFO - 'cart', 15:54:30 INFO - 'tsvg_static']}, 15:54:30 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:54:30 INFO - 'talos_options': ['--disable-e10s'], 15:54:30 INFO - 'tests': ['tp5o']}, 15:54:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:54:30 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:54:30 INFO - 'talos_options': ['--disable-e10s', 15:54:30 INFO - '--xperf_path', 15:54:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:54:30 INFO - 'tests': ['tp5n']}, 15:54:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:54:30 INFO - 'talos_options': ['--xperf_path', 15:54:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:54:30 INFO - 'tests': ['tp5n']}}, 15:54:30 INFO - 'talos.zip': {'path': '', 15:54:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:54:30 INFO - Running post-action listener: _resource_record_post_action 15:54:30 INFO - [mozharness: 2017-05-09 22:54:30.941323Z] Finished populate-webroot step (success) 15:54:30 INFO - [mozharness: 2017-05-09 22:54:30.941482Z] Running create-virtualenv step. 15:54:30 INFO - Running pre-action listener: _resource_record_pre_action 15:54:30 INFO - Running main action method: create_virtualenv 15:54:30 INFO - Creating virtualenv /builds/slave/test/build/venv 15:54:30 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 15:54:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:54:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:54:31 INFO - Using real prefix '/tools/python27' 15:54:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:54:31 INFO - Installing distribute.............................................................................................................................................................................................done. 15:54:34 INFO - Installing pip.................done. 15:54:34 INFO - Return code: 0 15:54:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:54:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:54:35 INFO - Reading from file tmpfile_stdout 15:54:35 INFO - Output received: 15:54:35 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) 15:54:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:54:35 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')]} 15:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:35 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')]} 15:54:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:35 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 0x107150b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107153768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b2b48b980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e61d30>, '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 0x106e14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e55be8>, '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.3dUrUUHhpk/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.xMU3b98zfJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 15:54:35 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 15:54:35 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 15:54:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3dUrUUHhpk/Render', 15:54:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:54:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:54:35 INFO - 'HOME': '/Users/cltbld', 15:54:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:54:35 INFO - 'LOGNAME': 'cltbld', 15:54:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:35 INFO - 'MOZ_NO_REMOTE': '1', 15:54:35 INFO - 'NO_EM_RESTART': '1', 15:54:35 INFO - 'PAGER': '/bin/cat', 15:54:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:54:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:35 INFO - 'PWD': '/builds/slave/test', 15:54:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:54:35 INFO - 'SHELL': '/bin/bash', 15:54:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xMU3b98zfJ/Listeners', 15:54:35 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 15:54:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:54:35 INFO - 'USER': 'cltbld', 15:54:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:54:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:54:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:35 INFO - 'XPC_FLAGS': '0x0', 15:54:35 INFO - 'XPC_SERVICE_NAME': '0', 15:54:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:54:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:35 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 15:54:35 INFO - Cleaning up... 15:54:35 INFO - Return code: 0 15:54:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:54:35 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')]} 15:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:35 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')]} 15:54:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:35 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 0x107150b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107153768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b2b48b980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e61d30>, '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 0x106e14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e55be8>, '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.3dUrUUHhpk/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.xMU3b98zfJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 15:54:35 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 15:54:35 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 15:54:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3dUrUUHhpk/Render', 15:54:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:54:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:54:35 INFO - 'HOME': '/Users/cltbld', 15:54:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:54:35 INFO - 'LOGNAME': 'cltbld', 15:54:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:35 INFO - 'MOZ_NO_REMOTE': '1', 15:54:35 INFO - 'NO_EM_RESTART': '1', 15:54:35 INFO - 'PAGER': '/bin/cat', 15:54:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:54:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:35 INFO - 'PWD': '/builds/slave/test', 15:54:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:54:35 INFO - 'SHELL': '/bin/bash', 15:54:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xMU3b98zfJ/Listeners', 15:54:35 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 15:54:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:54:35 INFO - 'USER': 'cltbld', 15:54:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:54:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:54:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:35 INFO - 'XPC_FLAGS': '0x0', 15:54:35 INFO - 'XPC_SERVICE_NAME': '0', 15:54:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:54:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:35 INFO - Downloading/unpacking psutil>=3.1.1 15:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:54:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:54:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:54:37 INFO - Installing collected packages: psutil 15:54:37 INFO - Running setup.py install for psutil 15:54:38 INFO - building 'psutil._psutil_osx' extension 15:54:38 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 15:54:38 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 15:54:38 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 15:54:38 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 15:54:38 INFO - building 'psutil._psutil_posix' extension 15:54:38 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 15:54:38 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:54:38 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:54:38 INFO - ^ 15:54:38 INFO - 1 warning generated. 15:54:38 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 15:54:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:54:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:54:38 INFO - Successfully installed psutil 15:54:38 INFO - Cleaning up... 15:54:38 INFO - Return code: 0 15:54:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:54: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')]} 15:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54: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')]} 15:54:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:38 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 0x107150b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107153768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b2b48b980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e61d30>, '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 0x106e14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e55be8>, '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.3dUrUUHhpk/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.xMU3b98zfJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 15:54:38 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 15:54:38 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 15:54:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3dUrUUHhpk/Render', 15:54:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:54:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:54:38 INFO - 'HOME': '/Users/cltbld', 15:54:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:54:38 INFO - 'LOGNAME': 'cltbld', 15:54:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:38 INFO - 'MOZ_NO_REMOTE': '1', 15:54:38 INFO - 'NO_EM_RESTART': '1', 15:54:38 INFO - 'PAGER': '/bin/cat', 15:54:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:54:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:38 INFO - 'PWD': '/builds/slave/test', 15:54:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:54:38 INFO - 'SHELL': '/bin/bash', 15:54:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xMU3b98zfJ/Listeners', 15:54:38 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 15:54:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:54:38 INFO - 'USER': 'cltbld', 15:54:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:54:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:54:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:38 INFO - 'XPC_FLAGS': '0x0', 15:54:38 INFO - 'XPC_SERVICE_NAME': '0', 15:54:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:54:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:54:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:54:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:54:40 INFO - Installing collected packages: mozsystemmonitor 15:54:40 INFO - Running setup.py install for mozsystemmonitor 15:54:40 INFO - Successfully installed mozsystemmonitor 15:54:40 INFO - Cleaning up... 15:54:40 INFO - Return code: 0 15:54:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:54:40 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')]} 15:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:41 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')]} 15:54:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:41 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 0x107150b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107153768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b2b48b980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e61d30>, '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 0x106e14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e55be8>, '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.3dUrUUHhpk/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.xMU3b98zfJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 15:54:41 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 15:54:41 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 15:54:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3dUrUUHhpk/Render', 15:54:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:54:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:54:41 INFO - 'HOME': '/Users/cltbld', 15:54:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:54:41 INFO - 'LOGNAME': 'cltbld', 15:54:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:41 INFO - 'MOZ_NO_REMOTE': '1', 15:54:41 INFO - 'NO_EM_RESTART': '1', 15:54:41 INFO - 'PAGER': '/bin/cat', 15:54:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:54:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:41 INFO - 'PWD': '/builds/slave/test', 15:54:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:54:41 INFO - 'SHELL': '/bin/bash', 15:54:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xMU3b98zfJ/Listeners', 15:54:41 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 15:54:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:54:41 INFO - 'USER': 'cltbld', 15:54:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:54:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:54:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:41 INFO - 'XPC_FLAGS': '0x0', 15:54:41 INFO - 'XPC_SERVICE_NAME': '0', 15:54:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:54:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:41 INFO - Downloading/unpacking jsonschema==2.5.1 15:54:41 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 15:54:41 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 15:54:41 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 15:54:41 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 15:54:41 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 15:54:41 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 15:54:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:54:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:54:43 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 15:54:43 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 15:54:43 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 15:54:43 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 15:54:43 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 15:54:43 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 15:54:43 INFO - Downloading functools32-3.2.3-2.tar.gz 15:54:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:54:43 INFO - warning: no files found matching '*.txt' 15:54:43 INFO - no previously-included directories found matching 'build' 15:54:43 INFO - no previously-included directories found matching 'dist' 15:54:43 INFO - no previously-included directories found matching '.git*' 15:54:43 INFO - Installing collected packages: jsonschema, functools32 15:54:43 INFO - Running setup.py install for functools32 15:54:43 INFO - warning: no files found matching '*.txt' 15:54:43 INFO - no previously-included directories found matching 'build' 15:54:43 INFO - no previously-included directories found matching 'dist' 15:54:43 INFO - no previously-included directories found matching '.git*' 15:54:43 INFO - Successfully installed jsonschema functools32 15:54:43 INFO - Cleaning up... 15:54:43 INFO - Return code: 0 15:54:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:54:43 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')]} 15:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:43 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')]} 15:54:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:43 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 0x107150b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107153768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b2b48b980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e61d30>, '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 0x106e14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e55be8>, '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.3dUrUUHhpk/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.xMU3b98zfJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 15:54:43 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 15:54:43 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 15:54:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3dUrUUHhpk/Render', 15:54:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:54:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:54:43 INFO - 'HOME': '/Users/cltbld', 15:54:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:54:43 INFO - 'LOGNAME': 'cltbld', 15:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:43 INFO - 'MOZ_NO_REMOTE': '1', 15:54:43 INFO - 'NO_EM_RESTART': '1', 15:54:43 INFO - 'PAGER': '/bin/cat', 15:54:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:43 INFO - 'PWD': '/builds/slave/test', 15:54:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:54:43 INFO - 'SHELL': '/bin/bash', 15:54:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xMU3b98zfJ/Listeners', 15:54:43 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 15:54:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:54:43 INFO - 'USER': 'cltbld', 15:54:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:54:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:43 INFO - 'XPC_FLAGS': '0x0', 15:54:43 INFO - 'XPC_SERVICE_NAME': '0', 15:54:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:54:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:54:44 INFO - Cleaning up... 15:54:44 INFO - Return code: 0 15:54:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:54: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')]} 15:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54: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')]} 15:54:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:44 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 0x107150b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107153768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b2b48b980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e61d30>, '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 0x106e14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e55be8>, '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.3dUrUUHhpk/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.xMU3b98zfJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 15:54:44 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 15:54:44 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 15:54:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3dUrUUHhpk/Render', 15:54:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:54:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:54:44 INFO - 'HOME': '/Users/cltbld', 15:54:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:54:44 INFO - 'LOGNAME': 'cltbld', 15:54:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:44 INFO - 'MOZ_NO_REMOTE': '1', 15:54:44 INFO - 'NO_EM_RESTART': '1', 15:54:44 INFO - 'PAGER': '/bin/cat', 15:54:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:54:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:44 INFO - 'PWD': '/builds/slave/test', 15:54:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:54:44 INFO - 'SHELL': '/bin/bash', 15:54:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xMU3b98zfJ/Listeners', 15:54:44 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 15:54:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:54:44 INFO - 'USER': 'cltbld', 15:54:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:54:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:54:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:44 INFO - 'XPC_FLAGS': '0x0', 15:54:44 INFO - 'XPC_SERVICE_NAME': '0', 15:54:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:54:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:44 INFO - Downloading/unpacking blobuploader==1.2.4 15:54:44 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 15:54:44 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 15:54:44 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 15:54:44 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 15:54:44 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 15:54:44 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 15:54:45 INFO - Downloading blobuploader-1.2.4.tar.gz 15:54:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:54:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:54:45 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 15:54:45 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 15:54:45 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 15:54:45 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 15:54:45 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 15:54:45 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 15:54:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:54:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:54: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 15:54: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 15:54: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 15:54: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 15:54: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 15:54: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 15:54:46 INFO - Downloading docopt-0.6.1.tar.gz 15:54:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:54:46 INFO - Installing collected packages: blobuploader, requests, docopt 15:54:46 INFO - Running setup.py install for blobuploader 15:54:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:54:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:54:46 INFO - Running setup.py install for requests 15:54:47 INFO - Running setup.py install for docopt 15:54:47 INFO - Successfully installed blobuploader requests docopt 15:54:47 INFO - Cleaning up... 15:54:47 INFO - Return code: 0 15:54:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:54:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:47 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 0x107150b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107153768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b2b48b980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e61d30>, '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 0x106e14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e55be8>, '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.3dUrUUHhpk/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.xMU3b98zfJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 15:54:47 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 15:54:47 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 15:54:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3dUrUUHhpk/Render', 15:54:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:54:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:54:47 INFO - 'HOME': '/Users/cltbld', 15:54:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:54:47 INFO - 'LOGNAME': 'cltbld', 15:54:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:47 INFO - 'MOZ_NO_REMOTE': '1', 15:54:47 INFO - 'NO_EM_RESTART': '1', 15:54:47 INFO - 'PAGER': '/bin/cat', 15:54:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:54:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:47 INFO - 'PWD': '/builds/slave/test', 15:54:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:54:47 INFO - 'SHELL': '/bin/bash', 15:54:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xMU3b98zfJ/Listeners', 15:54:47 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 15:54:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:54:47 INFO - 'USER': 'cltbld', 15:54:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:54:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:54:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:47 INFO - 'XPC_FLAGS': '0x0', 15:54:47 INFO - 'XPC_SERVICE_NAME': '0', 15:54:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:54:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:54:47 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-o2xPy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:54:47 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-y8Ivng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:54:48 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-2si_vB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:54:48 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-TCDJSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:54:48 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-U_e2lQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:54:48 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-GTeSO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:54:48 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-iX22wp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:54:48 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-1Y26c_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:54:48 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-2Njx0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:54:48 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-bs8t0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:54:48 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-zVO9jl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:54:48 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-reivJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:54:49 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-xiS8Xg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:54:49 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-_s190Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:49 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-sMagUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:54:49 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-0_j1jM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:54:49 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-4P28p0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:54:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:54:49 INFO - Running setup.py install for manifestparser 15:54:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:54:49 INFO - Running setup.py install for mozcrash 15:54:49 INFO - Running setup.py install for mozdebug 15:54:50 INFO - Running setup.py install for mozdevice 15:54:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:54:50 INFO - Running setup.py install for mozfile 15:54:50 INFO - Running setup.py install for mozhttpd 15:54:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:54:50 INFO - Running setup.py install for mozinfo 15:54:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:54:50 INFO - Running setup.py install for mozInstall 15:54:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:54:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:54:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:54:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:54:50 INFO - Running setup.py install for mozleak 15:54:50 INFO - Running setup.py install for mozlog 15:54:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:54:51 INFO - Running setup.py install for moznetwork 15:54:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:54:51 INFO - Running setup.py install for mozprocess 15:54:51 INFO - Running setup.py install for mozprofile 15:54:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:54:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:54:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:54:51 INFO - Running setup.py install for mozrunner 15:54:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:54:51 INFO - Running setup.py install for mozscreenshot 15:54:51 INFO - Running setup.py install for moztest 15:54:51 INFO - Running setup.py install for mozversion 15:54:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:54:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:54:52 INFO - Cleaning up... 15:54:52 INFO - Return code: 0 15:54:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:54:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:52 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 0x107150b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107153768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b2b48b980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e61d30>, '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 0x106e14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e55be8>, '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.3dUrUUHhpk/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.xMU3b98zfJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 15:54:52 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 15:54:52 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 15:54:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3dUrUUHhpk/Render', 15:54:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:54:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:54:52 INFO - 'HOME': '/Users/cltbld', 15:54:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:54:52 INFO - 'LOGNAME': 'cltbld', 15:54:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:52 INFO - 'MOZ_NO_REMOTE': '1', 15:54:52 INFO - 'NO_EM_RESTART': '1', 15:54:52 INFO - 'PAGER': '/bin/cat', 15:54:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:54:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:52 INFO - 'PWD': '/builds/slave/test', 15:54:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:54:52 INFO - 'SHELL': '/bin/bash', 15:54:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xMU3b98zfJ/Listeners', 15:54:52 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 15:54:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:54:52 INFO - 'USER': 'cltbld', 15:54:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:54:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:54:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:52 INFO - 'XPC_FLAGS': '0x0', 15:54:52 INFO - 'XPC_SERVICE_NAME': '0', 15:54:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:54:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:54:52 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-8ghem7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:54:52 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)) 15:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:54:52 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-OwgZE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:54:52 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)) 15:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:54:52 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-UN_Nhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:54:52 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)) 15:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:54:52 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-0YrSPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:54:52 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)) 15:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:54:52 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-01LluI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:54:52 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)) 15:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:54:52 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-6Mz9X0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:54:53 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)) 15:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:54:53 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-kJlt0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:54:53 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)) 15:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:54:53 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-F7zJEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:54:53 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)) 15:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:54:53 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-B2emoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:54:53 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)) 15:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:54:53 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-K_bJx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:54:53 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)) 15:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:54:53 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-X86Kzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:54:53 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)) 15:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:54:53 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-5mrU12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:54:53 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)) 15:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:54:53 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-uGlKqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:54:53 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)) 15:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:54:53 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-xwk1aD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:54:53 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)) 15:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:53 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-0_8XdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:54 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)) 15:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:54:54 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-yygT8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:54:54 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)) 15:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:54:54 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-Lxn6dn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:54:54 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)) 15:54:54 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)) 15:54:54 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)) 15:54:54 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)) 15:54:54 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)) 15:54:54 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)) 15:54:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:54:54 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 15:54:54 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 15:54:54 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 15:54:54 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 15:54:54 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 15:54:54 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 15:54:55 INFO - Downloading blessings-1.6.tar.gz 15:54:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:54:55 INFO - Installing collected packages: blessings 15:54:55 INFO - Running setup.py install for blessings 15:54:55 INFO - Successfully installed blessings 15:54:55 INFO - Cleaning up... 15:54:55 INFO - Return code: 0 15:54:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:54:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:54:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:54:56 INFO - Reading from file tmpfile_stdout 15:54:56 INFO - Current package versions: 15:54:56 INFO - blessings == 1.6 15:54:56 INFO - blobuploader == 1.2.4 15:54:56 INFO - docopt == 0.6.1 15:54:56 INFO - functools32 == 3.2.3-2 15:54:56 INFO - jsonschema == 2.5.1 15:54:56 INFO - manifestparser == 1.1 15:54:56 INFO - mozInstall == 1.12 15:54:56 INFO - mozcrash == 1.0 15:54:56 INFO - mozdebug == 0.1 15:54:56 INFO - mozdevice == 0.50 15:54:56 INFO - mozfile == 1.2 15:54:56 INFO - mozhttpd == 0.7 15:54:56 INFO - mozinfo == 0.9 15:54:56 INFO - mozleak == 0.1 15:54:56 INFO - mozlog == 3.4 15:54:56 INFO - moznetwork == 0.27 15:54:56 INFO - mozprocess == 0.25 15:54:56 INFO - mozprofile == 0.28 15:54:56 INFO - mozrunner == 6.13 15:54:56 INFO - mozscreenshot == 0.1 15:54:56 INFO - mozsystemmonitor == 0.3 15:54:56 INFO - moztest == 0.8 15:54:56 INFO - mozversion == 1.4 15:54:56 INFO - psutil == 3.1.1 15:54:56 INFO - requests == 1.2.3 15:54:56 INFO - wsgiref == 0.1.2 15:54:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:54:56 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')]} 15:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:56 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')]} 15:54:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:56 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 0x107150b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107153768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b2b48b980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e61d30>, '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 0x106e14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e55be8>, '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.3dUrUUHhpk/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.xMU3b98zfJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 15:54:56 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 15:54:56 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 15:54:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3dUrUUHhpk/Render', 15:54:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:54:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:54:56 INFO - 'HOME': '/Users/cltbld', 15:54:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:54:56 INFO - 'LOGNAME': 'cltbld', 15:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:56 INFO - 'MOZ_NO_REMOTE': '1', 15:54:56 INFO - 'NO_EM_RESTART': '1', 15:54:56 INFO - 'PAGER': '/bin/cat', 15:54:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:56 INFO - 'PWD': '/builds/slave/test', 15:54:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:54:56 INFO - 'SHELL': '/bin/bash', 15:54:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xMU3b98zfJ/Listeners', 15:54:56 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 15:54:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:54:56 INFO - 'USER': 'cltbld', 15:54:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:54:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:56 INFO - 'XPC_FLAGS': '0x0', 15:54:56 INFO - 'XPC_SERVICE_NAME': '0', 15:54:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:56 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)) 15:54:56 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)) 15:54:56 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)) 15:54:56 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)) 15:54:56 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)) 15:54:56 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)) 15:54:56 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)) 15:54:56 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)) 15:54:56 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)) 15:54:56 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)) 15:54:56 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)) 15:54:56 INFO - Cleaning up... 15:54:56 INFO - Return code: 0 15:54:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:54:56 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')]} 15:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:56 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')]} 15:54:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:56 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 0x107150b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107153768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b2b48b980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e61d30>, '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 0x106e14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e55be8>, '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.3dUrUUHhpk/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.xMU3b98zfJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 15:54:56 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 15:54:56 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 15:54:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3dUrUUHhpk/Render', 15:54:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:54:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:54:56 INFO - 'HOME': '/Users/cltbld', 15:54:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:54:56 INFO - 'LOGNAME': 'cltbld', 15:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:56 INFO - 'MOZ_NO_REMOTE': '1', 15:54:56 INFO - 'NO_EM_RESTART': '1', 15:54:56 INFO - 'PAGER': '/bin/cat', 15:54:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:56 INFO - 'PWD': '/builds/slave/test', 15:54:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:54:56 INFO - 'SHELL': '/bin/bash', 15:54:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xMU3b98zfJ/Listeners', 15:54:56 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 15:54:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:54:56 INFO - 'USER': 'cltbld', 15:54:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:54:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:56 INFO - 'XPC_FLAGS': '0x0', 15:54:56 INFO - 'XPC_SERVICE_NAME': '0', 15:54:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:54:56 INFO - Cleaning up... 15:54:56 INFO - Return code: 0 15:54:56 INFO - Running post-action listener: _resource_record_post_action 15:54:56 INFO - Running post-action listener: _start_resource_monitoring 15:54:56 INFO - Starting resource monitoring. 15:54:56 INFO - [mozharness: 2017-05-09 22:54:56.787907Z] Finished create-virtualenv step (success) 15:54:56 INFO - [mozharness: 2017-05-09 22:54:56.788869Z] Running install step. 15:54:56 INFO - Running pre-action listener: _resource_record_pre_action 15:54:56 INFO - Running main action method: install 15:54:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:54:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:54:57 INFO - Reading from file tmpfile_stdout 15:54:57 INFO - Detecting whether we're running mozinstall >=1.0... 15:54:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:54:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:54:57 INFO - Reading from file tmpfile_stdout 15:54:57 INFO - Output received: 15:54:57 INFO - Usage: mozinstall [options] installer 15:54:57 INFO - Options: 15:54:57 INFO - -h, --help show this help message and exit 15:54:57 INFO - -d DEST, --destination=DEST 15:54:57 INFO - Directory to install application into. [default: 15:54:57 INFO - "/builds/slave/test"] 15:54:57 INFO - --app=APP Application being installed. [default: firefox] 15:54:57 INFO - mkdir: /builds/slave/test/build/application 15:54:57 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'] 15:54:57 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 15:55:17 INFO - Reading from file tmpfile_stdout 15:55:17 INFO - Output received: 15:55:17 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:55:17 INFO - Running post-action listener: _resource_record_post_action 15:55:17 INFO - [mozharness: 2017-05-09 22:55:17.692917Z] Finished install step (success) 15:55:17 INFO - [mozharness: 2017-05-09 22:55:17.693117Z] Running run-tests step. 15:55:17 INFO - Running pre-action listener: _resource_record_pre_action 15:55:17 INFO - Running main action method: run_tests 15:55:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:55:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:55:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:55:17 INFO - 2017-05-09 15:55:17.707 screenresolution[2853:30267] starting screenresolution argv=screenresolution get 15:55:17 INFO - 2017-05-09 15:55:17.710 screenresolution[2853:30267] Display 0: 1600x1200x32@60 15:55:17 INFO - 2017-05-09 15:55:17.716 screenresolution[2854:30269] starting screenresolution argv=screenresolution list 15:55:17 INFO - Available Modes on Display 0 15:55:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:55:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:55:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:55:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:55:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:55:17 INFO - Intel Iris: 15:55:17 INFO - Chipset Model: Intel Iris 15:55:17 INFO - Type: GPU 15:55:17 INFO - Bus: Built-In 15:55:17 INFO - VRAM (Dynamic, Max): 1536 MB 15:55:17 INFO - Vendor: Intel (0x8086) 15:55:17 INFO - Device ID: 0x0a2e 15:55:17 INFO - Revision ID: 0x0009 15:55:17 INFO - Displays: 15:55:17 INFO - Display: 15:55:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:55:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:55:17 INFO - Display Serial Number: 1600x1200 60 15:55:17 INFO - Main Display: Yes 15:55:17 INFO - Mirror: Off 15:55:17 INFO - Online: Yes 15:55:17 INFO - Rotation: Supported 15:55:17 INFO - Return code: 0 15:55:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:55:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:55:17 INFO - Python 2.7.3 15:55:17 INFO - Return code: 0 15:55:17 INFO - grabbing minidump binary from tooltool 15:55:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:55:17 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 0x106e61d30>, '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 0x106e14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e55be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:55:17 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 15:55:17 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 15:55:17 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 15:55:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:55:18 INFO - Return code: 0 15:55:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:55:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:55:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:55:18 INFO - ENV: RUST_BACKTRACE is now 1 15:55:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:55:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:55:18 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/UNuUHLe6SWqH8Lt5SgBjGg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0216', '--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 15:55:18 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/UNuUHLe6SWqH8Lt5SgBjGg/artifacts/public/build/target.crashreporter-symbols.zip --title t-yosemite-r7-0216 --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 15:55:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3dUrUUHhpk/Render', 15:55:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:55:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:55:18 INFO - 'HOME': '/Users/cltbld', 15:55:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:55:18 INFO - 'LOGNAME': 'cltbld', 15:55:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:55:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:55:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:18 INFO - 'MOZ_NO_REMOTE': '1', 15:55:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:55:18 INFO - 'NO_EM_RESTART': '1', 15:55:18 INFO - 'PAGER': '/bin/cat', 15:55:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:55:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:18 INFO - 'PWD': '/builds/slave/test', 15:55:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:55:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:55:18 INFO - 'RUST_BACKTRACE': '1', 15:55:18 INFO - 'SHELL': '/bin/bash', 15:55:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xMU3b98zfJ/Listeners', 15:55:18 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 15:55:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:55:18 INFO - 'USER': 'cltbld', 15:55:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:55:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:55:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:18 INFO - 'XPC_FLAGS': '0x0', 15:55:18 INFO - 'XPC_SERVICE_NAME': '0', 15:55:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:55:18 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/UNuUHLe6SWqH8Lt5SgBjGg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0216', '--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 15:55:18 INFO - mozversion application_buildid: 20170509143927 15:55:18 INFO - mozversion application_changeset: 120d8562d4a53e4f78bd86c6f5076f6db265e5a3 15:55:18 INFO - mozversion application_display_name: Nightly 15:55:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:55:18 INFO - mozversion application_name: Firefox 15:55:18 INFO - mozversion application_remotingname: firefox 15:55:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:55:18 INFO - mozversion application_vendor: Mozilla 15:55:18 INFO - mozversion application_version: 55.0a1 15:55:18 INFO - mozversion platform_buildid: 20170509143927 15:55:18 INFO - mozversion platform_changeset: 120d8562d4a53e4f78bd86c6f5076f6db265e5a3 15:55:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:55:18 INFO - mozversion platform_version: 55.0a1 15:55:18 INFO - using testdate: 1494370518 15:55:18 INFO - actual date: 1494370518 15:55:18 INFO - starting webserver on 'localhost:57179' 15:55:18 INFO - SUITE-START | Running 2 tests 15:55:18 INFO - TEST-START | dromaeo_css 15:55:18 INFO - operating with platform_type : mac_ 15:55:18 INFO - Initialising browser for dromaeo_css test... 15:55:18 INFO - TEST-INFO | started process 2864 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/tmpilXvER/profile http://localhost:57179/getInfo.html) 15:55:20 INFO - PID 2864 | __metrics Screen width/height:1600/1200 15:55:20 INFO - PID 2864 | colorDepth:24 15:55:20 INFO - PID 2864 | Browser inner width/height: 1024/691 15:55:20 INFO - PID 2864 | __metrics 15:55:20 INFO - PID 2864 | 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" 15:55:20 INFO - PID 2864 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:55:21 INFO - TEST-INFO | 2864: exit 0 15:55:21 INFO - Browser initialized. 15:55:21 INFO - Running cycle 1/1 for dromaeo_css test... 15:55:21 INFO - TEST-INFO | started process 2866 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/tmpilXvER/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:55:33 INFO - PID 2866 | RSS: Main: 233984000 15:55:33 INFO - PID 2866 | 15:58:39 INFO - PID 2866 | Cycle 1(1): loaded http://localhost:57179/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57179/tests/dromaeo/cssquery-ext.html) 15:58:40 INFO - PID 2866 | RSS: Main: 388841472 15:58:40 INFO - PID 2866 | 16:01:43 INFO - PID 2866 | Cycle 1(1): loaded http://localhost:57179/tests/dromaeo/cssquery-ext.html (next: http://localhost:57179/tests/dromaeo/cssquery-jquery.html) 16:01:44 INFO - PID 2866 | RSS: Main: 369078272 16:01:44 INFO - PID 2866 | 16:04:46 INFO - PID 2866 | Cycle 1(1): loaded http://localhost:57179/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57179/tests/dromaeo/cssquery-mootools.html) 16:04:46 INFO - PID 2866 | RSS: Main: 347303936 16:04:46 INFO - PID 2866 | 16:07:49 INFO - PID 2866 | Cycle 1(1): loaded http://localhost:57179/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57179/tests/dromaeo/cssquery-prototype.html) 16:07:49 INFO - PID 2866 | RSS: Main: 360067072 16:07:49 INFO - PID 2866 | 16:10:53 INFO - PID 2866 | Cycle 1(1): loaded http://localhost:57179/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57179/tests/dromaeo/cssquery-yui.html) 16:10:54 INFO - PID 2866 | RSS: Main: 325435392 16:10:54 INFO - PID 2866 | 16:13:56 INFO - PID 2866 | Cycle 1(1): loaded http://localhost:57179/tests/dromaeo/cssquery-yui.html (next: http://localhost:57179/tests/dromaeo/cssquery-dojo.html) 16:13:56 INFO - PID 2866 | RSS: Main: 372547584 16:13:56 INFO - PID 2866 | 16:13:56 INFO - PID 2866 | __start_tp_report 16:13:56 INFO - PID 2866 | _x_x_mozilla_page_load 16:13:56 INFO - PID 2866 | _x_x_mozilla_page_load_details 16:13:56 INFO - PID 2866 | |i|pagename|runs| 16:13:56 INFO - PID 2866 | |0;dojo.html;3503.527023851781;3557.07516045828;3575.0883524701203;3576.3026209889067;3600.45993101035;6021.578489505725;6124.543000308823;6133.6626485543275;6178.845528861781;6219.3780621937785;6085.269767627879;6118.082287656854;6124.112003759452;6125.81622551323;6144.692765361737;5227.817026404076;5268.998890210867;5271.973640131794;5277.366715994086;5356.91964620531;5387.138057910735;5394.541463975547;5407.83776486706;5412.2152287918225;5415.214793854889;5373.81191658292;5381.408045115034;5384.6769193848295;5387;5395.865103372427;5373.946260537384;5382.4886635769735;5384.59615528833;5398.460153984609;5407.215953686713;5205.765740541685;5324.866878328034;5328.866778330534;5342.5993050521365;5343.278657381243;6188.81433556994;6219.222597175353;6222.284437289724;6223.222097237845;6260.530460215502;6474.7086381112495;6520.771772987922;6528;6550.901736473909;6571.539992200548;5376.516113549799;6405.48756099511;6503.057056726795;6521.0544471051435;6526.77156299532;5623.80316688918;6172.722227499773;6261.749530018839;6273.56085074045;6305.085762564402;6809.250982392032;6814.897776533356;6854.0404343391965;6855.5543889647015;6857.211420686585;6444;6449.903251451232;6466.644334561644;6497;6586.473082153416;6399.776007839703;6472.093906853044;6533.24867640218;6575.769848055295;6631.10480085192;6468.126802881645;6482.67586620667;6487.3836985486305;6500.284968653445;6514.511411644051;6517.57635753684;6524.836879078061;6544.247411547733;6547.934520654732;6554.737810487527;5092.312537807423;5208.8958220835375;5222.686638801684;5261;5293.179557168645;4650.953490465052;4680.204365257914;4687.343771871941;4702.200625893606;4752.334673145762;6274.9686251569365;6282.591631543935;6285.560010799291;6294.874102517924;6300.432961033529;6412.422881940648;6432.774852880127;6595.439387652007;6647.135872336566;6648.268690444047;6284.12022316876;6288.654124023131;6304.495640348761;6318.368163183645;6332.398422149889;5804.680742559115;5824;5826.242588463472;5829.94170058294;5852.122181672783;6655.500837437308;6712;6842.794716158523;6890.896636550356;6920.411765000032;6517.7067031984625;6610.3720146586;6611.735530578915;6630.403263706096;6638.435732962752;6835.897461537981;6842.1789385272095;6847.109875716125;6849.486288528281;6853.211880633791;6351.396617321347;6443.645599491885;6477.676116194078;6491.156149700509;6508.772192973223;6504.9674751625935;6545.901811472737;6579.374959378852;6647.5014373921185;6718.664066796739;6393.456556192776;6395.840103997251;6401.8719625608155;6402.263739669997;6409.038644203407;6155.692215389302;6331.9366806331345;6339.746410143727;6397;6447.194100737408;6336.398042185985;6346.365363463617;6352.428281454691;6353.52348573868;6354.90467642995;6254.8123556293385;6314.905276420949;6335.493160547053;6350.587211831216;6427.710753016032;6230;6234.812955611339;6247.781327653511;6259.530535209969;6269.341719119427 16:13:56 INFO - PID 2866 | |1;ext.html;762.7559181062059;791.8218400859807;800.6477150053978;1130.7173206698326;1147.323079383165;21693.891530542343;36819.26361472772;36978.63021369782;37143.62856371435;37203.627963720355;38557.807210963976;38826.8058659707;38881;38931.41602875959;39046.8047659762;6068.848278793022;8287.295579875718;8457.57712114395;8468.280196183332;8490.787730306762;6076.848078798022;8316.70891518797;8527.658893644248;8528.360372972053;8531.744047678549;8508.404411691185;8597.785055373635;8601;8609.741707748777;8659.95670021649;5996.940030599681;8498.787530311762;8557;8562.972443306811;8567.614457349435;5991.400859913973;6678.165229346332;7051.647417629098;8386.287165590933;8395.286400655952;37142;37253.44119838205;37278.627213727785;37389.62610373888;37862.62137378618;3549.3256281306726;3590.4434812604086;3593.6703419734604;3599.5140656011367;3600.4059330210484;30251.546226806615;30470.847645761853;30490.54264186039;30495.542566861513;30511.542326865114;3068.3096303331795;3112.3775244950875;3121.2040929563045;3153.1486498645236;3158.921026974321;279260;282677.99999999796;282828;283835;284158;49349.50650493521;49355.50644493581;49470.010599788526;49485;49490.50509494859;52207.47792522102;52246.73876630593;52254.73872630689;52268.47731522636;52367.73816130971;14170.220637865017;14226.28868556568;14231.288435578179;14252.928735356258;14253.216073115871;9997.150242229493;10049.346792458613;11562.710932226762;11564.826527602092;11574.47914843834;11076.39079850616;11191.496382662799;11197.72005699864;11207.439628018567;11214.775704486028;4473.3960915276675;5468.562514998791;5514.172874068921;5519.724013799374;5526.696031718214;915.688665853613;1013.8834034086027;1022.8619136416488;1025.9025392587691;1053.2469284461495;22413.43966400853;24625.753742462704;24654.630180547305;24662;24828.131015414372;1108.3682301088302;1110.1174566219875;1116.1461481966303;1148.9885101149048;1158.478684591937;10152.695419137437;12501.93749031249;12593.181443206162;12612.432440540199;12634.620961371174;286273;288294;288822;290207.54896225804;290575;53258.46741532535;53354;53452.93094138173;53563;53565;1466.288849907794;1509.1850400783453;1509.4037855047195;1521.186165401505;1537.3082113049172;28540.57189142206;29096.27259318534;29296.41407171802;29347;29472.852635736683;37481.87554373373;37491.250174996894;37495.62504374921;37553;37643.62356376401;235094;235308;235715;235950.82024590453;236146;32786.508202376506;33220.83389583133;34178.48732268968;34281.31437371189;34324.313513730085;35281.82359088291;35813.46279805753;36969.44545831761;44933;45126.87182820456;28334.149975500768;29734.959276425223;30269.091927242218;30562;30967;25714.457132572104;28427.289317766394;29895.55156672695;30506;30543;28570.714292856806;29203.561946570393;36684.082897927765;36720.81639591785;36758.44862327121;24388.756112439358;28826;30801.537976930813;31265.062048138592;31452.294187924104;19235.4229373119;23817.642735358637;24121.517569648156;24150;24740.752592474564 16:13:56 INFO - PID 2866 | |2;jquery.html;436.17562806296087;438.5570573720543;440.94929083155426;448.6029863570739;460.1487248590109;18715.4385368439;20486.487837804063;20932.16271349144;21161.57676846464;21193.894030529864;21326.786732132674;21627.3511794646;21754.3473695789;22028.669569956422;22942;6138.171346868183;6356.269029061671;6377.649229292387;6390.137331460263;6392.009238568029;6143.232095988002;6150.784722534712;6199.814005579818;6243.56295059346;6258.249010118792;6061.696915154247;6171.309606424105;6215.223097112861;6239.188905442286;6244.500439964814;6110.938890611082;6236.095766113888;6247.06294055893;6247.375262473762;6252.781152659635;4277.871663850089;4594.908101837945;5527.401237907563;5553.555715542747;5583.162525621189;22582;26617.27728538354;27359.589606155925;27458.62706864669;27724.02965896204;2187.245400336881;2224.132588290568;2253.346529506441;2260.9095636174534;2262.4457008032973;14256.215908125048;17190.968541887527;17254.051027193625;17989.820101799076;18044.639107217783;2124.7131637229086;2133.8826364549946;2154.849160558746;2166.8483206175415;2170.978290217109;149376;159898;162320;163436;164799;12180.451879665436;12234.143609947218;12376.195547289397;12451.128421010442;12683.302418367079;16576.75134872978;16577.254023568967;16581.08804015791;16607.50177494677;16614.25235864389;7919.812028195702;8471.407001509835;8602.827943441222;8917.242034427016;9068.909310906807;8401.915980840113;8434.367422443342;8473;8636.136386361439;8660.13398660129;6084.300305464928;7736.574488403079;7760.84478310442;7769.961150194213;7773.494722842997;2100.5693832764246;2118.4915620251027;2120.618288708047;2125.4048866317457;2291.049214575932;901.1619194149504;930.851063829784;958.5973890965811;959.6689142245914;960.490058085377;18491.81508184901;20970.580588388148;21035.579288414454;21092.05085771144;21108.577828443653;957.094562729907;970.6554173268529;983.1004630762772;988.5813857115063;988.9554970026367;8499.74500764978;10742.409167495864;10853.945730271298;10902.454877256265;11058.502367393487;545037;571752;572898.2522097375;573095;579195;130839;133755.98732038055;136124.7750449914;139982;142158;1149.0807354116673;1201.4893670190133;1218.975620487603;1242.9559170296993;1249.7125661097998;20636;20992.475188120417;21951.560968780854;22690.659640105743;23069.307920762403;59726.70136649463;59947.700261498416;59964.50088747816;60056.39943600508;60515.39484605098;52196.217056744936;76235;76466.2353376459;76985;80032.39854206458;12583;12757.681057973625;12881.033922455666;13162.47350105985;13211.339433028503;13971.301434928417;14000.859991400363;14140;14451.855481445471;14468.927655361656;10201.438920859424;11714.648560543197;11734.823977640513;11917;12129.757404851676;10986.450677465935;11151.72120696989;11152.609658661908;11504.079673626256;11535.250208736405;11828.881711182778;11837.644870653894;12038.277703337828;12147.331896745764;12176.878231217574;12704.174228675107;12728.809067863804;12982.415791289226;13018.2839943804;13186.472541098248;11287.589051368579;11688.006519445942;11788.823167652321;12082.39588020613;12135.150539462153 16:13:56 INFO - PID 2866 | |3;mootools.html;1200.5677955935855;1380.820493335866;1466.7066586682658;1490.7093116842216;1491.1351416178618;9745.805083898318;10219.335743176689;10219.591216351337;10224.795504089923;10225.437600931955;9956.452395118265;10794.946025269863;11440.370779607118;11517.42412879357;11535.884641153585;2453.0310527341735;2504.3238325652064;2506.1604362538574;2506.5738824399805;2508.912188073418;2429.210506585358;2525.090967251797;2528;2528.506941146477;2535.1760677779703;2036.704677821715;2124.3839286606867;2432.7080750309988;2529.84820910745;2530.329462692379;2507.7993760499116;2510.3975045988923;2544.033267358401;2544.4147845995526;2545.4909018196436;2406.278116565041;2414.9034038638433;2416.226807421626;2417.54066727323;2418.733939266679;11438.828417573659;11687.941560292229;11698.766024679458;11699.122565807598;11723.296602203895;6583.868322633569;6844.726210951556;6856.897146542806;6864.931350686479;6865.9313406865795;3924.3328634132267;4128.8348466061325;4223.852165174235;4285.250081235802;4293.205756934977;1208.4501551793912;1219.1465973818363;1235.5243231355903;1253.9498420063187;1256.0391300655006;16308.75536866948;16339.26473308704;16341.59146021347;16342.182890855409;16348.754768678598;5890.991357497955;5942.821715348547;5943.465088142088;5949.25634295713;6094.725737341831;13863.584092477242;13864.098833575987;13867.375968081258;13872.514461993782;13880.305984700724;6803.48973826965;6819.079424277758;6824.385805277549;6829.556078854858;6836.077129587442;5140.254663073833;5154.742262886915;6283.7800676976085;6293.842653933688;6299.370062993664;4490.955090449119;4633.884152896205;4665.813367465264;4724.338592597039;4725.621950243973;1432.2194404049817;1462.0642788615294;1463.780432935047;1484.1243666236971;1488.8585584369469;799.7161007842249;806.5725165662209;830.5681045856121;836.0761358698672;861.6725644255143;6510.544261901621;6761.763338283136;6943.479239057091;6987.371136597629;7004.929950700428;501.8343946497647;602.2050892821434;612.0513204532956;620.7299824576323;620.9844753881189;3591.06632275605;3597.568291804948;4077.7757223353;4162.729422587522;4624.14453326129;14853.257337133316;15276.541703748906;15278.31247593861;15299.770503442458;15321.23393830304;14646.707065858624;15132.697346053017;15172.165530895907;15175.696486070217;15179;8435.451695639764;8629.180227878342;8648.481091134552;8653.437526560754;8706.825863482694;6808.65956702153;6852.862942741217;6856.348646878539;7133.82165445868;7138.750143744944;12484.500619975099;13235.205887646773;13291.933540332237;13339.399727012114;13371.53199638008;9670.758231044;12919.741605168032;13170.539031133865;13525.72948541004;13591.932040339734;9731.464769437465;9768.07203315684;10475.895241047492;10713.14294856394;10770.676879693621;10824.079953204066;10999.450027498753;11009.284396514522;11009.669709908716;11016.50425730828;8778.209961103275;9107.863382049141;9164.266858651159;9188.632454701738;9229.815403691755;8885.555722213734;8934.374593778633;8943.552822358986;8993.550322483981;9015.143561361923;8176.4276500646765;8182.877256841033;8273.710420135267;8298.336133109216;8329.916700832913;5623.8594035149445;5916.230889984275;6028.577999540165;6141.723622436912;6175.289841668266;5953.3153687324775;5987.31145918225;6158.7990341882905;6170.784022559368;6299.464545513682 16:13:56 INFO - PID 2866 | |4;prototype.html;328.9769716119872;387.37632411816986;405.46276184056114;408.1449363583292;409.2919249698022;5175.456577059406;5682.602217844753;5939.970300148493;5950.9107363389585;5979.222701048863;5280.445553216915;5799.391063938278;5811.041178205602;5811.733423964647;5815.412141596991;3934.6852251819787;4162.583741625844;4475.634931345939;4527.275635898265;4587.42657167854;4560.2019646561885;4561.407017087774;4587.334836448713;4593.816247350119;4602.815887364502;4578.816847326103;4592.9665825189395;4597.126545956257;4607.792649330788;4611.608013318855;4192.622663960243;4321.0061685812125;4331.956680433187;4337.392765012901;4592.196365636;3097.272141046852;3729.440583912408;3731.8507259709577;3754.9812250938844;3760.9059773505883;5770.855728606818;5785.190073389729;5793.7392817323325;5811.738471768738;5817.243758311435;4277.379779931924;4830.85507434774;5037.773300201463;5120.667156634807;5155.974220128913;5617.578681598897;5860.549688789424;6293.339199384044;6294.905576416358;6312.400321969406;4213.91572168558;4235.745855248664;4236.258654735439;4241.7879106044575;4248.299030659938;5394.298741163663;6248.812535623939;6362.840928976812;6482.050666946481;6570.868582628368;3452.2750222453565;3631.019624701316;4234.259004674232;4281.314989601711;4286.8499602514385;4293.8711838644895;4333.241682705577;4356.411884395629;4366.170427618742;4369.847055353048;3976.76139431635;4268.9786551067045;4935.3595826232795;5055.7219352935945;5094.821681241213;6224.937750622526;6226.750929962841;6240.563160578716;6255.906161407583;6258.624482531062;1446.132320607627;1469.6987117641072;1473.9732867307453;1481.5999680086315;1483.9332230049674;783.710027289895;958.7651025498798;962.9759256018516;977.7973093095533;988.1768137785917;4773.307870358848;4883.8290659826735;5685.715714214355;5928.822135335947;5941.881162376728;6508.8047358579315;6524.151860258136;6585.979173228157;6587.868242635121;6588.341165883373;4952.910359720856;5087.97456012725;5151.295569825871;5474.850281440942;5826.679532625746;2772.334639686501;2805.438912217565;3308.8915213403297;3325.8525808595996;3394.4229480988292;6367.256393986417;6694.765683201162;6770.796876093725;6810.421114205348;6837.829054273683;5610.495055444948;6720;6725.2602213756445;6779.762708305186;6780.288069752605;5629.296337957755;6367.733618475632;6709.966450167718;6767.52627316093;6808.4212841908;6057;6464.773732919325;6523.31505191967;6525.314841941527;6569.671516424255;4991.051700176955;5539.362973258127;6085.648761135809;6426.100345951664;6435.22777266731;6258.775326654399;6743.898841517479;6761.695723692347;6764;6765.932340676531;4226.197022565826;4226.6618670506905;4233.830646774095;4236.978815106028;4254.1704367649245;5856.853578660568;6277.748890044347;6465.349206825179;6509.121268628864;6521.413072823469;5181.585473162213;6216.564840461125;6237.941479311726;6239.532035097477;6272.466840318624;5112.693238405707;5669;5946.316173640087;6237.438630523093;6259.96870015647;5360.839174824761;6130.325664176848;6135.417135372132;6148.754049837957;6170.753169873155;5921.526277897672;6243.719032643451;6248.12526246335;6267.717952692231;6274.435300822948;4822.397200349957;5775.364709881826;6116.938830611637;6117.663528505975;6141.355157708376 16:13:56 INFO - PID 2866 | |5;yui.html;846.9026062002871;865.2861389353783;868.9913100868994;872.6509396241503;885.663447889802;16137.515874523753;16295.674086518276;16727.414540491085;16729.414470493535;16770.07764572948;15555.222238888038;15570.688586228296;15665.216739163025;15744.606384840385;15768.684626307468;993.46849435552;993.5280741647732;995.6863587969802;996.1930836022808;998.645480854299;997.5909876950452;1001.8096561653299;1017.1964148322816;1027.4965267019145;1031.9071283584476;1072.8980746829077;1074.6346242277625;1078.0890147825075;1078.44460103047;1081.1188881061948;909.4088842252555;1008.5259927833943;1052.8736551613779;1068.1348108032519;1068.6259809066842;798.2097723253995;799.2606838674261;799.7880561651167;802.4342838299043;802.9116797152309;16294.918525407416;16463.34146634133;16672.58318542034;17078.402255921108;17315.740263895925;17409.390671326444;17454.56363590908;17553.912230438895;17766.91116544409;17913.7312940306;13933.79099313501;14189.290535473185;14287.57137285883;14513.419463221458;14526;3327.168207948013;3347.9497807532907;3530.117470632342;3561.5904171020406;3563.429851223792;85674;132210.3389483056;132291;136306.31846840703;136403;10996.23026388145;11315.15136364776;11534.423278836024;11545.595904143483;13540.796888046687;23870.761292386855;25082;25088.749112509005;25168.496630067297;25409.983600655767;7951.244631759973;8124.309433698084;8138.837223255502;8148.511089334659;8157.347412207009;3958.6833053355663;4023.094803669151;4032.1734044520804;4032.193561287754;4034.2133284009337;3779.281936432069;4368;4389.144116897174;4406.801693923781;4408.58118478744;913.5569248914271;949.050949050949;950.9966984830932;953.6280850468323;954.3033585482498;616.9568130230841;618.8514756458418;627.3914303125961;627.6547898655813;651.9576227545194;9524.047595240421;9685;10977.231593788518;11818.822717659243;11963.760724785456;634.6604566556962;660.5574265242299;671.4326394196896;684.0218487562832;684.2507454337492;4361.80371883266;5487.012337779158;5498.422665620053;5554.527865131509;5644.774209031592;108376;108708;109463;110722.33916491258;112709.43645281885;96914.51542742242;97973;99206.50396748114;100729.49635251777;100947.49526252468;87431;88319.11680883238;88401.67397489042;88810;90223;8540.359473039423;9166.724998250063;11039.558417663204;11398.316101033965;11482.827757583476;41857.372139417326;41964;42227;42605.934851628954;42617.57382426136;39845.2030959385;54035.189472157166;54270.45729542654;64834.35165648283;72726.27273727195;14178.645533861736;16616.58458538498;16897;17310.480685579452;17335.479935601954;18035.458936231935;18436.631267374847;18637.44087677372;18724.719129213347;18872;16529.173541322645;17155.142242887556;17224.82775172232;17228.138593070547;17310.22104005348;16663.66672666564;16842.66314673675;17280.22238999223;17345.56636084108;17492;15432.691346173238;15948;16010.519684409486;16039.438619648256;16253.67492650164;10024.348417352849;11121.776604573652;11184.217104802585;11265;11949.402529873645;10077.395356278646;12647.936760316139;12958.870411296144;12966.740665186831;13034.022448316224 16:13:56 INFO - PID 2866 | __end_tp_report 16:13:56 INFO - PID 2866 | __start_cc_report 16:13:56 INFO - PID 2866 | _x_x_mozilla_cycle_collect,1679 16:13:56 INFO - PID 2866 | __end_cc_report 16:13:56 INFO - PID 2866 | __startTimestamp1494371636456__endTimestamp 16:13:56 INFO - PID 2866 | 16:13:56 INFO - PID 2866 | ------- Summary: start ------- 16:13:56 INFO - PID 2866 | Number of tests: 6 16:13:56 INFO - PID 2866 | 16:13:56 INFO - PID 2866 | [#0] dojo.html Cycles:165 Average:6074.56 Median:6318.37 stddev:700.11 (11.1%) stddev-sans-first:672.58 16:13:56 INFO - PID 2866 | Values: 3503.5 3557.1 3575.1 3576.3 3600.5 6021.6 6124.5 6133.7 6178.8 6219.4 6085.3 6118.1 6124.1 6125.8 6144.7 5227.8 5269.0 5272.0 5277.4 5356.9 5387.1 5394.5 5407.8 5412.2 5415.2 5373.8 5381.4 5384.7 5387.0 5395.9 5373.9 5382.5 5384.6 5398.5 5407.2 5205.8 5324.9 5328.9 5342.6 5343.3 6188.8 6219.2 6222.3 6223.2 6260.5 6474.7 6520.8 6528.0 6550.9 6571.5 5376.5 6405.5 6503.1 6521.1 6526.8 5623.8 6172.7 6261.7 6273.6 6305.1 6809.3 6814.9 6854.0 6855.6 6857.2 6444.0 6449.9 6466.6 6497.0 6586.5 6399.8 6472.1 6533.2 6575.8 6631.1 6468.1 6482.7 6487.4 6500.3 6514.5 6517.6 6524.8 6544.2 6547.9 6554.7 5092.3 5208.9 5222.7 5261.0 5293.2 4651.0 4680.2 4687.3 4702.2 4752.3 6275.0 6282.6 6285.6 6294.9 6300.4 6412.4 6432.8 6595.4 6647.1 6648.3 6284.1 6288.7 6304.5 6318.4 6332.4 5804.7 5824.0 5826.2 5829.9 5852.1 6655.5 6712.0 6842.8 6890.9 6920.4 6517.7 6610.4 6611.7 6630.4 6638.4 6835.9 6842.2 6847.1 6849.5 6853.2 6351.4 6443.6 6477.7 6491.2 6508.8 6505.0 6545.9 6579.4 6647.5 6718.7 6393.5 6395.8 6401.9 6402.3 6409.0 6155.7 6331.9 6339.7 6397.0 6447.2 6336.4 6346.4 6352.4 6353.5 6354.9 6254.8 6314.9 6335.5 6350.6 6427.7 6230.0 6234.8 6247.8 6259.5 6269.3 16:13:56 INFO - PID 2866 | 16:13:56 INFO - PID 2866 | [#1] ext.html Cycles:180 Average:42143.63 Median:17302.72 stddev:70663.41 (408.4%) stddev-sans-first:70793.34 16:13:56 INFO - PID 2866 | Values: 762.8 791.8 800.6 1130.7 1147.3 21693.9 36819.3 36978.6 37143.6 37203.6 38557.8 38826.8 38881.0 38931.4 39046.8 6068.8 8287.3 8457.6 8468.3 8490.8 6076.8 8316.7 8527.7 8528.4 8531.7 8508.4 8597.8 8601.0 8609.7 8660.0 5996.9 8498.8 8557.0 8563.0 8567.6 5991.4 6678.2 7051.6 8386.3 8395.3 37142.0 37253.4 37278.6 37389.6 37862.6 3549.3 3590.4 3593.7 3599.5 3600.4 30251.5 30470.8 30490.5 30495.5 30511.5 3068.3 3112.4 3121.2 3153.1 3158.9 279260.0 282678.0 282828.0 283835.0 284158.0 49349.5 49355.5 49470.0 49485.0 49490.5 52207.5 52246.7 52254.7 52268.5 52367.7 14170.2 14226.3 14231.3 14252.9 14253.2 9997.2 10049.3 11562.7 11564.8 11574.5 11076.4 11191.5 11197.7 11207.4 11214.8 4473.4 5468.6 5514.2 5519.7 5526.7 915.7 1013.9 1022.9 1025.9 1053.2 22413.4 24625.8 24654.6 24662.0 24828.1 1108.4 1110.1 1116.1 1149.0 1158.5 10152.7 12501.9 12593.2 12612.4 12634.6 286273.0 288294.0 288822.0 290207.5 290575.0 53258.5 53354.0 53452.9 53563.0 53565.0 1466.3 1509.2 1509.4 1521.2 1537.3 28540.6 29096.3 29296.4 29347.0 29472.9 37481.9 37491.3 37495.6 37553.0 37643.6 235094.0 235308.0 235715.0 235950.8 236146.0 32786.5 33220.8 34178.5 34281.3 34324.3 35281.8 35813.5 36969.4 44933.0 45126.9 28334.1 29735.0 30269.1 30562.0 30967.0 25714.5 28427.3 29895.6 30506.0 30543.0 28570.7 29203.6 36684.1 36720.8 36758.4 24388.8 28826.0 30801.5 31265.1 31452.3 19235.4 23817.6 24121.5 24150.0 24740.8 16:13:56 INFO - PID 2866 | 16:13:56 INFO - PID 2866 | [#2] jquery.html Cycles:180 Average:36562.27 Median:2168.91 stddev:96465.43 (4447.6%) stddev-sans-first:96697.90 16:13:56 INFO - PID 2866 | Values: 436.2 438.6 440.9 448.6 460.1 18715.4 20486.5 20932.2 21161.6 21193.9 21326.8 21627.4 21754.3 22028.7 22942.0 6138.2 6356.3 6377.6 6390.1 6392.0 6143.2 6150.8 6199.8 6243.6 6258.2 6061.7 6171.3 6215.2 6239.2 6244.5 6110.9 6236.1 6247.1 6247.4 6252.8 4277.9 4594.9 5527.4 5553.6 5583.2 22582.0 26617.3 27359.6 27458.6 27724.0 2187.2 2224.1 2253.3 2260.9 2262.4 14256.2 17191.0 17254.1 17989.8 18044.6 2124.7 2133.9 2154.8 2166.8 2171.0 149376.0 159898.0 162320.0 163436.0 164799.0 12180.5 12234.1 12376.2 12451.1 12683.3 16576.8 16577.3 16581.1 16607.5 16614.3 7919.8 8471.4 8602.8 8917.2 9068.9 8401.9 8434.4 8473.0 8636.1 8660.1 6084.3 7736.6 7760.8 7770.0 7773.5 2100.6 2118.5 2120.6 2125.4 2291.0 901.2 930.9 958.6 959.7 960.5 18491.8 20970.6 21035.6 21092.1 21108.6 957.1 970.7 983.1 988.6 989.0 8499.7 10742.4 10853.9 10902.5 11058.5 545037.0 571752.0 572898.3 573095.0 579195.0 130839.0 133756.0 136124.8 139982.0 142158.0 1149.1 1201.5 1219.0 1243.0 1249.7 20636.0 20992.5 21951.6 22690.7 23069.3 59726.7 59947.7 59964.5 60056.4 60515.4 52196.2 76235.0 76466.2 76985.0 80032.4 12583.0 12757.7 12881.0 13162.5 13211.3 13971.3 14000.9 14140.0 14451.9 14468.9 10201.4 11714.6 11734.8 11917.0 12129.8 10986.5 11151.7 11152.6 11504.1 11535.3 11828.9 11837.6 12038.3 12147.3 12176.9 12704.2 12728.8 12982.4 13018.3 13186.5 11287.6 11688.0 11788.8 12082.4 12135.2 16:13:56 INFO - PID 2866 | 16:13:56 INFO - PID 2866 | [#3] mootools.html Cycles:180 Average:7143.02 Median:3594.32 stddev:4514.69 (125.6%) stddev-sans-first:4505.27 16:13:56 INFO - PID 2866 | Values: 1200.6 1380.8 1466.7 1490.7 1491.1 9745.8 10219.3 10219.6 10224.8 10225.4 9956.5 10794.9 11440.4 11517.4 11535.9 2453.0 2504.3 2506.2 2506.6 2508.9 2429.2 2525.1 2528.0 2528.5 2535.2 2036.7 2124.4 2432.7 2529.8 2530.3 2507.8 2510.4 2544.0 2544.4 2545.5 2406.3 2414.9 2416.2 2417.5 2418.7 11438.8 11687.9 11698.8 11699.1 11723.3 6583.9 6844.7 6856.9 6864.9 6865.9 3924.3 4128.8 4223.9 4285.3 4293.2 1208.5 1219.1 1235.5 1253.9 1256.0 16308.8 16339.3 16341.6 16342.2 16348.8 5891.0 5942.8 5943.5 5949.3 6094.7 13863.6 13864.1 13867.4 13872.5 13880.3 6803.5 6819.1 6824.4 6829.6 6836.1 5140.3 5154.7 6283.8 6293.8 6299.4 4491.0 4633.9 4665.8 4724.3 4725.6 1432.2 1462.1 1463.8 1484.1 1488.9 799.7 806.6 830.6 836.1 861.7 6510.5 6761.8 6943.5 6987.4 7004.9 501.8 602.2 612.1 620.7 621.0 3591.1 3597.6 4077.8 4162.7 4624.1 14853.3 15276.5 15278.3 15299.8 15321.2 14646.7 15132.7 15172.2 15175.7 15179.0 8435.5 8629.2 8648.5 8653.4 8706.8 6808.7 6852.9 6856.3 7133.8 7138.8 12484.5 13235.2 13291.9 13339.4 13371.5 9670.8 12919.7 13170.5 13525.7 13591.9 9731.5 9768.1 10475.9 10713.1 10770.7 10824.1 10999.5 11009.3 11009.7 11016.5 8778.2 9107.9 9164.3 9188.6 9229.8 8885.6 8934.4 8943.6 8993.6 9015.1 8176.4 8182.9 8273.7 8298.3 8329.9 5623.9 5916.2 6028.6 6141.7 6175.3 5953.3 5987.3 6158.8 6170.8 6299.5 16:13:56 INFO - PID 2866 | 16:13:56 INFO - PID 2866 | [#4] prototype.html Cycles:180 Average:5045.89 Median:5728.29 stddev:1591.51 (27.8%) stddev-sans-first:1556.10 16:13:56 INFO - PID 2866 | Values: 329.0 387.4 405.5 408.1 409.3 5175.5 5682.6 5940.0 5950.9 5979.2 5280.4 5799.4 5811.0 5811.7 5815.4 3934.7 4162.6 4475.6 4527.3 4587.4 4560.2 4561.4 4587.3 4593.8 4602.8 4578.8 4593.0 4597.1 4607.8 4611.6 4192.6 4321.0 4332.0 4337.4 4592.2 3097.3 3729.4 3731.9 3755.0 3760.9 5770.9 5785.2 5793.7 5811.7 5817.2 4277.4 4830.9 5037.8 5120.7 5156.0 5617.6 5860.5 6293.3 6294.9 6312.4 4213.9 4235.7 4236.3 4241.8 4248.3 5394.3 6248.8 6362.8 6482.1 6570.9 3452.3 3631.0 4234.3 4281.3 4286.8 4293.9 4333.2 4356.4 4366.2 4369.8 3976.8 4269.0 4935.4 5055.7 5094.8 6224.9 6226.8 6240.6 6255.9 6258.6 1446.1 1469.7 1474.0 1481.6 1483.9 783.7 958.8 963.0 977.8 988.2 4773.3 4883.8 5685.7 5928.8 5941.9 6508.8 6524.2 6586.0 6587.9 6588.3 4952.9 5088.0 5151.3 5474.9 5826.7 2772.3 2805.4 3308.9 3325.9 3394.4 6367.3 6694.8 6770.8 6810.4 6837.8 5610.5 6720.0 6725.3 6779.8 6780.3 5629.3 6367.7 6710.0 6767.5 6808.4 6057.0 6464.8 6523.3 6525.3 6569.7 4991.1 5539.4 6085.6 6426.1 6435.2 6258.8 6743.9 6761.7 6764.0 6765.9 4226.2 4226.7 4233.8 4237.0 4254.2 5856.9 6277.7 6465.3 6509.1 6521.4 5181.6 6216.6 6237.9 6239.5 6272.5 5112.7 5669.0 5946.3 6237.4 6260.0 5360.8 6130.3 6135.4 6148.8 6170.8 5921.5 6243.7 6248.1 6267.7 6274.4 4822.4 5775.4 6116.9 6117.7 6141.4 16:13:56 INFO - PID 2866 | 16:13:56 INFO - PID 2866 | [#5] yui.html Cycles:180 Average:22284.65 Median:18236.05 stddev:32223.69 (176.7%) stddev-sans-first:32273.88 16:13:56 INFO - PID 2866 | Values: 846.9 865.3 869.0 872.7 885.7 16137.5 16295.7 16727.4 16729.4 16770.1 15555.2 15570.7 15665.2 15744.6 15768.7 993.5 993.5 995.7 996.2 998.6 997.6 1001.8 1017.2 1027.5 1031.9 1072.9 1074.6 1078.1 1078.4 1081.1 909.4 1008.5 1052.9 1068.1 1068.6 798.2 799.3 799.8 802.4 802.9 16294.9 16463.3 16672.6 17078.4 17315.7 17409.4 17454.6 17553.9 17766.9 17913.7 13933.8 14189.3 14287.6 14513.4 14526.0 3327.2 3347.9 3530.1 3561.6 3563.4 85674.0 132210.3 132291.0 136306.3 136403.0 10996.2 11315.2 11534.4 11545.6 13540.8 23870.8 25082.0 25088.7 25168.5 25410.0 7951.2 8124.3 8138.8 8148.5 8157.3 3958.7 4023.1 4032.2 4032.2 4034.2 3779.3 4368.0 4389.1 4406.8 4408.6 913.6 949.1 951.0 953.6 954.3 617.0 618.9 627.4 627.7 652.0 9524.0 9685.0 10977.2 11818.8 11963.8 634.7 660.6 671.4 684.0 684.3 4361.8 5487.0 5498.4 5554.5 5644.8 108376.0 108708.0 109463.0 110722.3 112709.4 96914.5 97973.0 99206.5 100729.5 100947.5 87431.0 88319.1 88401.7 88810.0 90223.0 8540.4 9166.7 11039.6 11398.3 11482.8 41857.4 41964.0 42227.0 42605.9 42617.6 39845.2 54035.2 54270.5 64834.4 72726.3 14178.6 16616.6 16897.0 17310.5 17335.5 18035.5 18436.6 18637.4 18724.7 18872.0 16529.2 17155.1 17224.8 17228.1 17310.2 16663.7 16842.7 17280.2 17345.6 17492.0 15432.7 15948.0 16010.5 16039.4 16253.7 10024.3 11121.8 11184.2 11265.0 11949.4 10077.4 12647.9 12958.9 12966.7 13034.0 16:13:56 INFO - PID 2866 | -------- Summary: end -------- 16:13:56 INFO - PID 2866 | 16:13:57 INFO - TEST-INFO | 2866: exit 0 16:13:57 INFO - TEST-OK | dromaeo_css | took 1118837ms 16:13:57 INFO - TEST-START | kraken 16:13:57 INFO - operating with platform_type : mac_ 16:13:57 INFO - Initialising browser for kraken test... 16:13:57 INFO - TEST-INFO | started process 2981 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/tmpDfVcqq/profile http://localhost:57179/getInfo.html) 16:13:59 INFO - PID 2981 | __metrics Screen width/height:1600/1200 16:13:59 INFO - PID 2981 | colorDepth:24 16:13:59 INFO - PID 2981 | Browser inner width/height: 1024/691 16:13:59 INFO - PID 2981 | __metrics 16:13:59 INFO - PID 2981 | 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" 16:13:59 INFO - PID 2981 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:14:00 INFO - TEST-INFO | 2981: exit 0 16:14:00 INFO - Browser initialized. 16:14:00 INFO - Running cycle 1/1 for kraken test... 16:14:00 INFO - TEST-INFO | started process 2982 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/tmpDfVcqq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:14:12 INFO - PID 2982 | RSS: Main: 233582592 16:14:12 INFO - PID 2982 | 16:14:14 INFO - PID 2982 | Cycle 1(1): loaded http://localhost:57179/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57179/tests/kraken/driver.html?testName=audio-beat-detection) 16:14:15 INFO - PID 2982 | RSS: Main: 304230400 16:14:15 INFO - PID 2982 | 16:14:18 INFO - PID 2982 | Cycle 1(1): loaded http://localhost:57179/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57179/tests/kraken/driver.html?testName=audio-dft) 16:14:19 INFO - PID 2982 | RSS: Main: 286191616 16:14:19 INFO - PID 2982 | 16:14:22 INFO - PID 2982 | Cycle 1(1): loaded http://localhost:57179/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57179/tests/kraken/driver.html?testName=audio-fft) 16:14:22 INFO - PID 2982 | RSS: Main: 377274368 16:14:22 INFO - PID 2982 | 16:14:24 INFO - PID 2982 | Cycle 1(1): loaded http://localhost:57179/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57179/tests/kraken/driver.html?testName=audio-oscillator) 16:14:25 INFO - PID 2982 | RSS: Main: 279449600 16:14:25 INFO - PID 2982 | 16:14:27 INFO - PID 2982 | Cycle 1(1): loaded http://localhost:57179/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57179/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:14:28 INFO - PID 2982 | RSS: Main: 282357760 16:14:28 INFO - PID 2982 | 16:14:31 INFO - PID 2982 | Cycle 1(1): loaded http://localhost:57179/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57179/tests/kraken/driver.html?testName=imaging-darkroom) 16:14:31 INFO - PID 2982 | RSS: Main: 346361856 16:14:31 INFO - PID 2982 | 16:14:34 INFO - PID 2982 | Cycle 1(1): loaded http://localhost:57179/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57179/tests/kraken/driver.html?testName=imaging-desaturate) 16:14:35 INFO - PID 2982 | RSS: Main: 361713664 16:14:35 INFO - PID 2982 | 16:14:38 INFO - PID 2982 | Cycle 1(1): loaded http://localhost:57179/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57179/tests/kraken/driver.html?testName=json-parse-financial) 16:14:38 INFO - PID 2982 | RSS: Main: 368549888 16:14:38 INFO - PID 2982 | 16:14:40 INFO - PID 2982 | Cycle 1(1): loaded http://localhost:57179/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57179/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:14:40 INFO - PID 2982 | RSS: Main: 323432448 16:14:40 INFO - PID 2982 | 16:14:42 INFO - PID 2982 | Cycle 1(1): loaded http://localhost:57179/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57179/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:14:43 INFO - PID 2982 | RSS: Main: 323760128 16:14:43 INFO - PID 2982 | 16:14:45 INFO - PID 2982 | Cycle 1(1): loaded http://localhost:57179/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57179/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:14:46 INFO - PID 2982 | RSS: Main: 325918720 16:14:46 INFO - PID 2982 | 16:14:48 INFO - PID 2982 | Cycle 1(1): loaded http://localhost:57179/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57179/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:14:49 INFO - PID 2982 | RSS: Main: 348364800 16:14:49 INFO - PID 2982 | 16:14:52 INFO - PID 2982 | Cycle 1(1): loaded http://localhost:57179/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57179/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:14:53 INFO - PID 2982 | RSS: Main: 341069824 16:14:53 INFO - PID 2982 | 16:14:55 INFO - PID 2982 | Cycle 1(1): loaded http://localhost:57179/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57179/tests/kraken/driver.html?testName=ai-astar) 16:14:55 INFO - PID 2982 | RSS: Main: 383725568 16:14:55 INFO - PID 2982 | 16:14:55 INFO - PID 2982 | __start_tp_report 16:14:55 INFO - PID 2982 | _x_x_mozilla_page_load 16:14:55 INFO - PID 2982 | _x_x_mozilla_page_load_details 16:14:55 INFO - PID 2982 | |i|pagename|runs| 16:14:55 INFO - PID 2982 | |0;ai-astar;111;109;110;111;111;111;113;111;109;112 16:14:55 INFO - PID 2982 | |1;audio-beat-detection;147;109;109;151;110;109;107;108;137;107 16:14:55 INFO - PID 2982 | |2;audio-dft;186;185;183;183;185;184;186;186;187;180 16:14:55 INFO - PID 2982 | |3;audio-fft;84;58;58;90;65;62;59;58;81;57 16:14:55 INFO - PID 2982 | |4;audio-oscillator;90;71;103;103;103;68;88;69;69;87 16:14:55 INFO - PID 2982 | |5;imaging-gaussian-blur;86;86;86;85;86;86;86;86;87;86 16:14:55 INFO - PID 2982 | |6;imaging-darkroom;94;94;94;103;118;94;97;94;95;103 16:14:55 INFO - PID 2982 | |7;imaging-desaturate;85;85;84;86;84;84;85;86;90;87 16:14:55 INFO - PID 2982 | |8;json-parse-financial;48;47;47;46;49;48;48;49;47;47 16:14:55 INFO - PID 2982 | |9;json-stringify-tinderbox;54;57;62;54;65;58;57;59;58;57 16:14:55 INFO - PID 2982 | |10;stanford-crypto-aes;86;97;109;105;80;82;81;81;82;80 16:14:55 INFO - PID 2982 | |11;stanford-crypto-ccm;136;134;133;133;134;134;138;135;175;153 16:14:55 INFO - PID 2982 | |12;stanford-crypto-pbkdf2;211;235;192;186;234;205;184;182;189;180 16:14:55 INFO - PID 2982 | |13;stanford-crypto-sha256-iterative;64;66;62;67;69;67;67;68;67;68 16:14:55 INFO - PID 2982 | __end_tp_report 16:14:55 INFO - PID 2982 | __start_cc_report 16:14:55 INFO - PID 2982 | _x_x_mozilla_cycle_collect,2181 16:14:55 INFO - PID 2982 | __end_cc_report 16:14:55 INFO - PID 2982 | __startTimestamp1494371695429__endTimestamp 16:14:55 INFO - PID 2982 | 16:14:55 INFO - PID 2982 | ------- Summary: start ------- 16:14:55 INFO - PID 2982 | Number of tests: 14 16:14:55 INFO - PID 2982 | 16:14:55 INFO - PID 2982 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:1.23 (1.1%) stddev-sans-first:1.30 16:14:55 INFO - PID 2982 | Values: 111.0 109.0 110.0 111.0 111.0 111.0 113.0 111.0 109.0 112.0 16:14:55 INFO - PID 2982 | 16:14:55 INFO - PID 2982 | [#1] audio-beat-detection Cycles:10 Average:119.40 Median:109.50 stddev:18.01 (16.5%) stddev-sans-first:16.10 16:14:55 INFO - PID 2982 | Values: 147.0 109.0 109.0 151.0 110.0 109.0 107.0 108.0 137.0 107.0 16:14:55 INFO - PID 2982 | 16:14:55 INFO - PID 2982 | [#2] audio-dft Cycles:10 Average:184.50 Median:185.50 stddev:2.07 (1.1%) stddev-sans-first:2.12 16:14:55 INFO - PID 2982 | Values: 186.0 185.0 183.0 183.0 185.0 184.0 186.0 186.0 187.0 180.0 16:14:55 INFO - PID 2982 | 16:14:55 INFO - PID 2982 | [#3] audio-fft Cycles:10 Average:67.20 Median:63.50 stddev:12.69 (20.0%) stddev-sans-first:11.92 16:14:55 INFO - PID 2982 | Values: 84.0 58.0 58.0 90.0 65.0 62.0 59.0 58.0 81.0 57.0 16:14:55 INFO - PID 2982 | 16:14:55 INFO - PID 2982 | [#4] audio-oscillator Cycles:10 Average:85.10 Median:70.00 stddev:14.93 (21.3%) stddev-sans-first:15.73 16:14:55 INFO - PID 2982 | Values: 90.0 71.0 103.0 103.0 103.0 68.0 88.0 69.0 69.0 87.0 16:14:55 INFO - PID 2982 | 16:14:55 INFO - PID 2982 | [#5] imaging-gaussian-blur Cycles:10 Average:86.00 Median:86.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 16:14:55 INFO - PID 2982 | Values: 86.0 86.0 86.0 85.0 86.0 86.0 86.0 86.0 87.0 86.0 16:14:55 INFO - PID 2982 | 16:14:55 INFO - PID 2982 | [#6] imaging-darkroom Cycles:10 Average:98.60 Median:94.00 stddev:7.72 (8.2%) stddev-sans-first:8.01 16:14:55 INFO - PID 2982 | Values: 94.0 94.0 94.0 103.0 118.0 94.0 97.0 94.0 95.0 103.0 16:14:55 INFO - PID 2982 | 16:14:55 INFO - PID 2982 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:85.50 stddev:1.84 (2.1%) stddev-sans-first:1.94 16:14:55 INFO - PID 2982 | Values: 85.0 85.0 84.0 86.0 84.0 84.0 85.0 86.0 90.0 87.0 16:14:55 INFO - PID 2982 | 16:14:55 INFO - PID 2982 | [#8] json-parse-financial Cycles:10 Average:47.60 Median:48.00 stddev:0.97 (2.0%) stddev-sans-first:1.01 16:14:55 INFO - PID 2982 | Values: 48.0 47.0 47.0 46.0 49.0 48.0 48.0 49.0 47.0 47.0 16:14:55 INFO - PID 2982 | 16:14:55 INFO - PID 2982 | [#9] json-stringify-tinderbox Cycles:10 Average:58.10 Median:58.00 stddev:3.35 (5.8%) stddev-sans-first:3.21 16:14:55 INFO - PID 2982 | Values: 54.0 57.0 62.0 54.0 65.0 58.0 57.0 59.0 58.0 57.0 16:14:55 INFO - PID 2982 | 16:14:55 INFO - PID 2982 | [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:81.50 stddev:11.12 (13.6%) stddev-sans-first:11.76 16:14:55 INFO - PID 2982 | Values: 86.0 97.0 109.0 105.0 80.0 82.0 81.0 81.0 82.0 80.0 16:14:55 INFO - PID 2982 | 16:14:55 INFO - PID 2982 | [#11] stanford-crypto-ccm Cycles:10 Average:140.50 Median:135.50 stddev:13.51 (10.0%) stddev-sans-first:14.23 16:14:55 INFO - PID 2982 | Values: 136.0 134.0 133.0 133.0 134.0 134.0 138.0 135.0 175.0 153.0 16:14:55 INFO - PID 2982 | 16:14:55 INFO - PID 2982 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:199.80 Median:198.50 stddev:20.78 (10.5%) stddev-sans-first:21.65 16:14:55 INFO - PID 2982 | Values: 211.0 235.0 192.0 186.0 234.0 205.0 184.0 182.0 189.0 180.0 16:14:55 INFO - PID 2982 | 16:14:55 INFO - PID 2982 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:2.07 (3.1%) stddev-sans-first:1.99 16:14:55 INFO - PID 2982 | Values: 64.0 66.0 62.0 67.0 69.0 67.0 67.0 68.0 67.0 68.0 16:14:55 INFO - PID 2982 | -------- Summary: end -------- 16:14:55 INFO - PID 2982 | 16:14:56 INFO - TEST-INFO | 2982: exit 0 16:14:56 INFO - TEST-OK | kraken | took 59239ms 16:14:56 INFO - SUITE-END | took 1178s 16:14:56 INFO - Completed test suite (00:19:38) 16:14:56 INFO - javascript benchmark 16:14:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7782.447576098745, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3503.527023851781, 3557.07516045828, 3575.0883524701203, 3576.3026209889067, 3600.45993101035, 6021.578489505725, 6124.543000308823, 6133.6626485543275, 6178.845528861781, 6219.3780621937785, 6085.269767627879, 6118.082287656854, 6124.112003759452, 6125.81622551323, 6144.692765361737, 5227.817026404076, 5268.998890210867, 5271.973640131794, 5277.366715994086, 5356.91964620531, 5387.138057910735, 5394.541463975547, 5407.83776486706, 5412.2152287918225, 5415.214793854889, 5373.81191658292, 5381.408045115034, 5384.6769193848295, 5387.0, 5395.865103372427, 5373.946260537384, 5382.4886635769735, 5384.59615528833, 5398.460153984609, 5407.215953686713, 5205.765740541685, 5324.866878328034, 5328.866778330534, 5342.5993050521365, 5343.278657381243, 6188.81433556994, 6219.222597175353, 6222.284437289724, 6223.222097237845, 6260.530460215502, 6474.7086381112495, 6520.771772987922, 6528.0, 6550.901736473909, 6571.539992200548, 5376.516113549799, 6405.48756099511, 6503.057056726795, 6521.0544471051435, 6526.77156299532, 5623.80316688918, 6172.722227499773, 6261.749530018839, 6273.56085074045, 6305.085762564402, 6809.250982392032, 6814.897776533356, 6854.0404343391965, 6855.5543889647015, 6857.211420686585, 6444.0, 6449.903251451232, 6466.644334561644, 6497.0, 6586.473082153416, 6399.776007839703, 6472.093906853044, 6533.24867640218, 6575.769848055295, 6631.10480085192, 6468.126802881645, 6482.67586620667, 6487.3836985486305, 6500.284968653445, 6514.511411644051, 6517.57635753684, 6524.836879078061, 6544.247411547733, 6547.934520654732, 6554.737810487527, 5092.312537807423, 5208.8958220835375, 5222.686638801684, 5261.0, 5293.179557168645, 4650.953490465052, 4680.204365257914, 4687.343771871941, 4702.200625893606, 4752.334673145762, 6274.9686251569365, 6282.591631543935, 6285.560010799291, 6294.874102517924, 6300.432961033529, 6412.422881940648, 6432.774852880127, 6595.439387652007, 6647.135872336566, 6648.268690444047, 6284.12022316876, 6288.654124023131, 6304.495640348761, 6318.368163183645, 6332.398422149889, 5804.680742559115, 5824.0, 5826.242588463472, 5829.94170058294, 5852.122181672783, 6655.500837437308, 6712.0, 6842.794716158523, 6890.896636550356, 6920.411765000032, 6517.7067031984625, 6610.3720146586, 6611.735530578915, 6630.403263706096, 6638.435732962752, 6835.897461537981, 6842.1789385272095, 6847.109875716125, 6849.486288528281, 6853.211880633791, 6351.396617321347, 6443.645599491885, 6477.676116194078, 6491.156149700509, 6508.772192973223, 6504.9674751625935, 6545.901811472737, 6579.374959378852, 6647.5014373921185, 6718.664066796739, 6393.456556192776, 6395.840103997251, 6401.8719625608155, 6402.263739669997, 6409.038644203407, 6155.692215389302, 6331.9366806331345, 6339.746410143727, 6397.0, 6447.194100737408, 6336.398042185985, 6346.365363463617, 6352.428281454691, 6353.52348573868, 6354.90467642995, 6254.8123556293385, 6314.905276420949, 6335.493160547053, 6350.587211831216, 6427.710753016032, 6230.0, 6234.812955611339, 6247.781327653511, 6259.530535209969, 6269.341719119427], "value": 6028.071676873243, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [762.7559181062059, 791.8218400859807, 800.6477150053978, 1130.7173206698326, 1147.323079383165, 21693.891530542343, 36819.26361472772, 36978.63021369782, 37143.62856371435, 37203.627963720355, 38557.807210963976, 38826.8058659707, 38881.0, 38931.41602875959, 39046.8047659762, 6068.848278793022, 8287.295579875718, 8457.57712114395, 8468.280196183332, 8490.787730306762, 6076.848078798022, 8316.70891518797, 8527.658893644248, 8528.360372972053, 8531.744047678549, 8508.404411691185, 8597.785055373635, 8601.0, 8609.741707748777, 8659.95670021649, 5996.940030599681, 8498.787530311762, 8557.0, 8562.972443306811, 8567.614457349435, 5991.400859913973, 6678.165229346332, 7051.647417629098, 8386.287165590933, 8395.286400655952, 37142.0, 37253.44119838205, 37278.627213727785, 37389.62610373888, 37862.62137378618, 3549.3256281306726, 3590.4434812604086, 3593.6703419734604, 3599.5140656011367, 3600.4059330210484, 30251.546226806615, 30470.847645761853, 30490.54264186039, 30495.542566861513, 30511.542326865114, 3068.3096303331795, 3112.3775244950875, 3121.2040929563045, 3153.1486498645236, 3158.921026974321, 279260.0, 282677.99999999796, 282828.0, 283835.0, 284158.0, 49349.50650493521, 49355.50644493581, 49470.010599788526, 49485.0, 49490.50509494859, 52207.47792522102, 52246.73876630593, 52254.73872630689, 52268.47731522636, 52367.73816130971, 14170.220637865017, 14226.28868556568, 14231.288435578179, 14252.928735356258, 14253.216073115871, 9997.150242229493, 10049.346792458613, 11562.710932226762, 11564.826527602092, 11574.47914843834, 11076.39079850616, 11191.496382662799, 11197.72005699864, 11207.439628018567, 11214.775704486028, 4473.3960915276675, 5468.562514998791, 5514.172874068921, 5519.724013799374, 5526.696031718214, 915.688665853613, 1013.8834034086027, 1022.8619136416488, 1025.9025392587691, 1053.2469284461495, 22413.43966400853, 24625.753742462704, 24654.630180547305, 24662.0, 24828.131015414372, 1108.3682301088302, 1110.1174566219875, 1116.1461481966303, 1148.9885101149048, 1158.478684591937, 10152.695419137437, 12501.93749031249, 12593.181443206162, 12612.432440540199, 12634.620961371174, 286273.0, 288294.0, 288822.0, 290207.54896225804, 290575.0, 53258.46741532535, 53354.0, 53452.93094138173, 53563.0, 53565.0, 1466.288849907794, 1509.1850400783453, 1509.4037855047195, 1521.186165401505, 1537.3082113049172, 28540.57189142206, 29096.27259318534, 29296.41407171802, 29347.0, 29472.852635736683, 37481.87554373373, 37491.250174996894, 37495.62504374921, 37553.0, 37643.62356376401, 235094.0, 235308.0, 235715.0, 235950.82024590453, 236146.0, 32786.508202376506, 33220.83389583133, 34178.48732268968, 34281.31437371189, 34324.313513730085, 35281.82359088291, 35813.46279805753, 36969.44545831761, 44933.0, 45126.87182820456, 28334.149975500768, 29734.959276425223, 30269.091927242218, 30562.0, 30967.0, 25714.457132572104, 28427.289317766394, 29895.55156672695, 30506.0, 30543.0, 28570.714292856806, 29203.561946570393, 36684.082897927765, 36720.81639591785, 36758.44862327121, 24388.756112439358, 28826.0, 30801.537976930813, 31265.062048138592, 31452.294187924104, 19235.4229373119, 23817.642735358637, 24121.517569648156, 24150.0, 24740.752592474564], "value": 16955.518143881727, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [436.17562806296087, 438.5570573720543, 440.94929083155426, 448.6029863570739, 460.1487248590109, 18715.4385368439, 20486.487837804063, 20932.16271349144, 21161.57676846464, 21193.894030529864, 21326.786732132674, 21627.3511794646, 21754.3473695789, 22028.669569956422, 22942.0, 6138.171346868183, 6356.269029061671, 6377.649229292387, 6390.137331460263, 6392.009238568029, 6143.232095988002, 6150.784722534712, 6199.814005579818, 6243.56295059346, 6258.249010118792, 6061.696915154247, 6171.309606424105, 6215.223097112861, 6239.188905442286, 6244.500439964814, 6110.938890611082, 6236.095766113888, 6247.06294055893, 6247.375262473762, 6252.781152659635, 4277.871663850089, 4594.908101837945, 5527.401237907563, 5553.555715542747, 5583.162525621189, 22582.0, 26617.27728538354, 27359.589606155925, 27458.62706864669, 27724.02965896204, 2187.245400336881, 2224.132588290568, 2253.346529506441, 2260.9095636174534, 2262.4457008032973, 14256.215908125048, 17190.968541887527, 17254.051027193625, 17989.820101799076, 18044.639107217783, 2124.7131637229086, 2133.8826364549946, 2154.849160558746, 2166.8483206175415, 2170.978290217109, 149376.0, 159898.0, 162320.0, 163436.0, 164799.0, 12180.451879665436, 12234.143609947218, 12376.195547289397, 12451.128421010442, 12683.302418367079, 16576.75134872978, 16577.254023568967, 16581.08804015791, 16607.50177494677, 16614.25235864389, 7919.812028195702, 8471.407001509835, 8602.827943441222, 8917.242034427016, 9068.909310906807, 8401.915980840113, 8434.367422443342, 8473.0, 8636.136386361439, 8660.13398660129, 6084.300305464928, 7736.574488403079, 7760.84478310442, 7769.961150194213, 7773.494722842997, 2100.5693832764246, 2118.4915620251027, 2120.618288708047, 2125.4048866317457, 2291.049214575932, 901.1619194149504, 930.851063829784, 958.5973890965811, 959.6689142245914, 960.490058085377, 18491.81508184901, 20970.580588388148, 21035.579288414454, 21092.05085771144, 21108.577828443653, 957.094562729907, 970.6554173268529, 983.1004630762772, 988.5813857115063, 988.9554970026367, 8499.74500764978, 10742.409167495864, 10853.945730271298, 10902.454877256265, 11058.502367393487, 545037.0, 571752.0, 572898.2522097375, 573095.0, 579195.0, 130839.0, 133755.98732038055, 136124.7750449914, 139982.0, 142158.0, 1149.0807354116673, 1201.4893670190133, 1218.975620487603, 1242.9559170296993, 1249.7125661097998, 20636.0, 20992.475188120417, 21951.560968780854, 22690.659640105743, 23069.307920762403, 59726.70136649463, 59947.700261498416, 59964.50088747816, 60056.39943600508, 60515.39484605098, 52196.217056744936, 76235.0, 76466.2353376459, 76985.0, 80032.39854206458, 12583.0, 12757.681057973625, 12881.033922455666, 13162.47350105985, 13211.339433028503, 13971.301434928417, 14000.859991400363, 14140.0, 14451.855481445471, 14468.927655361656, 10201.438920859424, 11714.648560543197, 11734.823977640513, 11917.0, 12129.757404851676, 10986.450677465935, 11151.72120696989, 11152.609658661908, 11504.079673626256, 11535.250208736405, 11828.881711182778, 11837.644870653894, 12038.277703337828, 12147.331896745764, 12176.878231217574, 12704.174228675107, 12728.809067863804, 12982.415791289226, 13018.2839943804, 13186.472541098248, 11287.589051368579, 11688.006519445942, 11788.823167652321, 12082.39588020613, 12135.150539462153], "value": 10656.389979386347, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1200.5677955935855, 1380.820493335866, 1466.7066586682658, 1490.7093116842216, 1491.1351416178618, 9745.805083898318, 10219.335743176689, 10219.591216351337, 10224.795504089923, 10225.437600931955, 9956.452395118265, 10794.946025269863, 11440.370779607118, 11517.42412879357, 11535.884641153585, 2453.0310527341735, 2504.3238325652064, 2506.1604362538574, 2506.5738824399805, 2508.912188073418, 2429.210506585358, 2525.090967251797, 2528.0, 2528.506941146477, 2535.1760677779703, 2036.704677821715, 2124.3839286606867, 2432.7080750309988, 2529.84820910745, 2530.329462692379, 2507.7993760499116, 2510.3975045988923, 2544.033267358401, 2544.4147845995526, 2545.4909018196436, 2406.278116565041, 2414.9034038638433, 2416.226807421626, 2417.54066727323, 2418.733939266679, 11438.828417573659, 11687.941560292229, 11698.766024679458, 11699.122565807598, 11723.296602203895, 6583.868322633569, 6844.726210951556, 6856.897146542806, 6864.931350686479, 6865.9313406865795, 3924.3328634132267, 4128.8348466061325, 4223.852165174235, 4285.250081235802, 4293.205756934977, 1208.4501551793912, 1219.1465973818363, 1235.5243231355903, 1253.9498420063187, 1256.0391300655006, 16308.75536866948, 16339.26473308704, 16341.59146021347, 16342.182890855409, 16348.754768678598, 5890.991357497955, 5942.821715348547, 5943.465088142088, 5949.25634295713, 6094.725737341831, 13863.584092477242, 13864.098833575987, 13867.375968081258, 13872.514461993782, 13880.305984700724, 6803.48973826965, 6819.079424277758, 6824.385805277549, 6829.556078854858, 6836.077129587442, 5140.254663073833, 5154.742262886915, 6283.7800676976085, 6293.842653933688, 6299.370062993664, 4490.955090449119, 4633.884152896205, 4665.813367465264, 4724.338592597039, 4725.621950243973, 1432.2194404049817, 1462.0642788615294, 1463.780432935047, 1484.1243666236971, 1488.8585584369469, 799.7161007842249, 806.5725165662209, 830.5681045856121, 836.0761358698672, 861.6725644255143, 6510.544261901621, 6761.763338283136, 6943.479239057091, 6987.371136597629, 7004.929950700428, 501.8343946497647, 602.2050892821434, 612.0513204532956, 620.7299824576323, 620.9844753881189, 3591.06632275605, 3597.568291804948, 4077.7757223353, 4162.729422587522, 4624.14453326129, 14853.257337133316, 15276.541703748906, 15278.31247593861, 15299.770503442458, 15321.23393830304, 14646.707065858624, 15132.697346053017, 15172.165530895907, 15175.696486070217, 15179.0, 8435.451695639764, 8629.180227878342, 8648.481091134552, 8653.437526560754, 8706.825863482694, 6808.65956702153, 6852.862942741217, 6856.348646878539, 7133.82165445868, 7138.750143744944, 12484.500619975099, 13235.205887646773, 13291.933540332237, 13339.399727012114, 13371.53199638008, 9670.758231044, 12919.741605168032, 13170.539031133865, 13525.72948541004, 13591.932040339734, 9731.464769437465, 9768.07203315684, 10475.895241047492, 10713.14294856394, 10770.676879693621, 10824.079953204066, 10999.450027498753, 11009.284396514522, 11009.669709908716, 11016.50425730828, 8778.209961103275, 9107.863382049141, 9164.266858651159, 9188.632454701738, 9229.815403691755, 8885.555722213734, 8934.374593778633, 8943.552822358986, 8993.550322483981, 9015.143561361923, 8176.4276500646765, 8182.877256841033, 8273.710420135267, 8298.336133109216, 8329.916700832913, 5623.8594035149445, 5916.230889984275, 6028.577999540165, 6141.723622436912, 6175.289841668266, 5953.3153687324775, 5987.31145918225, 6158.7990341882905, 6170.784022559368, 6299.464545513682], "value": 5360.148113728118, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.9769716119872, 387.37632411816986, 405.46276184056114, 408.1449363583292, 409.2919249698022, 5175.456577059406, 5682.602217844753, 5939.970300148493, 5950.9107363389585, 5979.222701048863, 5280.445553216915, 5799.391063938278, 5811.041178205602, 5811.733423964647, 5815.412141596991, 3934.6852251819787, 4162.583741625844, 4475.634931345939, 4527.275635898265, 4587.42657167854, 4560.2019646561885, 4561.407017087774, 4587.334836448713, 4593.816247350119, 4602.815887364502, 4578.816847326103, 4592.9665825189395, 4597.126545956257, 4607.792649330788, 4611.608013318855, 4192.622663960243, 4321.0061685812125, 4331.956680433187, 4337.392765012901, 4592.196365636, 3097.272141046852, 3729.440583912408, 3731.8507259709577, 3754.9812250938844, 3760.9059773505883, 5770.855728606818, 5785.190073389729, 5793.7392817323325, 5811.738471768738, 5817.243758311435, 4277.379779931924, 4830.85507434774, 5037.773300201463, 5120.667156634807, 5155.974220128913, 5617.578681598897, 5860.549688789424, 6293.339199384044, 6294.905576416358, 6312.400321969406, 4213.91572168558, 4235.745855248664, 4236.258654735439, 4241.7879106044575, 4248.299030659938, 5394.298741163663, 6248.812535623939, 6362.840928976812, 6482.050666946481, 6570.868582628368, 3452.2750222453565, 3631.019624701316, 4234.259004674232, 4281.314989601711, 4286.8499602514385, 4293.8711838644895, 4333.241682705577, 4356.411884395629, 4366.170427618742, 4369.847055353048, 3976.76139431635, 4268.9786551067045, 4935.3595826232795, 5055.7219352935945, 5094.821681241213, 6224.937750622526, 6226.750929962841, 6240.563160578716, 6255.906161407583, 6258.624482531062, 1446.132320607627, 1469.6987117641072, 1473.9732867307453, 1481.5999680086315, 1483.9332230049674, 783.710027289895, 958.7651025498798, 962.9759256018516, 977.7973093095533, 988.1768137785917, 4773.307870358848, 4883.8290659826735, 5685.715714214355, 5928.822135335947, 5941.881162376728, 6508.8047358579315, 6524.151860258136, 6585.979173228157, 6587.868242635121, 6588.341165883373, 4952.910359720856, 5087.97456012725, 5151.295569825871, 5474.850281440942, 5826.679532625746, 2772.334639686501, 2805.438912217565, 3308.8915213403297, 3325.8525808595996, 3394.4229480988292, 6367.256393986417, 6694.765683201162, 6770.796876093725, 6810.421114205348, 6837.829054273683, 5610.495055444948, 6720.0, 6725.2602213756445, 6779.762708305186, 6780.288069752605, 5629.296337957755, 6367.733618475632, 6709.966450167718, 6767.52627316093, 6808.4212841908, 6057.0, 6464.773732919325, 6523.31505191967, 6525.314841941527, 6569.671516424255, 4991.051700176955, 5539.362973258127, 6085.648761135809, 6426.100345951664, 6435.22777266731, 6258.775326654399, 6743.898841517479, 6761.695723692347, 6764.0, 6765.932340676531, 4226.197022565826, 4226.6618670506905, 4233.830646774095, 4236.978815106028, 4254.1704367649245, 5856.853578660568, 6277.748890044347, 6465.349206825179, 6509.121268628864, 6521.413072823469, 5181.585473162213, 6216.564840461125, 6237.941479311726, 6239.532035097477, 6272.466840318624, 5112.693238405707, 5669.0, 5946.316173640087, 6237.438630523093, 6259.96870015647, 5360.839174824761, 6130.325664176848, 6135.417135372132, 6148.754049837957, 6170.753169873155, 5921.526277897672, 6243.719032643451, 6248.12526246335, 6267.717952692231, 6274.435300822948, 4822.397200349957, 5775.364709881826, 6116.938830611637, 6117.663528505975, 6141.355157708376], "value": 4550.28270378274, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [846.9026062002871, 865.2861389353783, 868.9913100868994, 872.6509396241503, 885.663447889802, 16137.515874523753, 16295.674086518276, 16727.414540491085, 16729.414470493535, 16770.07764572948, 15555.222238888038, 15570.688586228296, 15665.216739163025, 15744.606384840385, 15768.684626307468, 993.46849435552, 993.5280741647732, 995.6863587969802, 996.1930836022808, 998.645480854299, 997.5909876950452, 1001.8096561653299, 1017.1964148322816, 1027.4965267019145, 1031.9071283584476, 1072.8980746829077, 1074.6346242277625, 1078.0890147825075, 1078.44460103047, 1081.1188881061948, 909.4088842252555, 1008.5259927833943, 1052.8736551613779, 1068.1348108032519, 1068.6259809066842, 798.2097723253995, 799.2606838674261, 799.7880561651167, 802.4342838299043, 802.9116797152309, 16294.918525407416, 16463.34146634133, 16672.58318542034, 17078.402255921108, 17315.740263895925, 17409.390671326444, 17454.56363590908, 17553.912230438895, 17766.91116544409, 17913.7312940306, 13933.79099313501, 14189.290535473185, 14287.57137285883, 14513.419463221458, 14526.0, 3327.168207948013, 3347.9497807532907, 3530.117470632342, 3561.5904171020406, 3563.429851223792, 85674.0, 132210.3389483056, 132291.0, 136306.31846840703, 136403.0, 10996.23026388145, 11315.15136364776, 11534.423278836024, 11545.595904143483, 13540.796888046687, 23870.761292386855, 25082.0, 25088.749112509005, 25168.496630067297, 25409.983600655767, 7951.244631759973, 8124.309433698084, 8138.837223255502, 8148.511089334659, 8157.347412207009, 3958.6833053355663, 4023.094803669151, 4032.1734044520804, 4032.193561287754, 4034.2133284009337, 3779.281936432069, 4368.0, 4389.144116897174, 4406.801693923781, 4408.58118478744, 913.5569248914271, 949.050949050949, 950.9966984830932, 953.6280850468323, 954.3033585482498, 616.9568130230841, 618.8514756458418, 627.3914303125961, 627.6547898655813, 651.9576227545194, 9524.047595240421, 9685.0, 10977.231593788518, 11818.822717659243, 11963.760724785456, 634.6604566556962, 660.5574265242299, 671.4326394196896, 684.0218487562832, 684.2507454337492, 4361.80371883266, 5487.012337779158, 5498.422665620053, 5554.527865131509, 5644.774209031592, 108376.0, 108708.0, 109463.0, 110722.33916491258, 112709.43645281885, 96914.51542742242, 97973.0, 99206.50396748114, 100729.49635251777, 100947.49526252468, 87431.0, 88319.11680883238, 88401.67397489042, 88810.0, 90223.0, 8540.359473039423, 9166.724998250063, 11039.558417663204, 11398.316101033965, 11482.827757583476, 41857.372139417326, 41964.0, 42227.0, 42605.934851628954, 42617.57382426136, 39845.2030959385, 54035.189472157166, 54270.45729542654, 64834.35165648283, 72726.27273727195, 14178.645533861736, 16616.58458538498, 16897.0, 17310.480685579452, 17335.479935601954, 18035.458936231935, 18436.631267374847, 18637.44087677372, 18724.719129213347, 18872.0, 16529.173541322645, 17155.142242887556, 17224.82775172232, 17228.138593070547, 17310.22104005348, 16663.66672666564, 16842.66314673675, 17280.22238999223, 17345.56636084108, 17492.0, 15432.691346173238, 15948.0, 16010.519684409486, 16039.438619648256, 16253.67492650164, 10024.348417352849, 11121.776604573652, 11184.217104802585, 11265.0, 11949.402529873645, 10077.395356278646, 12647.936760316139, 12958.870411296144, 12966.740665186831, 13034.022448316224], "value": 8362.776629729222, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1438.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 109.0, 110.0, 111.0, 111.0, 111.0, 113.0, 111.0, 109.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 109.0, 109.0, 151.0, 110.0, 109.0, 107.0, 108.0, 137.0, 107.0], "value": 119.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 185.0, 183.0, 183.0, 185.0, 184.0, 186.0, 186.0, 187.0, 180.0], "value": 184.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 58.0, 58.0, 90.0, 65.0, 62.0, 59.0, 58.0, 81.0, 57.0], "value": 67.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 103.0, 103.0, 103.0, 68.0, 88.0, 69.0, 69.0, 87.0], "value": 85.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 86.0, 85.0, 86.0, 86.0, 86.0, 86.0, 87.0, 86.0], "value": 86.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 103.0, 118.0, 94.0, 97.0, 94.0, 95.0, 103.0], "value": 98.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 86.0, 84.0, 84.0, 85.0, 86.0, 90.0, 87.0], "value": 85.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 47.0, 47.0, 46.0, 49.0, 48.0, 48.0, 49.0, 47.0, 47.0], "value": 47.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 62.0, 54.0, 65.0, 58.0, 57.0, 59.0, 58.0, 57.0], "value": 58.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 97.0, 109.0, 105.0, 80.0, 82.0, 81.0, 81.0, 82.0, 80.0], "value": 88.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 134.0, 133.0, 133.0, 134.0, 134.0, 138.0, 135.0, 175.0, 153.0], "value": 140.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [211.0, 235.0, 192.0, 186.0, 234.0, 205.0, 184.0, 182.0, 189.0, 180.0], "value": 199.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 62.0, 67.0, 69.0, 67.0, 67.0, 68.0, 67.0, 68.0], "value": 66.5, "unit": "score"}]}]} 16:14:56 INFO - Return code: 0 16:14:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:14:56 INFO - # TBPL SUCCESS # 16:14:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:14:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:14:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:14:56 INFO - 2017-05-09 16:14:56.772 screenresolution[2993:32492] starting screenresolution argv=screenresolution get 16:14:56 INFO - 2017-05-09 16:14:56.774 screenresolution[2993:32492] Display 0: 1600x1200x32@60 16:14:56 INFO - 2017-05-09 16:14:56.781 screenresolution[2994:32495] starting screenresolution argv=screenresolution list 16:14:56 INFO - Available Modes on Display 0 16:14:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:14:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:14:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:14:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:14:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:14:57 INFO - Intel Iris: 16:14:57 INFO - Chipset Model: Intel Iris 16:14:57 INFO - Type: GPU 16:14:57 INFO - Bus: Built-In 16:14:57 INFO - VRAM (Dynamic, Max): 1536 MB 16:14:57 INFO - Vendor: Intel (0x8086) 16:14:57 INFO - Device ID: 0x0a2e 16:14:57 INFO - Revision ID: 0x0009 16:14:57 INFO - Displays: 16:14:57 INFO - Display: 16:14:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:14:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:14:57 INFO - Display Serial Number: 1600x1200 60 16:14:57 INFO - Main Display: Yes 16:14:57 INFO - Mirror: Off 16:14:57 INFO - Online: Yes 16:14:57 INFO - Rotation: Supported 16:14:57 INFO - Return code: 0 16:14:57 INFO - Running post-action listener: _resource_record_post_action 16:14:57 INFO - [mozharness: 2017-05-09 23:14:57.017603Z] Finished run-tests step (success) 16:14:57 INFO - Running post-run listener: _resource_record_post_run 16:14:57 INFO - Total resource usage - Wall time: 1199s; CPU: 53.0%; Read bytes: 1307136; Write bytes: 532046336; Read time: 6; Write time: 1626 16:14:57 INFO - TinderboxPrint: CPU usage
53.2% 16:14:57 INFO - TinderboxPrint: I/O read bytes / time
1,307,136 / 6 16:14:57 INFO - TinderboxPrint: I/O write bytes / time
532,046,336 / 1,626 16:14:57 INFO - TinderboxPrint: CPU idle
2,243.3 (46.8%) 16:14:57 INFO - TinderboxPrint: CPU system
955.7 (19.9%) 16:14:57 INFO - TinderboxPrint: CPU user
1,598.5 (33.3%) 16:14:57 INFO - TinderboxPrint: Swap in / out
213,950,464 / 0 16:14:57 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 204292608; Write bytes: 208418304; Read time: 16170; Write time: 444 16:14:57 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 1306624; Write bytes: 313740288; Read time: 6; Write time: 1144 16:14:57 INFO - Running post-run listener: _upload_blobber_files 16:14:57 INFO - Blob upload gear active. 16:14:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:14:57 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 16:14:57 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'] 16:14:57 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 16:14:57 INFO - (blobuploader) - INFO - Open directory for files ... 16:14:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:14:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:14:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:14:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:14:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:14:58 INFO - (blobuploader) - INFO - Done attempting. 16:14:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:14:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:14:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:14:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:14:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:14:59 INFO - (blobuploader) - INFO - Done attempting. 16:14:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:14:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:14:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:15:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:15:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:15:00 INFO - (blobuploader) - INFO - Done attempting. 16:15:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:15:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:15:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:15:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:15:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:15:02 INFO - (blobuploader) - INFO - Done attempting. 16:15:02 INFO - (blobuploader) - INFO - Iteration through files over. 16:15:02 INFO - Return code: 0 16:15:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:15:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:15:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cd374c4849149c6f3b1930e1fb0c1efd9674907064c4fdc74772fd8a4bc0ca86d3daf9c06e743cdba02d36f3351a32663a3ec94b01cbc24f8f0e0266dea5538", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/173e24d3959a79c57ee21875e1c8b5d5400f51abd68db495cddfd80f80ed94b49bda37aed7fb6ff20b2332e761f7df3399bd4f0cbb604aa95b9f2bb836519360", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6467baa850350896ac52533c22dd2affa398d6e40ef1e48742ac77303647835ad7177beba62f53a666ffada00fb8597e2776bea3c4c185357e31bd8c0538932", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/160175e877a444083c16ee2252690a04f2649f6ff29f42f0592541265994fff586db64719955b5e9527107ffb9acfc7ec252ef05b9af907305ce68111581e1ba"} 16:15:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:15:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:15:02 INFO - Contents: 16:15:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cd374c4849149c6f3b1930e1fb0c1efd9674907064c4fdc74772fd8a4bc0ca86d3daf9c06e743cdba02d36f3351a32663a3ec94b01cbc24f8f0e0266dea5538", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/173e24d3959a79c57ee21875e1c8b5d5400f51abd68db495cddfd80f80ed94b49bda37aed7fb6ff20b2332e761f7df3399bd4f0cbb604aa95b9f2bb836519360", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6467baa850350896ac52533c22dd2affa398d6e40ef1e48742ac77303647835ad7177beba62f53a666ffada00fb8597e2776bea3c4c185357e31bd8c0538932", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/160175e877a444083c16ee2252690a04f2649f6ff29f42f0592541265994fff586db64719955b5e9527107ffb9acfc7ec252ef05b9af907305ce68111581e1ba"} 16:15:02 INFO - Running post-run listener: copy_logs_to_upload_dir 16:15:02 INFO - Copying logs to upload dir... 16:15:02 INFO - mkdir: /builds/slave/test/build/upload/logs 16:15:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.326282 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-05-09 16:15:02.660132) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-09 16:15:02.663778) ========= 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.3dUrUUHhpk/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.xMU3b98zfJ/Listeners TMPDIR=/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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/5cd374c4849149c6f3b1930e1fb0c1efd9674907064c4fdc74772fd8a4bc0ca86d3daf9c06e743cdba02d36f3351a32663a3ec94b01cbc24f8f0e0266dea5538", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/173e24d3959a79c57ee21875e1c8b5d5400f51abd68db495cddfd80f80ed94b49bda37aed7fb6ff20b2332e761f7df3399bd4f0cbb604aa95b9f2bb836519360", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6467baa850350896ac52533c22dd2affa398d6e40ef1e48742ac77303647835ad7177beba62f53a666ffada00fb8597e2776bea3c4c185357e31bd8c0538932", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/160175e877a444083c16ee2252690a04f2649f6ff29f42f0592541265994fff586db64719955b5e9527107ffb9acfc7ec252ef05b9af907305ce68111581e1ba"} build_url:https://queue.taskcluster.net/v1/task/UNuUHLe6SWqH8Lt5SgBjGg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011108 build_url: 'https://queue.taskcluster.net/v1/task/UNuUHLe6SWqH8Lt5SgBjGg/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/5cd374c4849149c6f3b1930e1fb0c1efd9674907064c4fdc74772fd8a4bc0ca86d3daf9c06e743cdba02d36f3351a32663a3ec94b01cbc24f8f0e0266dea5538", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/173e24d3959a79c57ee21875e1c8b5d5400f51abd68db495cddfd80f80ed94b49bda37aed7fb6ff20b2332e761f7df3399bd4f0cbb604aa95b9f2bb836519360", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6467baa850350896ac52533c22dd2affa398d6e40ef1e48742ac77303647835ad7177beba62f53a666ffada00fb8597e2776bea3c4c185357e31bd8c0538932", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/160175e877a444083c16ee2252690a04f2649f6ff29f42f0592541265994fff586db64719955b5e9527107ffb9acfc7ec252ef05b9af907305ce68111581e1ba"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-09 16:15:02.697030) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 16:15:02.697372) ========= 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.3dUrUUHhpk/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.xMU3b98zfJ/Listeners TMPDIR=/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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.005242 ========= master_lag: 0.21 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 16:15:02.908704) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-09 16:15:02.909023) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-09 16:15:03.068902) ========= ========= Total master_lag: 0.41 =========