builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0254 starttime: 1494430817.56 results: success (0) revision: ebbcdaa5b5802ecd39624dd2acbdda8547b8384d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-10 08:40:17.559130) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-10 08:40:17.559615) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-10 08:40:17.559915) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-10 08:40:17.586512) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 08:40:17.586875) ========= 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.PPZKt5CQ6p/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.SD5nwqIdgP/Listeners TMPDIR=/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/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-10 08:40:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 164M=0s 2017-05-10 08:40:18 (164 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.480734 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 08:40:18.091794) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 08:40:18.092168) ========= 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.PPZKt5CQ6p/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.SD5nwqIdgP/Listeners TMPDIR=/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/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.030595 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 08:40:18.146742) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-10 08:40:18.147121) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ebbcdaa5b5802ecd39624dd2acbdda8547b8384d --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 ebbcdaa5b5802ecd39624dd2acbdda8547b8384d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PPZKt5CQ6p/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.SD5nwqIdgP/Listeners TMPDIR=/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/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-10 08:40:18,255 truncating revision to first 12 chars 2017-05-10 08:40:18,255 Setting DEBUG logging. 2017-05-10 08:40:18,255 attempt 1/10 2017-05-10 08:40:18,255 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ebbcdaa5b580?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-10 08:40:19,264 unpacking tar archive at: mozilla-central-ebbcdaa5b580/testing/mozharness/ program finished with exit code 0 elapsedTime=1.279541 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-10 08:40:19.451157) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-10 08:40:19.451635) ========= script_repo_revision: ebbcdaa5b5802ecd39624dd2acbdda8547b8384d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-10 08:40:19.452084) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-10 08:40:19.452358) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-10 08:40:19.477757) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-05-10 08:40:19.478209) ========= /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.PPZKt5CQ6p/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.SD5nwqIdgP/Listeners TMPDIR=/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:40:19 INFO - MultiFileLogger online at 20170510 08:40:19 in /builds/slave/test 08:40:19 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 08:40:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:40:19 INFO - {'append_to_log': False, 08:40:19 INFO - 'base_work_dir': '/builds/slave/test', 08:40:19 INFO - 'blob_upload_branch': 'Firefox', 08:40:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:40:19 INFO - 'branch': 'Firefox', 08:40:19 INFO - 'buildbot_json_path': 'buildprops.json', 08:40:19 INFO - 'config_files': ('talos/mac_config.py',), 08:40:19 INFO - 'default_actions': ('clobber', 08:40:19 INFO - 'read-buildbot-config', 08:40:19 INFO - 'download-and-extract', 08:40:19 INFO - 'populate-webroot', 08:40:19 INFO - 'create-virtualenv', 08:40:19 INFO - 'install', 08:40:19 INFO - 'run-tests'), 08:40:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:40:19 INFO - 'download_minidump_stackwalk': True, 08:40:19 INFO - 'download_symbols': 'ondemand', 08:40:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:40:19 INFO - 'tooltool.py': '/tools/tooltool.py', 08:40:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:40:19 INFO - '/tools/misc-python/virtualenv.py')}, 08:40:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:40:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:40:19 INFO - 'gecko_profile': False, 08:40:19 INFO - 'gecko_profile_interval': 0, 08:40:19 INFO - 'installer_path': 'installer.exe', 08:40:19 INFO - 'log_level': 'info', 08:40:19 INFO - 'log_name': 'talos', 08:40:19 INFO - 'log_to_console': True, 08:40:19 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:40:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:40:19 INFO - 'opt_config_files': (), 08:40:19 INFO - 'pip_index': False, 08:40:19 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:40:19 INFO - 'cmd': ('bash', 08:40:19 INFO - '-c', 08:40:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:40:19 INFO - 'enabled': True, 08:40:19 INFO - 'halt_on_failure': False, 08:40:19 INFO - 'name': 'check_screen_resolution'},), 08:40:19 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:40:19 INFO - 'cmd': ('bash', 08:40:19 INFO - '-c', 08:40:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:40:19 INFO - 'enabled': True, 08:40:19 INFO - 'halt_on_failure': False, 08:40:19 INFO - 'name': 'check_screen_resolution'},), 08:40:19 INFO - 'run_cmd_checks_enabled': True, 08:40:19 INFO - 'suite': 'dromaeojs', 08:40:19 INFO - 'system_bits': '32', 08:40:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:40:19 INFO - 'title': 't-yosemite-r7-0254', 08:40:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:40:19 INFO - 'use_talos_json': True, 08:40:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:40:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:40:19 INFO - 'work_dir': 'build'} 08:40:19 INFO - [mozharness: 2017-05-10 15:40:19.694442Z] Running clobber step. 08:40:19 INFO - Running pre-action listener: _resource_record_pre_action 08:40:19 INFO - Running main action method: clobber 08:40:19 INFO - rmtree: /builds/slave/test/build 08:40:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:40:22 INFO - Running post-action listener: _resource_record_post_action 08:40:22 INFO - [mozharness: 2017-05-10 15:40:22.324974Z] Finished clobber step (success) 08:40:22 INFO - [mozharness: 2017-05-10 15:40:22.325146Z] Running read-buildbot-config step. 08:40:22 INFO - Running pre-action listener: _resource_record_pre_action 08:40:22 INFO - Running main action method: read_buildbot_config 08:40:22 INFO - Using buildbot properties: 08:40:22 INFO - { 08:40:22 INFO - "project": "", 08:40:22 INFO - "product": "firefox", 08:40:22 INFO - "who": "cbook@mozilla.com", 08:40:22 INFO - "installer_path": "public/build/firefox-55.0a1.en-US.mac.dmg", 08:40:22 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:40:22 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:40:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:40:22 INFO - "stage_platform": "macosx64", 08:40:22 INFO - "basedir": "/builds/slave/test", 08:40:22 INFO - "buildnumber": 21, 08:40:22 INFO - "platform": "yosemite_r7", 08:40:22 INFO - "parent_task_id": "E_59EUdWTLWqPg30BD7Xiw", 08:40:22 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:40:22 INFO - "slavebuilddir": "test", 08:40:22 INFO - "taskId": "QPtqEu0-S66y7XPB5cIJgA", 08:40:22 INFO - "branch": "mozilla-central", 08:40:22 INFO - "script_repo_revision": "production", 08:40:22 INFO - "revision": "ebbcdaa5b5802ecd39624dd2acbdda8547b8384d", 08:40:22 INFO - "slavename": "t-yosemite-r7-0254", 08:40:22 INFO - "repo_path": "mozilla-central" 08:40:22 INFO - } 08:40:22 INFO - Finding installer, test and symbols from parent task. 08:40:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QPtqEu0-S66y7XPB5cIJgA'}, attempt #1 08:40:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QPtqEu0-S66y7XPB5cIJgA'}, attempt #1 08:40:23 INFO - Task dependencies: MY4JQSQqRiiFFVj12C406Q 08:40:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E_59EUdWTLWqPg30BD7Xiw'}, attempt #1 08:40:24 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/E_59EUdWTLWqPg30BD7Xiw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:40:24 INFO - Set test_url: https://queue.taskcluster.net/v1/task/E_59EUdWTLWqPg30BD7Xiw/artifacts/public/build/test_packages.json 08:40:24 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/E_59EUdWTLWqPg30BD7Xiw/artifacts/public/build/target.crashreporter-symbols.zip 08:40:24 INFO - Running post-action listener: _resource_record_post_action 08:40:24 INFO - [mozharness: 2017-05-10 15:40:24.027783Z] Finished read-buildbot-config step (success) 08:40:24 INFO - [mozharness: 2017-05-10 15:40:24.027895Z] Running download-and-extract step. 08:40:24 INFO - Running pre-action listener: _resource_record_pre_action 08:40:24 INFO - Running main action method: download_and_extract 08:40:24 INFO - mkdir: /builds/slave/test/build/tests 08:40:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:24 INFO - trying https://queue.taskcluster.net/v1/task/E_59EUdWTLWqPg30BD7Xiw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 08:40:24 INFO - Downloading https://queue.taskcluster.net/v1/task/E_59EUdWTLWqPg30BD7Xiw/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 08:40:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E_59EUdWTLWqPg30BD7Xiw/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 08:40:24 INFO - Downloaded 1325 bytes. 08:40:24 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 08:40:24 INFO - Using the following test package requirements: 08:40:24 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:40:24 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 08:40:24 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 08:40:24 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:40:24 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 08:40:24 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:40:24 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 08:40:24 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:40:24 INFO - u'jsshell-mac.zip'], 08:40:24 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:40:24 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 08:40:24 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 08:40:24 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:40:24 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 08:40:24 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:40:24 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 08:40:24 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:40:24 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 08:40:24 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:40:24 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 08:40:24 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:40:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E_59EUdWTLWqPg30BD7Xiw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 08:40:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E_59EUdWTLWqPg30BD7Xiw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:40:24 INFO - Fetch https://queue.taskcluster.net/v1/task/E_59EUdWTLWqPg30BD7Xiw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 08:40:26 INFO - Content-Length response header: 52707691 08:40:26 INFO - Bytes received: 52707691 08:40:42 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 08:40:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E_59EUdWTLWqPg30BD7Xiw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 08:40:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E_59EUdWTLWqPg30BD7Xiw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:40:42 INFO - Fetch https://queue.taskcluster.net/v1/task/E_59EUdWTLWqPg30BD7Xiw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 08:40:44 INFO - Content-Length response header: 52707691 08:40:44 INFO - Bytes received: 52707691 08:40:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E_59EUdWTLWqPg30BD7Xiw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 08:40:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E_59EUdWTLWqPg30BD7Xiw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:40:59 INFO - Fetch https://queue.taskcluster.net/v1/task/E_59EUdWTLWqPg30BD7Xiw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 08:41:00 INFO - Content-Length response header: 14409362 08:41:00 INFO - Bytes received: 14409362 08:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:00 INFO - trying https://queue.taskcluster.net/v1/task/E_59EUdWTLWqPg30BD7Xiw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:41:00 INFO - Downloading https://queue.taskcluster.net/v1/task/E_59EUdWTLWqPg30BD7Xiw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 08:41:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E_59EUdWTLWqPg30BD7Xiw/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 08:41:02 INFO - Downloaded 75909304 bytes. 08:41:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E_59EUdWTLWqPg30BD7Xiw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:41:02 INFO - mkdir: /builds/slave/test/properties 08:41:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:41:02 INFO - Writing to file /builds/slave/test/properties/build_url 08:41:02 INFO - Contents: 08:41:02 INFO - build_url:https://queue.taskcluster.net/v1/task/E_59EUdWTLWqPg30BD7Xiw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:41:02 INFO - Running post-action listener: _resource_record_post_action 08:41:02 INFO - Running post-action listener: set_extra_try_arguments 08:41:02 INFO - [mozharness: 2017-05-10 15:41:02.970607Z] Finished download-and-extract step (success) 08:41:02 INFO - [mozharness: 2017-05-10 15:41:02.970780Z] Running populate-webroot step. 08:41:02 INFO - Running pre-action listener: _resource_record_pre_action 08:41:02 INFO - Running main action method: populate_webroot 08:41:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:41:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:41:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:41:02 INFO - '--tppagecycles', 08:41:02 INFO - '7'], 08:41:02 INFO - 'tests': ['tsvgm']}}, 08:41:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:41:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:41:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:41:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:41:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:41:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:41:02 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:41:02 INFO - 'talos_options': ['--disable-e10s'], 08:41:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:41:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:41:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:41:02 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:41:02 INFO - 'talos_options': ['--disable-e10s'], 08:41:02 INFO - 'tests': ['damp', 'tps']}, 08:41:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:41:02 INFO - 'tests': ['damp', 'tps']}, 08:41:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:41:02 INFO - 'tests': ['dromaeo_dom']}, 08:41:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:41:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:41:02 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:41:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:41:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:41:02 INFO - 'tests': ['a11yr', 08:41:02 INFO - 'ts_paint', 08:41:02 INFO - 'tpaint', 08:41:02 INFO - 'sessionrestore', 08:41:02 INFO - 'sessionrestore_no_auto_restore', 08:41:02 INFO - 'tabpaint']}, 08:41:02 INFO - 'other-e10s': {'tests': ['a11yr', 08:41:02 INFO - 'ts_paint', 08:41:02 INFO - 'tpaint', 08:41:02 INFO - 'sessionrestore', 08:41:02 INFO - 'sessionrestore_no_auto_restore', 08:41:02 INFO - 'tabpaint']}, 08:41:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:41:02 INFO - 'ts_paint', 08:41:02 INFO - 'tpaint', 08:41:02 INFO - 'sessionrestore', 08:41:02 INFO - 'sessionrestore_no_auto_restore', 08:41:02 INFO - 'tabpaint']}, 08:41:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:41:02 INFO - 'ts_paint', 08:41:02 INFO - 'tpaint', 08:41:02 INFO - 'sessionrestore', 08:41:02 INFO - 'sessionrestore_no_auto_restore', 08:41:02 INFO - 'tabpaint']}, 08:41:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:41:02 INFO - 'tests': ['a11yr', 08:41:02 INFO - 'ts_paint', 08:41:02 INFO - 'tpaint', 08:41:02 INFO - 'sessionrestore', 08:41:02 INFO - 'sessionrestore_no_auto_restore', 08:41:02 INFO - 'tabpaint']}, 08:41:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:41:02 INFO - 'tests': ['a11yr', 08:41:02 INFO - 'ts_paint', 08:41:02 INFO - 'tpaint', 08:41:02 INFO - 'sessionrestore', 08:41:02 INFO - 'sessionrestore_no_auto_restore', 08:41:02 INFO - 'tabpaint']}, 08:41:02 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 08:41:02 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 08:41:02 INFO - 'bloom_basic_ref']}, 08:41:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:41:02 INFO - 'tests': ['tsvgx', 08:41:02 INFO - 'tsvgr_opacity', 08:41:02 INFO - 'tart', 08:41:02 INFO - 'tscrollx', 08:41:02 INFO - 'cart', 08:41:02 INFO - 'tsvg_static']}, 08:41:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:41:02 INFO - 'tsvgr_opacity', 08:41:02 INFO - 'tart', 08:41:02 INFO - 'tscrollx', 08:41:02 INFO - 'cart', 08:41:02 INFO - 'tsvg_static']}, 08:41:02 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:41:02 INFO - 'talos_options': ['--disable-e10s'], 08:41:02 INFO - 'tests': ['tp5o']}, 08:41:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:41:02 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:41:02 INFO - 'talos_options': ['--disable-e10s', 08:41:02 INFO - '--xperf_path', 08:41:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:41:02 INFO - 'tests': ['tp5n']}, 08:41:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:41:02 INFO - 'talos_options': ['--xperf_path', 08:41:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:41:02 INFO - 'tests': ['tp5n']}}, 08:41:02 INFO - 'talos.zip': {'path': '', 08:41:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:41:02 INFO - Running post-action listener: _resource_record_post_action 08:41:02 INFO - [mozharness: 2017-05-10 15:41:02.991592Z] Finished populate-webroot step (success) 08:41:02 INFO - [mozharness: 2017-05-10 15:41:02.991733Z] Running create-virtualenv step. 08:41:02 INFO - Running pre-action listener: _resource_record_pre_action 08:41:02 INFO - Running main action method: create_virtualenv 08:41:02 INFO - Creating virtualenv /builds/slave/test/build/venv 08:41:02 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:41:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:41:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:41:03 INFO - Using real prefix '/tools/python27' 08:41:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:41:03 INFO - Installing distribute.............................................................................................................................................................................................done. 08:41:06 INFO - Installing pip.................done. 08:41:06 INFO - Return code: 0 08:41:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:41:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:41:06 INFO - Reading from file tmpfile_stdout 08:41:06 INFO - Output received: 08:41:06 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:41:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:07 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 0x10db00b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db03768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8150c76e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d811d30>, '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 0x10d7c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d805be8>, '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.PPZKt5CQ6p/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.SD5nwqIdgP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:41:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:41:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:41:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PPZKt5CQ6p/Render', 08:41:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:07 INFO - 'HOME': '/Users/cltbld', 08:41:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:07 INFO - 'LOGNAME': 'cltbld', 08:41:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:07 INFO - 'MOZ_NO_REMOTE': '1', 08:41:07 INFO - 'NO_EM_RESTART': '1', 08:41:07 INFO - 'PAGER': '/bin/cat', 08:41:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:07 INFO - 'PWD': '/builds/slave/test', 08:41:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:07 INFO - 'SHELL': '/bin/bash', 08:41:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SD5nwqIdgP/Listeners', 08:41:07 INFO - 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', 08:41:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:07 INFO - 'USER': 'cltbld', 08:41:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:07 INFO - 'XPC_FLAGS': '0x0', 08:41:07 INFO - 'XPC_SERVICE_NAME': '0', 08:41:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:41:07 INFO - Cleaning up... 08:41:07 INFO - Return code: 0 08:41:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:07 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 0x10db00b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db03768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8150c76e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d811d30>, '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 0x10d7c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d805be8>, '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.PPZKt5CQ6p/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.SD5nwqIdgP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:41:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:41:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:41:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PPZKt5CQ6p/Render', 08:41:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:07 INFO - 'HOME': '/Users/cltbld', 08:41:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:07 INFO - 'LOGNAME': 'cltbld', 08:41:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:07 INFO - 'MOZ_NO_REMOTE': '1', 08:41:07 INFO - 'NO_EM_RESTART': '1', 08:41:07 INFO - 'PAGER': '/bin/cat', 08:41:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:07 INFO - 'PWD': '/builds/slave/test', 08:41:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:07 INFO - 'SHELL': '/bin/bash', 08:41:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SD5nwqIdgP/Listeners', 08:41:07 INFO - 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', 08:41:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:07 INFO - 'USER': 'cltbld', 08:41:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:07 INFO - 'XPC_FLAGS': '0x0', 08:41:07 INFO - 'XPC_SERVICE_NAME': '0', 08:41:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:07 INFO - Downloading/unpacking psutil>=3.1.1 08:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:41:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:41:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:41:10 INFO - Installing collected packages: psutil 08:41:10 INFO - Running setup.py install for psutil 08:41:10 INFO - building 'psutil._psutil_osx' extension 08:41:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:41:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:41:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:41:11 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:41:11 INFO - building 'psutil._psutil_posix' extension 08:41:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:41:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:41:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:41:11 INFO - ^ 08:41:11 INFO - 1 warning generated. 08:41:11 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:41:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:41:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:41:11 INFO - Successfully installed psutil 08:41:11 INFO - Cleaning up... 08:41:11 INFO - Return code: 0 08:41:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:11 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 0x10db00b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db03768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8150c76e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d811d30>, '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 0x10d7c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d805be8>, '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.PPZKt5CQ6p/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.SD5nwqIdgP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:41:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:41:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:41:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PPZKt5CQ6p/Render', 08:41:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:11 INFO - 'HOME': '/Users/cltbld', 08:41:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:11 INFO - 'LOGNAME': 'cltbld', 08:41:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:11 INFO - 'MOZ_NO_REMOTE': '1', 08:41:11 INFO - 'NO_EM_RESTART': '1', 08:41:11 INFO - 'PAGER': '/bin/cat', 08:41:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:11 INFO - 'PWD': '/builds/slave/test', 08:41:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:11 INFO - 'SHELL': '/bin/bash', 08:41:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SD5nwqIdgP/Listeners', 08:41:11 INFO - 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', 08:41:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:11 INFO - 'USER': 'cltbld', 08:41:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:11 INFO - 'XPC_FLAGS': '0x0', 08:41:11 INFO - 'XPC_SERVICE_NAME': '0', 08:41:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:41:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:41:13 INFO - Installing collected packages: mozsystemmonitor 08:41:13 INFO - Running setup.py install for mozsystemmonitor 08:41:13 INFO - Successfully installed mozsystemmonitor 08:41:13 INFO - Cleaning up... 08:41:13 INFO - Return code: 0 08:41:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:41:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:13 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 0x10db00b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db03768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8150c76e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d811d30>, '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 0x10d7c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d805be8>, '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.PPZKt5CQ6p/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.SD5nwqIdgP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:41:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:41:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:41:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PPZKt5CQ6p/Render', 08:41:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:13 INFO - 'HOME': '/Users/cltbld', 08:41:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:13 INFO - 'LOGNAME': 'cltbld', 08:41:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:13 INFO - 'MOZ_NO_REMOTE': '1', 08:41:13 INFO - 'NO_EM_RESTART': '1', 08:41:13 INFO - 'PAGER': '/bin/cat', 08:41:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:13 INFO - 'PWD': '/builds/slave/test', 08:41:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:13 INFO - 'SHELL': '/bin/bash', 08:41:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SD5nwqIdgP/Listeners', 08:41:13 INFO - 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', 08:41:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:13 INFO - 'USER': 'cltbld', 08:41:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:13 INFO - 'XPC_FLAGS': '0x0', 08:41:13 INFO - 'XPC_SERVICE_NAME': '0', 08:41:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:13 INFO - Downloading/unpacking jsonschema==2.5.1 08:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:41:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:15 INFO - Downloading functools32-3.2.3-2.tar.gz 08:41:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:41:15 INFO - warning: no files found matching '*.txt' 08:41:15 INFO - no previously-included directories found matching 'build' 08:41:15 INFO - no previously-included directories found matching 'dist' 08:41:15 INFO - no previously-included directories found matching '.git*' 08:41:15 INFO - Installing collected packages: jsonschema, functools32 08:41:15 INFO - Running setup.py install for functools32 08:41:15 INFO - warning: no files found matching '*.txt' 08:41:15 INFO - no previously-included directories found matching 'build' 08:41:15 INFO - no previously-included directories found matching 'dist' 08:41:15 INFO - no previously-included directories found matching '.git*' 08:41:15 INFO - Successfully installed jsonschema functools32 08:41:15 INFO - Cleaning up... 08:41:15 INFO - Return code: 0 08:41:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:41:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10db00b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db03768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8150c76e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d811d30>, '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 0x10d7c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d805be8>, '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.PPZKt5CQ6p/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.SD5nwqIdgP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:41:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:41:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:41:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PPZKt5CQ6p/Render', 08:41:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:15 INFO - 'HOME': '/Users/cltbld', 08:41:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:15 INFO - 'LOGNAME': 'cltbld', 08:41:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:15 INFO - 'MOZ_NO_REMOTE': '1', 08:41:15 INFO - 'NO_EM_RESTART': '1', 08:41:15 INFO - 'PAGER': '/bin/cat', 08:41:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:15 INFO - 'PWD': '/builds/slave/test', 08:41:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:15 INFO - 'SHELL': '/bin/bash', 08:41:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SD5nwqIdgP/Listeners', 08:41:15 INFO - 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', 08:41:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:15 INFO - 'USER': 'cltbld', 08:41:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:15 INFO - 'XPC_FLAGS': '0x0', 08:41:15 INFO - 'XPC_SERVICE_NAME': '0', 08:41:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:41:15 INFO - Cleaning up... 08:41:16 INFO - Return code: 0 08:41:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:41:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:16 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 0x10db00b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db03768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8150c76e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d811d30>, '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 0x10d7c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d805be8>, '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.PPZKt5CQ6p/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.SD5nwqIdgP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:41:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:41:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:41:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PPZKt5CQ6p/Render', 08:41:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:16 INFO - 'HOME': '/Users/cltbld', 08:41:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:16 INFO - 'LOGNAME': 'cltbld', 08:41:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:16 INFO - 'MOZ_NO_REMOTE': '1', 08:41:16 INFO - 'NO_EM_RESTART': '1', 08:41:16 INFO - 'PAGER': '/bin/cat', 08:41:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:16 INFO - 'PWD': '/builds/slave/test', 08:41:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:16 INFO - 'SHELL': '/bin/bash', 08:41:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SD5nwqIdgP/Listeners', 08:41:16 INFO - 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', 08:41:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:16 INFO - 'USER': 'cltbld', 08:41:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:16 INFO - 'XPC_FLAGS': '0x0', 08:41:16 INFO - 'XPC_SERVICE_NAME': '0', 08:41:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:16 INFO - Downloading/unpacking blobuploader==1.2.4 08:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:17 INFO - Downloading blobuploader-1.2.4.tar.gz 08:41:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:41:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:41:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:41:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:18 INFO - Downloading docopt-0.6.1.tar.gz 08:41:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:41:18 INFO - Installing collected packages: blobuploader, requests, docopt 08:41:18 INFO - Running setup.py install for blobuploader 08:41:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:41:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:41:18 INFO - Running setup.py install for requests 08:41:19 INFO - Running setup.py install for docopt 08:41:19 INFO - Successfully installed blobuploader requests docopt 08:41:19 INFO - Cleaning up... 08:41:19 INFO - Return code: 0 08:41:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:19 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 0x10db00b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db03768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8150c76e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d811d30>, '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 0x10d7c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d805be8>, '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.PPZKt5CQ6p/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.SD5nwqIdgP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:41:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:41:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:41:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PPZKt5CQ6p/Render', 08:41:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:19 INFO - 'HOME': '/Users/cltbld', 08:41:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:19 INFO - 'LOGNAME': 'cltbld', 08:41:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:19 INFO - 'MOZ_NO_REMOTE': '1', 08:41:19 INFO - 'NO_EM_RESTART': '1', 08:41:19 INFO - 'PAGER': '/bin/cat', 08:41:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:19 INFO - 'PWD': '/builds/slave/test', 08:41:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:19 INFO - 'SHELL': '/bin/bash', 08:41:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SD5nwqIdgP/Listeners', 08:41:19 INFO - 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', 08:41:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:19 INFO - 'USER': 'cltbld', 08:41:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:19 INFO - 'XPC_FLAGS': '0x0', 08:41:19 INFO - 'XPC_SERVICE_NAME': '0', 08:41:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:41:19 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-JfFz1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:41:19 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-Hiiar8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:41:19 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-gtGvsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:41:20 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-fChSyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:41:20 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-uQazUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:41:20 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-HAvBiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:41:20 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-lbRedF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:41:20 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-PiuyO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:41:20 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-VEzBI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:41:20 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-fCzmAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:41:20 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-aMtvqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:41:20 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-nhUEaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:41:21 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-gDL5sV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:41:21 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-hutAa6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:21 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-q6LDso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:41:21 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-zx5Av1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:41:21 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-1nu_YL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:41:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:41:21 INFO - Running setup.py install for manifestparser 08:41:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:41:21 INFO - Running setup.py install for mozcrash 08:41:21 INFO - Running setup.py install for mozdebug 08:41:21 INFO - Running setup.py install for mozdevice 08:41:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:41:22 INFO - Running setup.py install for mozfile 08:41:22 INFO - Running setup.py install for mozhttpd 08:41:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:41:22 INFO - Running setup.py install for mozinfo 08:41:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:41:22 INFO - Running setup.py install for mozInstall 08:41:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:41:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:41:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:41:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:41:22 INFO - Running setup.py install for mozleak 08:41:22 INFO - Running setup.py install for mozlog 08:41:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:41:22 INFO - Running setup.py install for moznetwork 08:41:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:41:23 INFO - Running setup.py install for mozprocess 08:41:23 INFO - Running setup.py install for mozprofile 08:41:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:41:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:41:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:41:23 INFO - Running setup.py install for mozrunner 08:41:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:41:23 INFO - Running setup.py install for mozscreenshot 08:41:23 INFO - Running setup.py install for moztest 08:41:23 INFO - Running setup.py install for mozversion 08:41:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:41:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:41:24 INFO - Cleaning up... 08:41:24 INFO - Return code: 0 08:41:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:24 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 0x10db00b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db03768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8150c76e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d811d30>, '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 0x10d7c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d805be8>, '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.PPZKt5CQ6p/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.SD5nwqIdgP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:41:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:41:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:41:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PPZKt5CQ6p/Render', 08:41:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:24 INFO - 'HOME': '/Users/cltbld', 08:41:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:24 INFO - 'LOGNAME': 'cltbld', 08:41:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:24 INFO - 'MOZ_NO_REMOTE': '1', 08:41:24 INFO - 'NO_EM_RESTART': '1', 08:41:24 INFO - 'PAGER': '/bin/cat', 08:41:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:24 INFO - 'PWD': '/builds/slave/test', 08:41:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:24 INFO - 'SHELL': '/bin/bash', 08:41:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SD5nwqIdgP/Listeners', 08:41:24 INFO - 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', 08:41:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:24 INFO - 'USER': 'cltbld', 08:41:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:24 INFO - 'XPC_FLAGS': '0x0', 08:41:24 INFO - 'XPC_SERVICE_NAME': '0', 08:41:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:41:24 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-QNob03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:41:24 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:41:24 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-AjTo1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:41:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:41:24 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-nUBq7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:41:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:41:24 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-vrfu3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:41:24 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)) 08:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:41:24 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-EHUeV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:41:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:41:24 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-fX_KFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:41:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:41:24 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-a2DRZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:41:25 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-GYNSqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:41:25 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-yBmrF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:41:25 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-PSpDzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:41:25 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-52yExC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:41:25 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-8fyq5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:41:25 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)) 08:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:41:25 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-ozbxYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:41:25 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-Cj2E2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:25 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-YXImQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:41:25 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-D0fLkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:41:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:41:26 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-wMUBT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:41:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:41:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:41:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:41:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:41:26 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)) 08:41:26 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)) 08:41:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:41:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:27 INFO - Downloading blessings-1.6.tar.gz 08:41:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:41:27 INFO - Installing collected packages: blessings 08:41:27 INFO - Running setup.py install for blessings 08:41:27 INFO - Successfully installed blessings 08:41:27 INFO - Cleaning up... 08:41:27 INFO - Return code: 0 08:41:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:41:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:41:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:41:28 INFO - Reading from file tmpfile_stdout 08:41:28 INFO - Current package versions: 08:41:28 INFO - blessings == 1.6 08:41:28 INFO - blobuploader == 1.2.4 08:41:28 INFO - docopt == 0.6.1 08:41:28 INFO - functools32 == 3.2.3-2 08:41:28 INFO - jsonschema == 2.5.1 08:41:28 INFO - manifestparser == 1.1 08:41:28 INFO - mozInstall == 1.12 08:41:28 INFO - mozcrash == 1.0 08:41:28 INFO - mozdebug == 0.1 08:41:28 INFO - mozdevice == 0.50 08:41:28 INFO - mozfile == 1.2 08:41:28 INFO - mozhttpd == 0.7 08:41:28 INFO - mozinfo == 0.9 08:41:28 INFO - mozleak == 0.1 08:41:28 INFO - mozlog == 3.4 08:41:28 INFO - moznetwork == 0.27 08:41:28 INFO - mozprocess == 0.25 08:41:28 INFO - mozprofile == 0.28 08:41:28 INFO - mozrunner == 6.13 08:41:28 INFO - mozscreenshot == 0.1 08:41:28 INFO - mozsystemmonitor == 0.3 08:41:28 INFO - moztest == 0.8 08:41:28 INFO - mozversion == 1.4 08:41:28 INFO - psutil == 3.1.1 08:41:28 INFO - requests == 1.2.3 08:41:28 INFO - wsgiref == 0.1.2 08:41:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41: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')]} 08:41:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41: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')]} 08:41:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:28 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 0x10db00b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db03768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8150c76e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d811d30>, '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 0x10d7c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d805be8>, '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.PPZKt5CQ6p/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.SD5nwqIdgP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:41:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:41:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:41:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PPZKt5CQ6p/Render', 08:41:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:28 INFO - 'HOME': '/Users/cltbld', 08:41:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:28 INFO - 'LOGNAME': 'cltbld', 08:41:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:28 INFO - 'MOZ_NO_REMOTE': '1', 08:41:28 INFO - 'NO_EM_RESTART': '1', 08:41:28 INFO - 'PAGER': '/bin/cat', 08:41:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:28 INFO - 'PWD': '/builds/slave/test', 08:41:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:28 INFO - 'SHELL': '/bin/bash', 08:41:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SD5nwqIdgP/Listeners', 08:41:28 INFO - 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', 08:41:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:28 INFO - 'USER': 'cltbld', 08:41:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:28 INFO - 'XPC_FLAGS': '0x0', 08:41:28 INFO - 'XPC_SERVICE_NAME': '0', 08:41:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:41:28 INFO - Cleaning up... 08:41:28 INFO - Return code: 0 08:41:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:41: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')]} 08:41:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41: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')]} 08:41:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:28 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 0x10db00b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db03768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8150c76e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d811d30>, '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 0x10d7c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d805be8>, '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.PPZKt5CQ6p/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.SD5nwqIdgP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:41:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:41:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:41:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PPZKt5CQ6p/Render', 08:41:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:28 INFO - 'HOME': '/Users/cltbld', 08:41:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:28 INFO - 'LOGNAME': 'cltbld', 08:41:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:28 INFO - 'MOZ_NO_REMOTE': '1', 08:41:28 INFO - 'NO_EM_RESTART': '1', 08:41:28 INFO - 'PAGER': '/bin/cat', 08:41:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:28 INFO - 'PWD': '/builds/slave/test', 08:41:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:28 INFO - 'SHELL': '/bin/bash', 08:41:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SD5nwqIdgP/Listeners', 08:41:28 INFO - 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', 08:41:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:28 INFO - 'USER': 'cltbld', 08:41:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:28 INFO - 'XPC_FLAGS': '0x0', 08:41:28 INFO - 'XPC_SERVICE_NAME': '0', 08:41:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:41:28 INFO - Cleaning up... 08:41:28 INFO - Return code: 0 08:41:28 INFO - Running post-action listener: _resource_record_post_action 08:41:28 INFO - Running post-action listener: _start_resource_monitoring 08:41:28 INFO - Starting resource monitoring. 08:41:28 INFO - [mozharness: 2017-05-10 15:41:28.696078Z] Finished create-virtualenv step (success) 08:41:28 INFO - [mozharness: 2017-05-10 15:41:28.697022Z] Running install step. 08:41:28 INFO - Running pre-action listener: _resource_record_pre_action 08:41:28 INFO - Running main action method: install 08:41:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:41:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:41:28 INFO - Reading from file tmpfile_stdout 08:41:28 INFO - Detecting whether we're running mozinstall >=1.0... 08:41:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:41:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:41:29 INFO - Reading from file tmpfile_stdout 08:41:29 INFO - Output received: 08:41:29 INFO - Usage: mozinstall [options] installer 08:41:29 INFO - Options: 08:41:29 INFO - -h, --help show this help message and exit 08:41:29 INFO - -d DEST, --destination=DEST 08:41:29 INFO - Directory to install application into. [default: 08:41:29 INFO - "/builds/slave/test"] 08:41:29 INFO - --app=APP Application being installed. [default: firefox] 08:41:29 INFO - mkdir: /builds/slave/test/build/application 08:41:29 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'] 08:41:29 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 08:41:49 INFO - Reading from file tmpfile_stdout 08:41:49 INFO - Output received: 08:41:49 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:41:49 INFO - Running post-action listener: _resource_record_post_action 08:41:49 INFO - [mozharness: 2017-05-10 15:41:49.650763Z] Finished install step (success) 08:41:49 INFO - [mozharness: 2017-05-10 15:41:49.650921Z] Running run-tests step. 08:41:49 INFO - Running pre-action listener: _resource_record_pre_action 08:41:49 INFO - Running main action method: run_tests 08:41:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:41:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:41:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:41:49 INFO - 2017-05-10 08:41:49.665 screenresolution[1630:8463] starting screenresolution argv=screenresolution get 08:41:49 INFO - 2017-05-10 08:41:49.667 screenresolution[1630:8463] Display 0: 1600x1200x32@60 08:41:49 INFO - 2017-05-10 08:41:49.673 screenresolution[1631:8465] starting screenresolution argv=screenresolution list 08:41:49 INFO - Available Modes on Display 0 08:41:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:41:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:41:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:41:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:41:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:41:49 INFO - Intel Iris: 08:41:49 INFO - Chipset Model: Intel Iris 08:41:49 INFO - Type: GPU 08:41:49 INFO - Bus: Built-In 08:41:49 INFO - VRAM (Dynamic, Max): 1536 MB 08:41:49 INFO - Vendor: Intel (0x8086) 08:41:49 INFO - Device ID: 0x0a2e 08:41:49 INFO - Revision ID: 0x0009 08:41:49 INFO - Displays: 08:41:49 INFO - Display: 08:41:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:41:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:41:49 INFO - Display Serial Number: 1600x1200 60 08:41:49 INFO - Main Display: Yes 08:41:49 INFO - Mirror: Off 08:41:49 INFO - Online: Yes 08:41:49 INFO - Rotation: Supported 08:41:49 INFO - Return code: 0 08:41:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:41:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:41:49 INFO - Python 2.7.3 08:41:49 INFO - Return code: 0 08:41:49 INFO - grabbing minidump binary from tooltool 08:41:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:49 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 0x10d811d30>, '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 0x10d7c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d805be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:41:49 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:41:49 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:41:49 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:41:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:41:50 INFO - Return code: 0 08:41:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:41:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:41:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:41:50 INFO - ENV: RUST_BACKTRACE is now 1 08:41:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:41:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:41:50 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/E_59EUdWTLWqPg30BD7Xiw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0254', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:41:50 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/E_59EUdWTLWqPg30BD7Xiw/artifacts/public/build/target.crashreporter-symbols.zip --title t-yosemite-r7-0254 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:41:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PPZKt5CQ6p/Render', 08:41:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:50 INFO - 'HOME': '/Users/cltbld', 08:41:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:50 INFO - 'LOGNAME': 'cltbld', 08:41:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:41:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:41:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:50 INFO - 'MOZ_NO_REMOTE': '1', 08:41:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:41:50 INFO - 'NO_EM_RESTART': '1', 08:41:50 INFO - 'PAGER': '/bin/cat', 08:41:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:50 INFO - 'PWD': '/builds/slave/test', 08:41:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:41:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:50 INFO - 'RUST_BACKTRACE': '1', 08:41:50 INFO - 'SHELL': '/bin/bash', 08:41:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SD5nwqIdgP/Listeners', 08:41:50 INFO - 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', 08:41:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:50 INFO - 'USER': 'cltbld', 08:41:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:50 INFO - 'XPC_FLAGS': '0x0', 08:41:50 INFO - 'XPC_SERVICE_NAME': '0', 08:41:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:50 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/E_59EUdWTLWqPg30BD7Xiw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0254', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:41:50 INFO - mozversion application_buildid: 20170510061209 08:41:50 INFO - mozversion application_changeset: ebbcdaa5b5802ecd39624dd2acbdda8547b8384d 08:41:50 INFO - mozversion application_display_name: Nightly 08:41:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:41:50 INFO - mozversion application_name: Firefox 08:41:50 INFO - mozversion application_remotingname: firefox 08:41:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:41:50 INFO - mozversion application_vendor: Mozilla 08:41:50 INFO - mozversion application_version: 55.0a1 08:41:50 INFO - mozversion platform_buildid: 20170510061209 08:41:50 INFO - mozversion platform_changeset: ebbcdaa5b5802ecd39624dd2acbdda8547b8384d 08:41:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:41:50 INFO - mozversion platform_version: 55.0a1 08:41:50 INFO - using testdate: 1494430910 08:41:50 INFO - actual date: 1494430910 08:41:50 INFO - starting webserver on 'localhost:49240' 08:41:50 INFO - SUITE-START | Running 2 tests 08:41:50 INFO - TEST-START | dromaeo_css 08:41:50 INFO - operating with platform_type : mac_ 08:41:50 INFO - Initialising browser for dromaeo_css test... 08:41:50 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/tmp23Sfui/profile http://localhost:49240/getInfo.html) 08:41:52 INFO - PID 1641 | __metrics Screen width/height:1600/1200 08:41:52 INFO - PID 1641 | colorDepth:24 08:41:52 INFO - PID 1641 | Browser inner width/height: 1024/691 08:41:52 INFO - PID 1641 | __metrics 08:41:52 INFO - PID 1641 | 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" 08:41:52 INFO - PID 1641 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:41:53 INFO - TEST-INFO | 1641: exit 0 08:41:53 INFO - Browser initialized. 08:41:53 INFO - Running cycle 1/1 for dromaeo_css test... 08:41:53 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/tmp23Sfui/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:42:05 INFO - PID 1644 | RSS: Main: 234958848 08:42:05 INFO - PID 1644 | 08:45:09 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 08:45:11 INFO - PID 1644 | RSS: Main: 354463744 08:45:11 INFO - PID 1644 | 08:48:14 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 08:48:15 INFO - PID 1644 | RSS: Main: 364584960 08:48:15 INFO - PID 1644 | 08:51:17 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 08:51:17 INFO - PID 1644 | RSS: Main: 331722752 08:51:17 INFO - PID 1644 | 08:54:20 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 08:54:20 INFO - PID 1644 | RSS: Main: 323891200 08:54:20 INFO - PID 1644 | 08:57:24 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 08:57:24 INFO - PID 1644 | RSS: Main: 328724480 08:57:24 INFO - PID 1644 | 09:00:27 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 09:00:27 INFO - PID 1644 | RSS: Main: 373600256 09:00:27 INFO - PID 1644 | 09:00:27 INFO - PID 1644 | __start_tp_report 09:00:27 INFO - PID 1644 | _x_x_mozilla_page_load 09:00:27 INFO - PID 1644 | _x_x_mozilla_page_load_details 09:00:27 INFO - PID 1644 | |i|pagename|runs| 09:00:27 INFO - PID 1644 | |0;dojo.html;3564.1980554375286;3575.999999999998;3607.22444674395;3611.295797319522;3638.727095467839;5201.505856943589;6138.8465288367815;6218.564700470969;6237.5009999200065;6293.804177206328;6169;6215.844603884894;6259.937400625992;6260.718267677954;6265.498760099193;5219.321488206528;5267.868303292429;5388.7305634718305;5414.972925135369;5452.536534394581;5444.455554444544;5493.093639549469;5498.917516237259;5508.476694713996;5513.9448605513835;5326.2543243945875;5398.325209348832;5412.702301373423;5431.8098866539485;5481.862953426176;4481.686281960264;5452.291202143736;5472.945270547283;5491.862703432406;5512.200730893998;5359.678419294854;5407.648502847303;5410.594205434608;5424.484673955968;5493.505584497374;6096.96951515244;6172.7530898764;6245.779207881471;6287.654179020152;6304.27500837405;6457.677116144221;6531.771388001444;6625.17185351831;6644.4020038196795;6648.634325112117;5599.32808063035;6728.9663551682415;6735.8989615155815;6743.561668491532;6745.595264284109;6164.291106522807;6291.43377096059;6293.559450838397;6331.746730130835;6340.587861789015;6620.172478440195;6710.16122984627;6837.726490940406;6936.445084393236;6947.756828510978;6473.352664733583;6483.902741458882;6485.156929599217;6493.675316234169;6494.447971922439;6649.867002660017;6663.200415950117;6710.966445167841;6726.865462690719;6728.024436456784;6374.649394283359;6607;6608.669566521751;6616.371444712745;6632.436242919406;6388.840278993062;6540.084388185658;6631.137952066297;6633.071370008202;6637.1703537057865;5286.577073834084;5295.947040529545;5303.04545181871;5304.177852432879;5328.4671532846405;4678.415198100238;4739.123262196505;4739.265413860857;4742.857714268577;4749.097671442415;6203.658798766111;6263.749450022039;6276.435120839146;6277.780277690259;6328.46208072319;6734.865302693918;6738.19141702989;6758.898616520756;6764.56030358035;6769.966150169316;6331.145295385156;6334.429901308904;6334.968325158345;6357.809265722036;6359.17330747;5741.45456181662;5843;5849.385814489502;5852.414758524199;5921.851953701192;6042.214512113573;6763.5265531413315;6857.245702972569;6930.965345173242;6943.062686537252;6499.870002599827;6570;6582;6617.900731489128;6732.293109223461;6886.10480637514;6929.514933954575;6932.792016239521;6949.131358580177;6952.582845029315;6614.404703576702;6619.900701489578;6620.205575330991;6626.105475760711;6629.7348106075215;6533.640649764308;6562.606243625398;6599.340065993362;6730.730770769114;6750.932490675031;5429;6469.417752402306;6520.967395162994;6542.411182993554;6548.443382312556;6462.321456247027;6498.122753428416;6524.641144737085;6525.119108920425;6534.705938232696;6225.346338634378;6257.2491301044165;6382.5532212744665;6386.68066596659;6392.3927226913365;6362.204724409449;6434.517411194272;6513;6513.413792758674;6548.541602087808;6346.492280617447;6349.746010159542;6352.301246862934;6355.459785918249;6365.809025729235 09:00:27 INFO - PID 1644 | |1;ext.html;795.1889073145392;807.7818988873005;1095.5289225632976;1127.1546340244815;1127.9266847654897;33775.83112084439;34196.48705269423;34289.14277143073;34330.82834585824;34339;36809;37044.25911481769;37092.62907370926;37109.25781484369;37130.62869371306;5872.17789509469;5956.076808094752;8141.755747327575;8301.252887240147;8327.916720832774;8196.631151598163;8354.415190936637;8360.916390836104;8369.204925532065;8372.916270837275;8445.36659750518;8464.449810762311;8482.87275690862;8499.150084991514;8536.317094632446;5946.910796338058;6036.486898613623;8388.8741668875;8428.873566896471;8443.366747493963;8084.717034903751;8227.917720822776;8233.053198882086;8235;8237;35212.82393588016;35456.46815297772;35529.46705799415;35612.82193589042;35617;2935.3248752786767;3630.2920930418577;3630.6006339302658;3633.2370202257557;3635.618260082706;29119.41761164786;29223.2694182645;29247;29295;29341.53292335375;3061.663217046123;3133.7336326412283;3155.1323386069016;3168.493041113411;3172.4289627866974;282189.5890520534;282384;282407;282689;283093;37647.4352884707;37693;37754;47026;47260.527394725614;46822;46946.765266173454;47010.059798803835;47011.82470438198;47407.76296118566;11040.503177357039;13224.471021159046;13227.941764658804;13230.73538529224;13235;10856.294340867818;10861.782764344827;10869.40218287986;10873.891261087289;10901.454927253606;11676.76646467066;11690.532378704927;11704;11761.764764704658;11860.347680877634;5266.236395722675;5292.153255479182;5296.496832800878;5308.973455132699;5328.600354973392;891.8895974511645;988.229181238635;1010.4947526236881;1023.82083135451;1029.5675816157232;23133.84330783454;23144.3056708299;23263.76736232616;23301.883490582437;23501.41246468818;990.5641517732175;1027.3630349183404;1144.370596172102;1146.1804809561204;1158.252926862186;10207.693769186937;10705.946470267754;12033.278003319829;12044.39778011096;12064.276143431422;293552;293617;293640;294028;295500;48361.27458088131;48422;48442.27336589954;48508.02983940372;49567.50432495701;1501.3169008101288;1552.7826104345402;1558.041804290376;1563.6012816731889;1569.9293531791097;23032;23091.307260782203;23183.53632927366;23185.76814231836;23413.882930585238;35914.46128308025;35978;35992.8200359007;36038.4594231092;36068.63931360758;256904.46433035194;256990;257394;257843;260077;27848.582271265543;28002.57996130019;31880;32115.839420802746;32196.83901580477;39719.623831974604;40681.79659101686;40723.796381017906;40764.1847163061;40782.9804254896;27249.863750681914;28592.42815143727;28623.566996805504;29407.26481837971;29615.407691846474;22983.655245171;29217.85391073031;29315.41369172562;29367.55948660729;29832.85083574568;35545.82227088848;35852.82073589615;36012.27975440529;36028.4595731059;36047.098822529646;28250.587470625975;28506.57240141441;29693.40613187681;29764.255893602833;30075.24811879633;22652;23483.64774528349;23511.882440587688;23718.52562948766;23854.825405554308 09:00:27 INFO - PID 1644 | |2;jquery.html;435.28395788927236;439.39144285165037;441.41071669321457;448.7868262575277;454.81352645415365;18746.718799218004;20738.585228295444;21178.83516406597;21391;21391.35825925223;21486.785132148674;21613.351599452002;22219.111235550597;22345.776542234573;23718.5256294874;5898.439648233411;6169.969150154243;6170.197874276338;6185.6597887116195;6186.597871138384;5724.856878578027;6051.848703782397;6086.147939288503;6100.511959043266;6105.297890742555;5813.331466881321;6044.607100538473;6058.878822423549;6071.939280607182;6089.969550152243;5959.493443057324;6071.332153463116;6085.995810691231;6091.664958427285;6096.664683442409;5302.602304827154;5328.6802791832615;5396.136618141118;5398.730063496849;5419.3225846769155;26783.464330713472;27031.459370812474;27668;28255.576166357314;28301.433971320457;2189.1134090693135;2277.794998450131;2281.3840263128864;2282.509260508982;2283.6117859963847;17812.931224126594;17894.91052544742;17964.640707185914;18090.819091809044;18303.90176589409;2105.599936012168;2113.6723807809813;2145;2149.580831737812;2159.6976423300753;155172;155278.1180470486;157601;158447;160803;11819.349935753617;12409.317487538272;12417;12429.75140497185;12497.687557810945;16666.749998749787;16680.999140051637;16702.832971670126;16727.749083763752;16739.91630041842;7558.962205189049;8734.956325218332;8931.73204803857;8944.8658270126;9022.593983270768;8468.661253549912;8469.280111190494;8488.448250863674;8676.262517686067;8690.391672582986;6545.378189072126;7779.202963505851;7895.328897043701;7946.404019698546;7947.602619869099;1796.6496533175905;1843.797182309945;2063.1541068161982;2106.157112526539;2290.8500811384347;947.3415975896824;949.9810003800023;955.5938726041404;963.1187463470845;1002.6039714312806;18738.90630546866;21053.894730526248;21068.894655526932;21166.47083822886;21233.469163271042;962.7400601837464;967.6419724701906;976.6386437018207;1001.9549120289604;1004.9296549241483;9128.42340857087;10578.259521833397;10910.945445272722;11027.481878035782;11045.33727976324;524715;530409;535472;549394;550565;83614;98223.50888245513;105041.47479262555;105145.94854051362;119182.40408797901;1008.7629407089328;1076.8923107689325;1187.590281352932;1189.2151180221013;1191.642507247822;21180.83505407156;21372.465688357915;22132.114715411848;22186.00162992637;22456.88771556132;51879.48120518746;51920.1059920515;53699.46300536945;54071;54178;69673;70201.29798702152;70702.64648676723;71699;71787.64106179436;8590.91409085901;8638.222559969632;8756.4308319959;8928.285737141143;9078.818423631623;14123.43506259738;14165.575032749033;14317.785233221302;14562.927185364006;14795.926020369829;11866.881331186923;11886.465109070286;12035.398230088636;12185.207961482476;12290.324032178316;10627.946860265649;11301.491432885705;11466.312021278416;11505.079593632656;11721.06231501495;11959.521619135485;12004.699882503008;12173.39133043362;12286.447109880255;12371.443285052374;8799;8886.111388861062;8897.688580899638;8956.238719708637;9064.592093355946;11728.061755059403;11827.467763950472;12015;12056.578019769266;12118.636440906786 09:00:27 INFO - PID 1644 | |3;mootools.html;1402.8456869744327;1451.114819959825;1463.5097242423788;1469.3323078306123;1476.9187694676789;10726.35641861488;11181.944090279558;11200.215984881052;11203.439828008588;11208.775824483515;10571;10953.371190914182;11111.611093611726;11146.777064458705;11151.219414640978;2426.575349313872;2468.308873515419;2470.814688898331;2471.5180539794746;2473.6413220083077;2389.545986262613;2394.7493199570813;2433.2821817563863;2433.8052955763583;2441.7436169202247;2363.1728894886737;2454.349597356702;2460.052879641333;2463.1379017343966;2466.235467005234;2403.6995375578053;2446.999999999991;2449.7550244975537;2462.2982450001664;2468.7778099971;2363.8108951283857;2387.9164229252065;2392.09100541793;2397.8561286322874;2399.196269249803;11036.448177591088;11266.985971262626;11288.604898828584;11298;11306.830397544043;6308.621482711006;6531.4448271896945;6539.313372095957;6540.542162048659;6543.869122617521;3901.8244179012013;4194.161167766429;4277.101808620194;4300.204462174508;4322.351647252905;1046.4414506531534;1049.422817450407;1207.402335843763;1232.2975903734875;1256.2776403567984;14274.429022839075;14534.927325363411;14547.272636368245;15407.61480962985;15486;5138.717370544656;5275.498827611371;5418.674879507243;5423.159410291411;5423.403425623178;11282.323060616389;11282.661520154244;11307.265027773168;11324.207305488702;11328.660140195807;6400.551961362753;6407.455366293917;6420.133282006869;6422.678866056678;6427.132337134521;5967.16459695643;6082.057281121433;6115.266168059772;6174.289956654952;6218.720157592919;4058.2189255747144;4154.626083652486;4192.916141677149;4232.576742325743;4240.5123410808155;1229.6495498782804;1230.1450491908038;1230.5389221556886;1244.775940330749;1249.1755441408627;784.5567254501188;797.6091715059695;817.1011886924335;819.4550623835202;845.3364109174391;4819.3012013257885;5941.643501389931;5981.342052374235;6045.002574575234;6312.084747711556;537.5028099008401;541.1720068295435;602.8251806975928;610.6824451285396;615.7844754336036;3824.5028146340796;4193.161367726467;4251.978740106341;4317.395564620955;4317.568243175658;13907.23510206928;14568.781468277984;14576.854231457763;14580.416783328548;14588.562343129723;11521.82717259225;11713.707157320965;14525.201113938834;14535.491257805927;14536.63658408527;7649.31156195945;7696.11494678108;7714.807129821799;7722.382209423233;7809.180036096128;5455.9454405455435;6705.262421133769;6877.862442751017;6917.896231556631;6944;12041.277523348626;12386.3187524687;12398.62804115878;12412.81380779307;12419.254844709347;12731.93634031824;12925.54760583375;12993.870061299265;13055.02087343472;13300.866991329964;7823.569703666125;8010.759677209693;8019.5990200490905;8025.117237103797;8050.637721302438;10296.124829389286;10321.225908057077;10414.895851041392;10419.06228439444;10461.163106951577;8846.911530884867;8854.645814167361;8866.64533418656;8870.911290887008;8929.464232146092;7665.808354791175;8552.059273480038;8663.6101375437;8668.176523230282;8748.431351962103;7699.846003080019;7879.0939042010905;7884.605769711607;7884.699024661096;7891.84216315659;5745.3105627324985;5867.266591676041;5902.439268269508;6026.216591843207;6027.758889644365;4402.493713223021;6019.638821670714;6069.757209711562;6099.878002440015;6143.447089761943 09:00:27 INFO - PID 1644 | |4;prototype.html;391.4558763318986;397.0510479952911;399.40488671878893;401.9296623090958;404.79962418602776;5981.730822113004;6036.909446358308;6040.879182416349;6041.788537401192;6084.330723620404;4768.833090841821;5103.030424219396;5611.607187496877;5862.970685146568;5943.88112237755;3930.941035884457;4105.876823695294;4182.07994241268;4516.277395616702;4531.006357202837;3728.4780130781714;3742;3768.284026035058;4501.234790085677;4552.271636538155;4417.779111044451;4457.621102206316;4505.414296141497;4509.503954565012;4524.457065152186;4484.618807401374;4500.8649740507835;4502.369668246448;4502.527234640348;4509.864704058867;3974.3641017437362;3975.7614543127215;3980.3631418972827;3998.3602623580086;4004.3593025115842;4811.542903424169;5677.687727175004;5766.606858153861;5813.88372232553;5847.853803654943;5360.463953604647;5367.75845086972;5373.226835144393;5378.838634840961;5381.596380271495;5544.77820887168;5843.152742852305;6057.666828324441;6344.873102537969;6361.650109243989;4477.417935668374;4505.193111820539;4528.909421811578;4540.205464043779;4543.727376357429;5494.549414973884;6510.283868774431;6666.500012499034;6728.764493242762;6729.192496900306;4635.837745678885;4757.548032936935;4784.067106914118;4787.497312782108;4792.771361316934;4872.585830204402;4894.629503738959;4903.656744027884;4906.337644418029;4920.6555541111775;5365.597580181424;5393.191021346829;5436.755346009439;5458.563314934796;5491.917621235684;5432.320959880015;6363.936360636427;6366.981282994699;6424.582402143846;6443.548951573345;1458.6207586027497;1605.3658804772049;1649.4062137630444;1666.1835700506665;1675.2042779679798;1062.6865074802952;1138.2771939818274;1156.4969238381163;1160.878107798686;1162.91859569831;5608.551315894719;5610.943890561124;5787.623804452697;6047.853012180701;6050.273967123973;6555.180602424697;6587.143671322793;6589.242237142694;6617.205935287796;6704.898542326459;5064.974675126601;5882.588218824641;5982.042873140276;6031.8793624127275;6076.665783381868;3044.4672182368;3045.649750278702;3438.6905178534053;3472.041872265619;3480.6693364130874;4963.751812409365;5722.484976352148;5933.110033495011;6015.766767812588;6785.796426107225;5827.446392592697;6076.5442591805795;6677.232118306457;6749.190097188369;6799.218089919624;5717.942820571908;5740.1102829061565;5961.36356822338;6362.981922892315;6468.967655161694;6628.403443690091;6636.2700102987665;6638.535302528777;6653.2348779889;6677.165354330708;5181.512873820512;5301.363836339664;6523.967380163069;6539.901901471387;6578.80263592093;6390.233172019201;6775.695093720893;6839.922035084332;6857.862842743217;6901.482388820758;4284;4284.871453856389;4321.762303073361;4326.437563116775;4331.155424692155;5782.017057100219;6394.840128996812;6502.902456463063;6607.669616519251;6639.170103737033;5333.413324534221;5560.555155587463;6100.8779824404155;6195.690215489298;6406.711697973509;5167.689938603546;5629.380768115422;6243.219597550306;6390.584612000205;6401.167848179894;6246.750129994749;6250.874982500415;6254.655993920378;6257.906131408124;6264.624122552661;5934.931712291829;5940.287165540163;6365.267994180728;6372.872542549216;6393.93606063952;5190.922136168036;5279.604029697711;6177.722002509988;6213.720382582705;6225.31521532622 09:00:27 INFO - PID 1644 | |5;yui.html;753.2505157368417;822.1367564057746;822.2476434062833;844.0757370679108;852.313887320707;16276.43032493863;16513.91743041286;16686.16569171541;16686.916565417185;16689.24898379573;14894.925525372386;15339.926205165642;15499.380024799022;15504.689906201897;15533.53399398017;971.825071487132;976.72651657536;979.3291595257236;979.9857147851975;982.0277924854379;1007.7480629842539;1009.6415772400802;1009.7576581620432;1011.5700827148469;1015.532854886753;998.9960090109466;1003.9799204015916;1005.2209537608339;1005.8038682456923;1020.6733845169549;996.9451680157624;998.5556427389814;999.6151481679533;999.7550600102949;1035.585765693721;761.0942977856389;762.5729591428818;763.6678045050421;764.0296823034715;766.9923300767033;16657.16714164299;16888.662226755518;17055.829441705548;17062.48812535626;17450.563735906704;17256.56858578533;17340.479785606327;17593.472195834016;17641.294348226056;17829.286828526845;13127.343632818322;13144.60566183016;13275.734485310337;13283.136596121318;13458.125221860548;3447.1382154461385;3464.0300715799362;3476.096214984097;3478.4608385700003;3480.3735327641016;81083.18916810815;129800;130613.34693326568;131738;134530.6546934528;11148.777024459465;11435.970762631403;13673.111247768864;14038.1577105374;14110.941679374087;19102.23591056342;25100.497990040098;25127.497450050898;25383.61924571133;25412.872935635205;7393.297636724503;7467.7012919483695;7470.215627359158;7475.9252407476315;7476.177620461854;3487.4071407860724;3613.512175856278;3652.196516766307;3703.6111208322736;3710.276496083238;4078.367852982733;4150.398192262105;4152.1280531088805;4157.8960525987095;4158.500979882373;880.7093659092484;918.2929144558652;923.6259314977444;924.5146298193503;926.9536523173814;541.8428655689805;645.6384424722171;653.8953767397194;669.4811521071111;693.2201273567237;10142.746431339276;10755;11399.860013998534;11987.940060299643;12176.756464870654;637.7799659117597;641.884460797061;651.9576227545194;653.5817077070678;674.4840197249108;5087.465816089331;5309.628326017141;5582.804601838916;5599.869124871721;5634.04221282383;105510.4173437399;106030.46984765181;106645;107892.92107078829;108668.4566577162;90644;96665.03334966561;96766.51616741871;97337;98540;83707.5814620923;83841.90395240168;84496.73254901181;84743.3051338982;84775;11124.110071194447;11126.944365278121;11207.775844482901;11282;11371.943140284577;40678.59321406748;40682.79658601688;40738;41528.377074343305;41710.1657966845;51629.741851290506;51823.22265166101;52204.43386698405;52309;53192.2021169675;13992.440302387791;14001;14134.929325353307;14188;14345.64135896611;14227.430902764188;15605.765913511534;15637.765433518734;15671.216439177768;15758.842411575737;13648.181109133484;13756.587302380945;13793.172409655454;13996.650083747987;14080.859191407955;14238.857611424168;14492.782608261095;14512;14613.269336532918;14826.184559849311;13903.235322056978;14075.788863167265;14285;14432.061915975428;14436.639084022983;10115.696529104138;10455.320404174008;10523.736906577396;10670.57317707314;10745.516451759846;10774.407407592658;11172.720681983015;11461.942690286494;11816.704582385166;11834.289942603471 09:00:27 INFO - PID 1644 | __end_tp_report 09:00:27 INFO - PID 1644 | __start_cc_report 09:00:27 INFO - PID 1644 | _x_x_mozilla_cycle_collect,1840 09:00:27 INFO - PID 1644 | __end_cc_report 09:00:27 INFO - PID 1644 | __startTimestamp1494432027429__endTimestamp 09:00:27 INFO - PID 1644 | 09:00:27 INFO - PID 1644 | ------- Summary: start ------- 09:00:27 INFO - PID 1644 | Number of tests: 6 09:00:27 INFO - PID 1644 | 09:00:27 INFO - PID 1644 | [#0] dojo.html Cycles:165 Average:6128.28 Median:6357.81 stddev:721.09 (11.3%) stddev-sans-first:694.68 09:00:27 INFO - PID 1644 | Values: 3564.2 3576.0 3607.2 3611.3 3638.7 5201.5 6138.8 6218.6 6237.5 6293.8 6169.0 6215.8 6259.9 6260.7 6265.5 5219.3 5267.9 5388.7 5415.0 5452.5 5444.5 5493.1 5498.9 5508.5 5513.9 5326.3 5398.3 5412.7 5431.8 5481.9 4481.7 5452.3 5472.9 5491.9 5512.2 5359.7 5407.6 5410.6 5424.5 5493.5 6097.0 6172.8 6245.8 6287.7 6304.3 6457.7 6531.8 6625.2 6644.4 6648.6 5599.3 6729.0 6735.9 6743.6 6745.6 6164.3 6291.4 6293.6 6331.7 6340.6 6620.2 6710.2 6837.7 6936.4 6947.8 6473.4 6483.9 6485.2 6493.7 6494.4 6649.9 6663.2 6711.0 6726.9 6728.0 6374.6 6607.0 6608.7 6616.4 6632.4 6388.8 6540.1 6631.1 6633.1 6637.2 5286.6 5295.9 5303.0 5304.2 5328.5 4678.4 4739.1 4739.3 4742.9 4749.1 6203.7 6263.7 6276.4 6277.8 6328.5 6734.9 6738.2 6758.9 6764.6 6770.0 6331.1 6334.4 6335.0 6357.8 6359.2 5741.5 5843.0 5849.4 5852.4 5921.9 6042.2 6763.5 6857.2 6931.0 6943.1 6499.9 6570.0 6582.0 6617.9 6732.3 6886.1 6929.5 6932.8 6949.1 6952.6 6614.4 6619.9 6620.2 6626.1 6629.7 6533.6 6562.6 6599.3 6730.7 6750.9 5429.0 6469.4 6521.0 6542.4 6548.4 6462.3 6498.1 6524.6 6525.1 6534.7 6225.3 6257.2 6382.6 6386.7 6392.4 6362.2 6434.5 6513.0 6513.4 6548.5 6346.5 6349.7 6352.3 6355.5 6365.8 09:00:27 INFO - PID 1644 | 09:00:27 INFO - PID 1644 | [#1] ext.html Cycles:180 Average:41932.76 Median:3161.81 stddev:72978.34 (2308.1%) stddev-sans-first:73117.70 09:00:27 INFO - PID 1644 | Values: 795.2 807.8 1095.5 1127.2 1127.9 33775.8 34196.5 34289.1 34330.8 34339.0 36809.0 37044.3 37092.6 37109.3 37130.6 5872.2 5956.1 8141.8 8301.3 8327.9 8196.6 8354.4 8360.9 8369.2 8372.9 8445.4 8464.4 8482.9 8499.2 8536.3 5946.9 6036.5 8388.9 8428.9 8443.4 8084.7 8227.9 8233.1 8235.0 8237.0 35212.8 35456.5 35529.5 35612.8 35617.0 2935.3 3630.3 3630.6 3633.2 3635.6 29119.4 29223.3 29247.0 29295.0 29341.5 3061.7 3133.7 3155.1 3168.5 3172.4 282189.6 282384.0 282407.0 282689.0 283093.0 37647.4 37693.0 37754.0 47026.0 47260.5 46822.0 46946.8 47010.1 47011.8 47407.8 11040.5 13224.5 13227.9 13230.7 13235.0 10856.3 10861.8 10869.4 10873.9 10901.5 11676.8 11690.5 11704.0 11761.8 11860.3 5266.2 5292.2 5296.5 5309.0 5328.6 891.9 988.2 1010.5 1023.8 1029.6 23133.8 23144.3 23263.8 23301.9 23501.4 990.6 1027.4 1144.4 1146.2 1158.3 10207.7 10705.9 12033.3 12044.4 12064.3 293552.0 293617.0 293640.0 294028.0 295500.0 48361.3 48422.0 48442.3 48508.0 49567.5 1501.3 1552.8 1558.0 1563.6 1569.9 23032.0 23091.3 23183.5 23185.8 23413.9 35914.5 35978.0 35992.8 36038.5 36068.6 256904.5 256990.0 257394.0 257843.0 260077.0 27848.6 28002.6 31880.0 32115.8 32196.8 39719.6 40681.8 40723.8 40764.2 40783.0 27249.9 28592.4 28623.6 29407.3 29615.4 22983.7 29217.9 29315.4 29367.6 29832.9 35545.8 35852.8 36012.3 36028.5 36047.1 28250.6 28506.6 29693.4 29764.3 30075.2 22652.0 23483.6 23511.9 23718.5 23854.8 09:00:27 INFO - PID 1644 | 09:00:27 INFO - PID 1644 | [#2] jquery.html Cycles:180 Average:34343.76 Median:2281.95 stddev:90809.84 (3979.5%) stddev-sans-first:91028.89 09:00:27 INFO - PID 1644 | Values: 435.3 439.4 441.4 448.8 454.8 18746.7 20738.6 21178.8 21391.0 21391.4 21486.8 21613.4 22219.1 22345.8 23718.5 5898.4 6170.0 6170.2 6185.7 6186.6 5724.9 6051.8 6086.1 6100.5 6105.3 5813.3 6044.6 6058.9 6071.9 6090.0 5959.5 6071.3 6086.0 6091.7 6096.7 5302.6 5328.7 5396.1 5398.7 5419.3 26783.5 27031.5 27668.0 28255.6 28301.4 2189.1 2277.8 2281.4 2282.5 2283.6 17812.9 17894.9 17964.6 18090.8 18303.9 2105.6 2113.7 2145.0 2149.6 2159.7 155172.0 155278.1 157601.0 158447.0 160803.0 11819.3 12409.3 12417.0 12429.8 12497.7 16666.7 16681.0 16702.8 16727.7 16739.9 7559.0 8735.0 8931.7 8944.9 9022.6 8468.7 8469.3 8488.4 8676.3 8690.4 6545.4 7779.2 7895.3 7946.4 7947.6 1796.6 1843.8 2063.2 2106.2 2290.9 947.3 950.0 955.6 963.1 1002.6 18738.9 21053.9 21068.9 21166.5 21233.5 962.7 967.6 976.6 1002.0 1004.9 9128.4 10578.3 10910.9 11027.5 11045.3 524715.0 530409.0 535472.0 549394.0 550565.0 83614.0 98223.5 105041.5 105145.9 119182.4 1008.8 1076.9 1187.6 1189.2 1191.6 21180.8 21372.5 22132.1 22186.0 22456.9 51879.5 51920.1 53699.5 54071.0 54178.0 69673.0 70201.3 70702.6 71699.0 71787.6 8590.9 8638.2 8756.4 8928.3 9078.8 14123.4 14165.6 14317.8 14562.9 14795.9 11866.9 11886.5 12035.4 12185.2 12290.3 10627.9 11301.5 11466.3 11505.1 11721.1 11959.5 12004.7 12173.4 12286.4 12371.4 8799.0 8886.1 8897.7 8956.2 9064.6 11728.1 11827.5 12015.0 12056.6 12118.6 09:00:27 INFO - PID 1644 | 09:00:27 INFO - PID 1644 | [#3] mootools.html Cycles:180 Average:6729.70 Median:3863.16 stddev:4181.55 (108.2%) stddev-sans-first:4174.12 09:00:27 INFO - PID 1644 | Values: 1402.8 1451.1 1463.5 1469.3 1476.9 10726.4 11181.9 11200.2 11203.4 11208.8 10571.0 10953.4 11111.6 11146.8 11151.2 2426.6 2468.3 2470.8 2471.5 2473.6 2389.5 2394.7 2433.3 2433.8 2441.7 2363.2 2454.3 2460.1 2463.1 2466.2 2403.7 2447.0 2449.8 2462.3 2468.8 2363.8 2387.9 2392.1 2397.9 2399.2 11036.4 11267.0 11288.6 11298.0 11306.8 6308.6 6531.4 6539.3 6540.5 6543.9 3901.8 4194.2 4277.1 4300.2 4322.4 1046.4 1049.4 1207.4 1232.3 1256.3 14274.4 14534.9 14547.3 15407.6 15486.0 5138.7 5275.5 5418.7 5423.2 5423.4 11282.3 11282.7 11307.3 11324.2 11328.7 6400.6 6407.5 6420.1 6422.7 6427.1 5967.2 6082.1 6115.3 6174.3 6218.7 4058.2 4154.6 4192.9 4232.6 4240.5 1229.6 1230.1 1230.5 1244.8 1249.2 784.6 797.6 817.1 819.5 845.3 4819.3 5941.6 5981.3 6045.0 6312.1 537.5 541.2 602.8 610.7 615.8 3824.5 4193.2 4252.0 4317.4 4317.6 13907.2 14568.8 14576.9 14580.4 14588.6 11521.8 11713.7 14525.2 14535.5 14536.6 7649.3 7696.1 7714.8 7722.4 7809.2 5455.9 6705.3 6877.9 6917.9 6944.0 12041.3 12386.3 12398.6 12412.8 12419.3 12731.9 12925.5 12993.9 13055.0 13300.9 7823.6 8010.8 8019.6 8025.1 8050.6 10296.1 10321.2 10414.9 10419.1 10461.2 8846.9 8854.6 8866.6 8870.9 8929.5 7665.8 8552.1 8663.6 8668.2 8748.4 7699.8 7879.1 7884.6 7884.7 7891.8 5745.3 5867.3 5902.4 6026.2 6027.8 4402.5 6019.6 6069.8 6099.9 6143.4 09:00:27 INFO - PID 1644 | 09:00:27 INFO - PID 1644 | [#4] prototype.html Cycles:180 Average:5147.67 Median:5609.75 stddev:1541.95 (27.5%) stddev-sans-first:1504.38 09:00:27 INFO - PID 1644 | Values: 391.5 397.1 399.4 401.9 404.8 5981.7 6036.9 6040.9 6041.8 6084.3 4768.8 5103.0 5611.6 5863.0 5943.9 3930.9 4105.9 4182.1 4516.3 4531.0 3728.5 3742.0 3768.3 4501.2 4552.3 4417.8 4457.6 4505.4 4509.5 4524.5 4484.6 4500.9 4502.4 4502.5 4509.9 3974.4 3975.8 3980.4 3998.4 4004.4 4811.5 5677.7 5766.6 5813.9 5847.9 5360.5 5367.8 5373.2 5378.8 5381.6 5544.8 5843.2 6057.7 6344.9 6361.7 4477.4 4505.2 4528.9 4540.2 4543.7 5494.5 6510.3 6666.5 6728.8 6729.2 4635.8 4757.5 4784.1 4787.5 4792.8 4872.6 4894.6 4903.7 4906.3 4920.7 5365.6 5393.2 5436.8 5458.6 5491.9 5432.3 6363.9 6367.0 6424.6 6443.5 1458.6 1605.4 1649.4 1666.2 1675.2 1062.7 1138.3 1156.5 1160.9 1162.9 5608.6 5610.9 5787.6 6047.9 6050.3 6555.2 6587.1 6589.2 6617.2 6704.9 5065.0 5882.6 5982.0 6031.9 6076.7 3044.5 3045.6 3438.7 3472.0 3480.7 4963.8 5722.5 5933.1 6015.8 6785.8 5827.4 6076.5 6677.2 6749.2 6799.2 5717.9 5740.1 5961.4 6363.0 6469.0 6628.4 6636.3 6638.5 6653.2 6677.2 5181.5 5301.4 6524.0 6539.9 6578.8 6390.2 6775.7 6839.9 6857.9 6901.5 4284.0 4284.9 4321.8 4326.4 4331.2 5782.0 6394.8 6502.9 6607.7 6639.2 5333.4 5560.6 6100.9 6195.7 6406.7 5167.7 5629.4 6243.2 6390.6 6401.2 6246.8 6250.9 6254.7 6257.9 6264.6 5934.9 5940.3 6365.3 6372.9 6393.9 5190.9 5279.6 6177.7 6213.7 6225.3 09:00:27 INFO - PID 1644 | 09:00:27 INFO - PID 1644 | [#5] yui.html Cycles:180 Average:21312.32 Median:17522.02 stddev:31145.28 (177.7%) stddev-sans-first:31194.39 09:00:27 INFO - PID 1644 | Values: 753.3 822.1 822.2 844.1 852.3 16276.4 16513.9 16686.2 16686.9 16689.2 14894.9 15339.9 15499.4 15504.7 15533.5 971.8 976.7 979.3 980.0 982.0 1007.7 1009.6 1009.8 1011.6 1015.5 999.0 1004.0 1005.2 1005.8 1020.7 996.9 998.6 999.6 999.8 1035.6 761.1 762.6 763.7 764.0 767.0 16657.2 16888.7 17055.8 17062.5 17450.6 17256.6 17340.5 17593.5 17641.3 17829.3 13127.3 13144.6 13275.7 13283.1 13458.1 3447.1 3464.0 3476.1 3478.5 3480.4 81083.2 129800.0 130613.3 131738.0 134530.7 11148.8 11436.0 13673.1 14038.2 14110.9 19102.2 25100.5 25127.5 25383.6 25412.9 7393.3 7467.7 7470.2 7475.9 7476.2 3487.4 3613.5 3652.2 3703.6 3710.3 4078.4 4150.4 4152.1 4157.9 4158.5 880.7 918.3 923.6 924.5 927.0 541.8 645.6 653.9 669.5 693.2 10142.7 10755.0 11399.9 11987.9 12176.8 637.8 641.9 652.0 653.6 674.5 5087.5 5309.6 5582.8 5599.9 5634.0 105510.4 106030.5 106645.0 107892.9 108668.5 90644.0 96665.0 96766.5 97337.0 98540.0 83707.6 83841.9 84496.7 84743.3 84775.0 11124.1 11126.9 11207.8 11282.0 11371.9 40678.6 40682.8 40738.0 41528.4 41710.2 51629.7 51823.2 52204.4 52309.0 53192.2 13992.4 14001.0 14134.9 14188.0 14345.6 14227.4 15605.8 15637.8 15671.2 15758.8 13648.2 13756.6 13793.2 13996.7 14080.9 14238.9 14492.8 14512.0 14613.3 14826.2 13903.2 14075.8 14285.0 14432.1 14436.6 10115.7 10455.3 10523.7 10670.6 10745.5 10774.4 11172.7 11461.9 11816.7 11834.3 09:00:27 INFO - PID 1644 | -------- Summary: end -------- 09:00:27 INFO - PID 1644 | 09:00:28 INFO - TEST-INFO | 1644: exit 0 09:00:28 INFO - TEST-OK | dromaeo_css | took 1117785ms 09:00:28 INFO - TEST-START | kraken 09:00:28 INFO - operating with platform_type : mac_ 09:00:28 INFO - Initialising browser for kraken test... 09:00:28 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/tmpwTcXA4/profile http://localhost:49240/getInfo.html) 09:00:30 INFO - PID 1653 | __metrics Screen width/height:1600/1200 09:00:30 INFO - PID 1653 | colorDepth:24 09:00:30 INFO - PID 1653 | Browser inner width/height: 1024/691 09:00:30 INFO - PID 1653 | __metrics 09:00:30 INFO - PID 1653 | 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" 09:00:30 INFO - PID 1653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:00:31 INFO - TEST-INFO | 1653: exit 0 09:00:31 INFO - Browser initialized. 09:00:31 INFO - Running cycle 1/1 for kraken test... 09:00:31 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/tmpwTcXA4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:00:43 INFO - PID 1654 | RSS: Main: 234901504 09:00:43 INFO - PID 1654 | 09:00:46 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 09:00:47 INFO - PID 1654 | RSS: Main: 304099328 09:00:47 INFO - PID 1654 | 09:00:49 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 09:00:50 INFO - PID 1654 | RSS: Main: 286818304 09:00:50 INFO - PID 1654 | 09:00:53 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 09:00:54 INFO - PID 1654 | RSS: Main: 378490880 09:00:54 INFO - PID 1654 | 09:00:56 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 09:00:56 INFO - PID 1654 | RSS: Main: 280555520 09:00:56 INFO - PID 1654 | 09:00:58 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:00:59 INFO - PID 1654 | RSS: Main: 283639808 09:00:59 INFO - PID 1654 | 09:01:02 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 09:01:02 INFO - PID 1654 | RSS: Main: 347860992 09:01:02 INFO - PID 1654 | 09:01:05 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 09:01:06 INFO - PID 1654 | RSS: Main: 363098112 09:01:06 INFO - PID 1654 | 09:01:09 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 09:01:09 INFO - PID 1654 | RSS: Main: 367624192 09:01:09 INFO - PID 1654 | 09:01:11 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:01:11 INFO - PID 1654 | RSS: Main: 323825664 09:01:11 INFO - PID 1654 | 09:01:13 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:01:14 INFO - PID 1654 | RSS: Main: 325595136 09:01:14 INFO - PID 1654 | 09:01:16 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:01:16 INFO - PID 1654 | RSS: Main: 327720960 09:01:16 INFO - PID 1654 | 09:01:19 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:01:20 INFO - PID 1654 | RSS: Main: 346935296 09:01:20 INFO - PID 1654 | 09:01:23 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:01:24 INFO - PID 1654 | RSS: Main: 339828736 09:01:24 INFO - PID 1654 | 09:01:25 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 09:01:26 INFO - PID 1654 | RSS: Main: 382967808 09:01:26 INFO - PID 1654 | 09:01:26 INFO - PID 1654 | __start_tp_report 09:01:26 INFO - PID 1654 | _x_x_mozilla_page_load 09:01:26 INFO - PID 1654 | _x_x_mozilla_page_load_details 09:01:26 INFO - PID 1654 | |i|pagename|runs| 09:01:26 INFO - PID 1654 | |0;ai-astar;110;109;109;110;110;110;109;113;158;163 09:01:26 INFO - PID 1654 | |1;audio-beat-detection;138;108;107;148;110;108;108;104;129;104 09:01:26 INFO - PID 1654 | |2;audio-dft;187;185;184;181;186;182;184;182;183;180 09:01:26 INFO - PID 1654 | |3;audio-fft;79;59;56;86;61;60;83;57;81;55 09:01:26 INFO - PID 1654 | |4;audio-oscillator;92;69;83;68;68;68;89;72;69;89 09:01:26 INFO - PID 1654 | |5;imaging-gaussian-blur;91;135;88;88;89;89;88;88;89;89 09:01:26 INFO - PID 1654 | |6;imaging-darkroom;96;95;96;95;96;97;96;96;96;95 09:01:26 INFO - PID 1654 | |7;imaging-desaturate;83;82;82;85;83;83;84;85;83;85 09:01:26 INFO - PID 1654 | |8;json-parse-financial;48;48;49;46;47;47;48;47;48;48 09:01:26 INFO - PID 1654 | |9;json-stringify-tinderbox;54;52;62;62;66;58;59;57;56;56 09:01:26 INFO - PID 1654 | |10;stanford-crypto-aes;83;83;82;82;83;81;82;82;81;82 09:01:26 INFO - PID 1654 | |11;stanford-crypto-ccm;137;135;135;135;136;134;138;136;174;139 09:01:26 INFO - PID 1654 | |12;stanford-crypto-pbkdf2;183;179;183;184;184;183;182;181;186;211 09:01:26 INFO - PID 1654 | |13;stanford-crypto-sha256-iterative;66;68;67;68;68;68;67;67;67;68 09:01:26 INFO - PID 1654 | __end_tp_report 09:01:26 INFO - PID 1654 | __start_cc_report 09:01:26 INFO - PID 1654 | _x_x_mozilla_cycle_collect,2252 09:01:26 INFO - PID 1654 | __end_cc_report 09:01:26 INFO - PID 1654 | __startTimestamp1494432086209__endTimestamp 09:01:26 INFO - PID 1654 | 09:01:26 INFO - PID 1654 | ------- Summary: start ------- 09:01:26 INFO - PID 1654 | Number of tests: 14 09:01:26 INFO - PID 1654 | 09:01:26 INFO - PID 1654 | [#0] ai-astar Cycles:10 Average:120.10 Median:110.00 stddev:21.36 (19.4%) stddev-sans-first:22.34 09:01:26 INFO - PID 1654 | Values: 110.0 109.0 109.0 110.0 110.0 110.0 109.0 113.0 158.0 163.0 09:01:26 INFO - PID 1654 | 09:01:26 INFO - PID 1654 | [#1] audio-beat-detection Cycles:10 Average:116.40 Median:109.00 stddev:15.89 (14.6%) stddev-sans-first:14.81 09:01:26 INFO - PID 1654 | Values: 138.0 108.0 107.0 148.0 110.0 108.0 108.0 104.0 129.0 104.0 09:01:26 INFO - PID 1654 | 09:01:26 INFO - PID 1654 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.00 stddev:2.22 (1.2%) stddev-sans-first:1.94 09:01:26 INFO - PID 1654 | Values: 187.0 185.0 184.0 181.0 186.0 182.0 184.0 182.0 183.0 180.0 09:01:26 INFO - PID 1654 | 09:01:26 INFO - PID 1654 | [#3] audio-fft Cycles:10 Average:67.70 Median:70.00 stddev:12.76 (18.2%) stddev-sans-first:12.87 09:01:26 INFO - PID 1654 | Values: 79.0 59.0 56.0 86.0 61.0 60.0 83.0 57.0 81.0 55.0 09:01:26 INFO - PID 1654 | 09:01:26 INFO - PID 1654 | [#4] audio-oscillator Cycles:10 Average:76.70 Median:77.50 stddev:10.24 (13.2%) stddev-sans-first:9.25 09:01:26 INFO - PID 1654 | Values: 92.0 69.0 83.0 68.0 68.0 68.0 89.0 72.0 69.0 89.0 09:01:26 INFO - PID 1654 | 09:01:26 INFO - PID 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:93.40 Median:89.00 stddev:14.65 (16.5%) stddev-sans-first:15.51 09:01:26 INFO - PID 1654 | Values: 91.0 135.0 88.0 88.0 89.0 89.0 88.0 88.0 89.0 89.0 09:01:26 INFO - PID 1654 | 09:01:26 INFO - PID 1654 | [#6] imaging-darkroom Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 09:01:26 INFO - PID 1654 | Values: 96.0 95.0 96.0 95.0 96.0 97.0 96.0 96.0 96.0 95.0 09:01:26 INFO - PID 1654 | 09:01:26 INFO - PID 1654 | [#7] imaging-desaturate Cycles:10 Average:83.50 Median:83.50 stddev:1.18 (1.4%) stddev-sans-first:1.24 09:01:26 INFO - PID 1654 | Values: 83.0 82.0 82.0 85.0 83.0 83.0 84.0 85.0 83.0 85.0 09:01:26 INFO - PID 1654 | 09:01:26 INFO - PID 1654 | [#8] json-parse-financial Cycles:10 Average:47.60 Median:48.00 stddev:0.84 (1.8%) stddev-sans-first:0.88 09:01:26 INFO - PID 1654 | Values: 48.0 48.0 49.0 46.0 47.0 47.0 48.0 47.0 48.0 48.0 09:01:26 INFO - PID 1654 | 09:01:26 INFO - PID 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:58.20 Median:58.50 stddev:4.18 (7.2%) stddev-sans-first:4.15 09:01:26 INFO - PID 1654 | Values: 54.0 52.0 62.0 62.0 66.0 58.0 59.0 57.0 56.0 56.0 09:01:26 INFO - PID 1654 | 09:01:26 INFO - PID 1654 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:82.00 stddev:0.74 (0.9%) stddev-sans-first:0.71 09:01:26 INFO - PID 1654 | Values: 83.0 83.0 82.0 82.0 83.0 81.0 82.0 82.0 81.0 82.0 09:01:26 INFO - PID 1654 | 09:01:26 INFO - PID 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:139.90 Median:136.50 stddev:12.08 (8.8%) stddev-sans-first:12.76 09:01:26 INFO - PID 1654 | Values: 137.0 135.0 135.0 135.0 136.0 134.0 138.0 136.0 174.0 139.0 09:01:26 INFO - PID 1654 | 09:01:26 INFO - PID 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.60 Median:183.50 stddev:9.12 (5.0%) stddev-sans-first:9.62 09:01:26 INFO - PID 1654 | Values: 183.0 179.0 183.0 184.0 184.0 183.0 182.0 181.0 186.0 211.0 09:01:26 INFO - PID 1654 | 09:01:26 INFO - PID 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.53 09:01:26 INFO - PID 1654 | Values: 66.0 68.0 67.0 68.0 68.0 68.0 67.0 67.0 67.0 68.0 09:01:26 INFO - PID 1654 | -------- Summary: end -------- 09:01:26 INFO - PID 1654 | 09:01:27 INFO - TEST-INFO | 1654: exit 0 09:01:27 INFO - TEST-OK | kraken | took 59053ms 09:01:27 INFO - SUITE-END | took 1176s 09:01:27 INFO - Completed test suite (00:19:37) 09:01:27 INFO - javascript benchmark 09:01:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7637.201054388885, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3564.1980554375286, 3575.999999999998, 3607.22444674395, 3611.295797319522, 3638.727095467839, 5201.505856943589, 6138.8465288367815, 6218.564700470969, 6237.5009999200065, 6293.804177206328, 6169.0, 6215.844603884894, 6259.937400625992, 6260.718267677954, 6265.498760099193, 5219.321488206528, 5267.868303292429, 5388.7305634718305, 5414.972925135369, 5452.536534394581, 5444.455554444544, 5493.093639549469, 5498.917516237259, 5508.476694713996, 5513.9448605513835, 5326.2543243945875, 5398.325209348832, 5412.702301373423, 5431.8098866539485, 5481.862953426176, 4481.686281960264, 5452.291202143736, 5472.945270547283, 5491.862703432406, 5512.200730893998, 5359.678419294854, 5407.648502847303, 5410.594205434608, 5424.484673955968, 5493.505584497374, 6096.96951515244, 6172.7530898764, 6245.779207881471, 6287.654179020152, 6304.27500837405, 6457.677116144221, 6531.771388001444, 6625.17185351831, 6644.4020038196795, 6648.634325112117, 5599.32808063035, 6728.9663551682415, 6735.8989615155815, 6743.561668491532, 6745.595264284109, 6164.291106522807, 6291.43377096059, 6293.559450838397, 6331.746730130835, 6340.587861789015, 6620.172478440195, 6710.16122984627, 6837.726490940406, 6936.445084393236, 6947.756828510978, 6473.352664733583, 6483.902741458882, 6485.156929599217, 6493.675316234169, 6494.447971922439, 6649.867002660017, 6663.200415950117, 6710.966445167841, 6726.865462690719, 6728.024436456784, 6374.649394283359, 6607.0, 6608.669566521751, 6616.371444712745, 6632.436242919406, 6388.840278993062, 6540.084388185658, 6631.137952066297, 6633.071370008202, 6637.1703537057865, 5286.577073834084, 5295.947040529545, 5303.04545181871, 5304.177852432879, 5328.4671532846405, 4678.415198100238, 4739.123262196505, 4739.265413860857, 4742.857714268577, 4749.097671442415, 6203.658798766111, 6263.749450022039, 6276.435120839146, 6277.780277690259, 6328.46208072319, 6734.865302693918, 6738.19141702989, 6758.898616520756, 6764.56030358035, 6769.966150169316, 6331.145295385156, 6334.429901308904, 6334.968325158345, 6357.809265722036, 6359.17330747, 5741.45456181662, 5843.0, 5849.385814489502, 5852.414758524199, 5921.851953701192, 6042.214512113573, 6763.5265531413315, 6857.245702972569, 6930.965345173242, 6943.062686537252, 6499.870002599827, 6570.0, 6582.0, 6617.900731489128, 6732.293109223461, 6886.10480637514, 6929.514933954575, 6932.792016239521, 6949.131358580177, 6952.582845029315, 6614.404703576702, 6619.900701489578, 6620.205575330991, 6626.105475760711, 6629.7348106075215, 6533.640649764308, 6562.606243625398, 6599.340065993362, 6730.730770769114, 6750.932490675031, 5429.0, 6469.417752402306, 6520.967395162994, 6542.411182993554, 6548.443382312556, 6462.321456247027, 6498.122753428416, 6524.641144737085, 6525.119108920425, 6534.705938232696, 6225.346338634378, 6257.2491301044165, 6382.5532212744665, 6386.68066596659, 6392.3927226913365, 6362.204724409449, 6434.517411194272, 6513.0, 6513.413792758674, 6548.541602087808, 6346.492280617447, 6349.746010159542, 6352.301246862934, 6355.459785918249, 6365.809025729235], "value": 6081.161974913692, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [795.1889073145392, 807.7818988873005, 1095.5289225632976, 1127.1546340244815, 1127.9266847654897, 33775.83112084439, 34196.48705269423, 34289.14277143073, 34330.82834585824, 34339.0, 36809.0, 37044.25911481769, 37092.62907370926, 37109.25781484369, 37130.62869371306, 5872.17789509469, 5956.076808094752, 8141.755747327575, 8301.252887240147, 8327.916720832774, 8196.631151598163, 8354.415190936637, 8360.916390836104, 8369.204925532065, 8372.916270837275, 8445.36659750518, 8464.449810762311, 8482.87275690862, 8499.150084991514, 8536.317094632446, 5946.910796338058, 6036.486898613623, 8388.8741668875, 8428.873566896471, 8443.366747493963, 8084.717034903751, 8227.917720822776, 8233.053198882086, 8235.0, 8237.0, 35212.82393588016, 35456.46815297772, 35529.46705799415, 35612.82193589042, 35617.0, 2935.3248752786767, 3630.2920930418577, 3630.6006339302658, 3633.2370202257557, 3635.618260082706, 29119.41761164786, 29223.2694182645, 29247.0, 29295.0, 29341.53292335375, 3061.663217046123, 3133.7336326412283, 3155.1323386069016, 3168.493041113411, 3172.4289627866974, 282189.5890520534, 282384.0, 282407.0, 282689.0, 283093.0, 37647.4352884707, 37693.0, 37754.0, 47026.0, 47260.527394725614, 46822.0, 46946.765266173454, 47010.059798803835, 47011.82470438198, 47407.76296118566, 11040.503177357039, 13224.471021159046, 13227.941764658804, 13230.73538529224, 13235.0, 10856.294340867818, 10861.782764344827, 10869.40218287986, 10873.891261087289, 10901.454927253606, 11676.76646467066, 11690.532378704927, 11704.0, 11761.764764704658, 11860.347680877634, 5266.236395722675, 5292.153255479182, 5296.496832800878, 5308.973455132699, 5328.600354973392, 891.8895974511645, 988.229181238635, 1010.4947526236881, 1023.82083135451, 1029.5675816157232, 23133.84330783454, 23144.3056708299, 23263.76736232616, 23301.883490582437, 23501.41246468818, 990.5641517732175, 1027.3630349183404, 1144.370596172102, 1146.1804809561204, 1158.252926862186, 10207.693769186937, 10705.946470267754, 12033.278003319829, 12044.39778011096, 12064.276143431422, 293552.0, 293617.0, 293640.0, 294028.0, 295500.0, 48361.27458088131, 48422.0, 48442.27336589954, 48508.02983940372, 49567.50432495701, 1501.3169008101288, 1552.7826104345402, 1558.041804290376, 1563.6012816731889, 1569.9293531791097, 23032.0, 23091.307260782203, 23183.53632927366, 23185.76814231836, 23413.882930585238, 35914.46128308025, 35978.0, 35992.8200359007, 36038.4594231092, 36068.63931360758, 256904.46433035194, 256990.0, 257394.0, 257843.0, 260077.0, 27848.582271265543, 28002.57996130019, 31880.0, 32115.839420802746, 32196.83901580477, 39719.623831974604, 40681.79659101686, 40723.796381017906, 40764.1847163061, 40782.9804254896, 27249.863750681914, 28592.42815143727, 28623.566996805504, 29407.26481837971, 29615.407691846474, 22983.655245171, 29217.85391073031, 29315.41369172562, 29367.55948660729, 29832.85083574568, 35545.82227088848, 35852.82073589615, 36012.27975440529, 36028.4595731059, 36047.098822529646, 28250.587470625975, 28506.57240141441, 29693.40613187681, 29764.255893602833, 30075.24811879633, 22652.0, 23483.64774528349, 23511.882440587688, 23718.52562948766, 23854.825405554308], "value": 16532.57928626247, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [435.28395788927236, 439.39144285165037, 441.41071669321457, 448.7868262575277, 454.81352645415365, 18746.718799218004, 20738.585228295444, 21178.83516406597, 21391.0, 21391.35825925223, 21486.785132148674, 21613.351599452002, 22219.111235550597, 22345.776542234573, 23718.5256294874, 5898.439648233411, 6169.969150154243, 6170.197874276338, 6185.6597887116195, 6186.597871138384, 5724.856878578027, 6051.848703782397, 6086.147939288503, 6100.511959043266, 6105.297890742555, 5813.331466881321, 6044.607100538473, 6058.878822423549, 6071.939280607182, 6089.969550152243, 5959.493443057324, 6071.332153463116, 6085.995810691231, 6091.664958427285, 6096.664683442409, 5302.602304827154, 5328.6802791832615, 5396.136618141118, 5398.730063496849, 5419.3225846769155, 26783.464330713472, 27031.459370812474, 27668.0, 28255.576166357314, 28301.433971320457, 2189.1134090693135, 2277.794998450131, 2281.3840263128864, 2282.509260508982, 2283.6117859963847, 17812.931224126594, 17894.91052544742, 17964.640707185914, 18090.819091809044, 18303.90176589409, 2105.599936012168, 2113.6723807809813, 2145.0, 2149.580831737812, 2159.6976423300753, 155172.0, 155278.1180470486, 157601.0, 158447.0, 160803.0, 11819.349935753617, 12409.317487538272, 12417.0, 12429.75140497185, 12497.687557810945, 16666.749998749787, 16680.999140051637, 16702.832971670126, 16727.749083763752, 16739.91630041842, 7558.962205189049, 8734.956325218332, 8931.73204803857, 8944.8658270126, 9022.593983270768, 8468.661253549912, 8469.280111190494, 8488.448250863674, 8676.262517686067, 8690.391672582986, 6545.378189072126, 7779.202963505851, 7895.328897043701, 7946.404019698546, 7947.602619869099, 1796.6496533175905, 1843.797182309945, 2063.1541068161982, 2106.157112526539, 2290.8500811384347, 947.3415975896824, 949.9810003800023, 955.5938726041404, 963.1187463470845, 1002.6039714312806, 18738.90630546866, 21053.894730526248, 21068.894655526932, 21166.47083822886, 21233.469163271042, 962.7400601837464, 967.6419724701906, 976.6386437018207, 1001.9549120289604, 1004.9296549241483, 9128.42340857087, 10578.259521833397, 10910.945445272722, 11027.481878035782, 11045.33727976324, 524715.0, 530409.0, 535472.0, 549394.0, 550565.0, 83614.0, 98223.50888245513, 105041.47479262555, 105145.94854051362, 119182.40408797901, 1008.7629407089328, 1076.8923107689325, 1187.590281352932, 1189.2151180221013, 1191.642507247822, 21180.83505407156, 21372.465688357915, 22132.114715411848, 22186.00162992637, 22456.88771556132, 51879.48120518746, 51920.1059920515, 53699.46300536945, 54071.0, 54178.0, 69673.0, 70201.29798702152, 70702.64648676723, 71699.0, 71787.64106179436, 8590.91409085901, 8638.222559969632, 8756.4308319959, 8928.285737141143, 9078.818423631623, 14123.43506259738, 14165.575032749033, 14317.785233221302, 14562.927185364006, 14795.926020369829, 11866.881331186923, 11886.465109070286, 12035.398230088636, 12185.207961482476, 12290.324032178316, 10627.946860265649, 11301.491432885705, 11466.312021278416, 11505.079593632656, 11721.06231501495, 11959.521619135485, 12004.699882503008, 12173.39133043362, 12286.447109880255, 12371.443285052374, 8799.0, 8886.111388861062, 8897.688580899638, 8956.238719708637, 9064.592093355946, 11728.061755059403, 11827.467763950472, 12015.0, 12056.578019769266, 12118.636440906786], "value": 10319.816705144438, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1402.8456869744327, 1451.114819959825, 1463.5097242423788, 1469.3323078306123, 1476.9187694676789, 10726.35641861488, 11181.944090279558, 11200.215984881052, 11203.439828008588, 11208.775824483515, 10571.0, 10953.371190914182, 11111.611093611726, 11146.777064458705, 11151.219414640978, 2426.575349313872, 2468.308873515419, 2470.814688898331, 2471.5180539794746, 2473.6413220083077, 2389.545986262613, 2394.7493199570813, 2433.2821817563863, 2433.8052955763583, 2441.7436169202247, 2363.1728894886737, 2454.349597356702, 2460.052879641333, 2463.1379017343966, 2466.235467005234, 2403.6995375578053, 2446.999999999991, 2449.7550244975537, 2462.2982450001664, 2468.7778099971, 2363.8108951283857, 2387.9164229252065, 2392.09100541793, 2397.8561286322874, 2399.196269249803, 11036.448177591088, 11266.985971262626, 11288.604898828584, 11298.0, 11306.830397544043, 6308.621482711006, 6531.4448271896945, 6539.313372095957, 6540.542162048659, 6543.869122617521, 3901.8244179012013, 4194.161167766429, 4277.101808620194, 4300.204462174508, 4322.351647252905, 1046.4414506531534, 1049.422817450407, 1207.402335843763, 1232.2975903734875, 1256.2776403567984, 14274.429022839075, 14534.927325363411, 14547.272636368245, 15407.61480962985, 15486.0, 5138.717370544656, 5275.498827611371, 5418.674879507243, 5423.159410291411, 5423.403425623178, 11282.323060616389, 11282.661520154244, 11307.265027773168, 11324.207305488702, 11328.660140195807, 6400.551961362753, 6407.455366293917, 6420.133282006869, 6422.678866056678, 6427.132337134521, 5967.16459695643, 6082.057281121433, 6115.266168059772, 6174.289956654952, 6218.720157592919, 4058.2189255747144, 4154.626083652486, 4192.916141677149, 4232.576742325743, 4240.5123410808155, 1229.6495498782804, 1230.1450491908038, 1230.5389221556886, 1244.775940330749, 1249.1755441408627, 784.5567254501188, 797.6091715059695, 817.1011886924335, 819.4550623835202, 845.3364109174391, 4819.3012013257885, 5941.643501389931, 5981.342052374235, 6045.002574575234, 6312.084747711556, 537.5028099008401, 541.1720068295435, 602.8251806975928, 610.6824451285396, 615.7844754336036, 3824.5028146340796, 4193.161367726467, 4251.978740106341, 4317.395564620955, 4317.568243175658, 13907.23510206928, 14568.781468277984, 14576.854231457763, 14580.416783328548, 14588.562343129723, 11521.82717259225, 11713.707157320965, 14525.201113938834, 14535.491257805927, 14536.63658408527, 7649.31156195945, 7696.11494678108, 7714.807129821799, 7722.382209423233, 7809.180036096128, 5455.9454405455435, 6705.262421133769, 6877.862442751017, 6917.896231556631, 6944.0, 12041.277523348626, 12386.3187524687, 12398.62804115878, 12412.81380779307, 12419.254844709347, 12731.93634031824, 12925.54760583375, 12993.870061299265, 13055.02087343472, 13300.866991329964, 7823.569703666125, 8010.759677209693, 8019.5990200490905, 8025.117237103797, 8050.637721302438, 10296.124829389286, 10321.225908057077, 10414.895851041392, 10419.06228439444, 10461.163106951577, 8846.911530884867, 8854.645814167361, 8866.64533418656, 8870.911290887008, 8929.464232146092, 7665.808354791175, 8552.059273480038, 8663.6101375437, 8668.176523230282, 8748.431351962103, 7699.846003080019, 7879.0939042010905, 7884.605769711607, 7884.699024661096, 7891.84216315659, 5745.3105627324985, 5867.266591676041, 5902.439268269508, 6026.216591843207, 6027.758889644365, 4402.493713223021, 6019.638821670714, 6069.757209711562, 6099.878002440015, 6143.447089761943], "value": 5097.7276271664, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.4558763318986, 397.0510479952911, 399.40488671878893, 401.9296623090958, 404.79962418602776, 5981.730822113004, 6036.909446358308, 6040.879182416349, 6041.788537401192, 6084.330723620404, 4768.833090841821, 5103.030424219396, 5611.607187496877, 5862.970685146568, 5943.88112237755, 3930.941035884457, 4105.876823695294, 4182.07994241268, 4516.277395616702, 4531.006357202837, 3728.4780130781714, 3742.0, 3768.284026035058, 4501.234790085677, 4552.271636538155, 4417.779111044451, 4457.621102206316, 4505.414296141497, 4509.503954565012, 4524.457065152186, 4484.618807401374, 4500.8649740507835, 4502.369668246448, 4502.527234640348, 4509.864704058867, 3974.3641017437362, 3975.7614543127215, 3980.3631418972827, 3998.3602623580086, 4004.3593025115842, 4811.542903424169, 5677.687727175004, 5766.606858153861, 5813.88372232553, 5847.853803654943, 5360.463953604647, 5367.75845086972, 5373.226835144393, 5378.838634840961, 5381.596380271495, 5544.77820887168, 5843.152742852305, 6057.666828324441, 6344.873102537969, 6361.650109243989, 4477.417935668374, 4505.193111820539, 4528.909421811578, 4540.205464043779, 4543.727376357429, 5494.549414973884, 6510.283868774431, 6666.500012499034, 6728.764493242762, 6729.192496900306, 4635.837745678885, 4757.548032936935, 4784.067106914118, 4787.497312782108, 4792.771361316934, 4872.585830204402, 4894.629503738959, 4903.656744027884, 4906.337644418029, 4920.6555541111775, 5365.597580181424, 5393.191021346829, 5436.755346009439, 5458.563314934796, 5491.917621235684, 5432.320959880015, 6363.936360636427, 6366.981282994699, 6424.582402143846, 6443.548951573345, 1458.6207586027497, 1605.3658804772049, 1649.4062137630444, 1666.1835700506665, 1675.2042779679798, 1062.6865074802952, 1138.2771939818274, 1156.4969238381163, 1160.878107798686, 1162.91859569831, 5608.551315894719, 5610.943890561124, 5787.623804452697, 6047.853012180701, 6050.273967123973, 6555.180602424697, 6587.143671322793, 6589.242237142694, 6617.205935287796, 6704.898542326459, 5064.974675126601, 5882.588218824641, 5982.042873140276, 6031.8793624127275, 6076.665783381868, 3044.4672182368, 3045.649750278702, 3438.6905178534053, 3472.041872265619, 3480.6693364130874, 4963.751812409365, 5722.484976352148, 5933.110033495011, 6015.766767812588, 6785.796426107225, 5827.446392592697, 6076.5442591805795, 6677.232118306457, 6749.190097188369, 6799.218089919624, 5717.942820571908, 5740.1102829061565, 5961.36356822338, 6362.981922892315, 6468.967655161694, 6628.403443690091, 6636.2700102987665, 6638.535302528777, 6653.2348779889, 6677.165354330708, 5181.512873820512, 5301.363836339664, 6523.967380163069, 6539.901901471387, 6578.80263592093, 6390.233172019201, 6775.695093720893, 6839.922035084332, 6857.862842743217, 6901.482388820758, 4284.0, 4284.871453856389, 4321.762303073361, 4326.437563116775, 4331.155424692155, 5782.017057100219, 6394.840128996812, 6502.902456463063, 6607.669616519251, 6639.170103737033, 5333.413324534221, 5560.555155587463, 6100.8779824404155, 6195.690215489298, 6406.711697973509, 5167.689938603546, 5629.380768115422, 6243.219597550306, 6390.584612000205, 6401.167848179894, 6246.750129994749, 6250.874982500415, 6254.655993920378, 6257.906131408124, 6264.624122552661, 5934.931712291829, 5940.287165540163, 6365.267994180728, 6372.872542549216, 6393.93606063952, 5190.922136168036, 5279.604029697711, 6177.722002509988, 6213.720382582705, 6225.31521532622], "value": 4683.233691528468, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [753.2505157368417, 822.1367564057746, 822.2476434062833, 844.0757370679108, 852.313887320707, 16276.43032493863, 16513.91743041286, 16686.16569171541, 16686.916565417185, 16689.24898379573, 14894.925525372386, 15339.926205165642, 15499.380024799022, 15504.689906201897, 15533.53399398017, 971.825071487132, 976.72651657536, 979.3291595257236, 979.9857147851975, 982.0277924854379, 1007.7480629842539, 1009.6415772400802, 1009.7576581620432, 1011.5700827148469, 1015.532854886753, 998.9960090109466, 1003.9799204015916, 1005.2209537608339, 1005.8038682456923, 1020.6733845169549, 996.9451680157624, 998.5556427389814, 999.6151481679533, 999.7550600102949, 1035.585765693721, 761.0942977856389, 762.5729591428818, 763.6678045050421, 764.0296823034715, 766.9923300767033, 16657.16714164299, 16888.662226755518, 17055.829441705548, 17062.48812535626, 17450.563735906704, 17256.56858578533, 17340.479785606327, 17593.472195834016, 17641.294348226056, 17829.286828526845, 13127.343632818322, 13144.60566183016, 13275.734485310337, 13283.136596121318, 13458.125221860548, 3447.1382154461385, 3464.0300715799362, 3476.096214984097, 3478.4608385700003, 3480.3735327641016, 81083.18916810815, 129800.0, 130613.34693326568, 131738.0, 134530.6546934528, 11148.777024459465, 11435.970762631403, 13673.111247768864, 14038.1577105374, 14110.941679374087, 19102.23591056342, 25100.497990040098, 25127.497450050898, 25383.61924571133, 25412.872935635205, 7393.297636724503, 7467.7012919483695, 7470.215627359158, 7475.9252407476315, 7476.177620461854, 3487.4071407860724, 3613.512175856278, 3652.196516766307, 3703.6111208322736, 3710.276496083238, 4078.367852982733, 4150.398192262105, 4152.1280531088805, 4157.8960525987095, 4158.500979882373, 880.7093659092484, 918.2929144558652, 923.6259314977444, 924.5146298193503, 926.9536523173814, 541.8428655689805, 645.6384424722171, 653.8953767397194, 669.4811521071111, 693.2201273567237, 10142.746431339276, 10755.0, 11399.860013998534, 11987.940060299643, 12176.756464870654, 637.7799659117597, 641.884460797061, 651.9576227545194, 653.5817077070678, 674.4840197249108, 5087.465816089331, 5309.628326017141, 5582.804601838916, 5599.869124871721, 5634.04221282383, 105510.4173437399, 106030.46984765181, 106645.0, 107892.92107078829, 108668.4566577162, 90644.0, 96665.03334966561, 96766.51616741871, 97337.0, 98540.0, 83707.5814620923, 83841.90395240168, 84496.73254901181, 84743.3051338982, 84775.0, 11124.110071194447, 11126.944365278121, 11207.775844482901, 11282.0, 11371.943140284577, 40678.59321406748, 40682.79658601688, 40738.0, 41528.377074343305, 41710.1657966845, 51629.741851290506, 51823.22265166101, 52204.43386698405, 52309.0, 53192.2021169675, 13992.440302387791, 14001.0, 14134.929325353307, 14188.0, 14345.64135896611, 14227.430902764188, 15605.765913511534, 15637.765433518734, 15671.216439177768, 15758.842411575737, 13648.181109133484, 13756.587302380945, 13793.172409655454, 13996.650083747987, 14080.859191407955, 14238.857611424168, 14492.782608261095, 14512.0, 14613.269336532918, 14826.184559849311, 13903.235322056978, 14075.788863167265, 14285.0, 14432.061915975428, 14436.639084022983, 10115.696529104138, 10455.320404174008, 10523.736906577396, 10670.57317707314, 10745.516451759846, 10774.407407592658, 11172.720681983015, 11461.942690286494, 11816.704582385166, 11834.289942603471], "value": 8010.377922984186, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1417.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 113.0, 158.0, 163.0], "value": 120.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 108.0, 107.0, 148.0, 110.0, 108.0, 108.0, 104.0, 129.0, 104.0], "value": 116.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 185.0, 184.0, 181.0, 186.0, 182.0, 184.0, 182.0, 183.0, 180.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 56.0, 86.0, 61.0, 60.0, 83.0, 57.0, 81.0, 55.0], "value": 67.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 69.0, 83.0, 68.0, 68.0, 68.0, 89.0, 72.0, 69.0, 89.0], "value": 76.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 135.0, 88.0, 88.0, 89.0, 89.0, 88.0, 88.0, 89.0, 89.0], "value": 93.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 96.0, 97.0, 96.0, 96.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 82.0, 85.0, 83.0, 83.0, 84.0, 85.0, 83.0, 85.0], "value": 83.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 48.0, 49.0, 46.0, 47.0, 47.0, 48.0, 47.0, 48.0, 48.0], "value": 47.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 62.0, 62.0, 66.0, 58.0, 59.0, 57.0, 56.0, 56.0], "value": 58.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 82.0, 82.0, 83.0, 81.0, 82.0, 82.0, 81.0, 82.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 135.0, 135.0, 135.0, 136.0, 134.0, 138.0, 136.0, 174.0, 139.0], "value": 139.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 179.0, 183.0, 184.0, 184.0, 183.0, 182.0, 181.0, 186.0, 211.0], "value": 185.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 68.0, 68.0, 68.0, 67.0, 67.0, 67.0, 68.0], "value": 67.4, "unit": "score"}]}]} 09:01:27 INFO - Return code: 0 09:01:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:01:27 INFO - # TBPL SUCCESS # 09:01:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:01:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:01:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:01:27 INFO - 2017-05-10 09:01:27.567 screenresolution[1659:10856] starting screenresolution argv=screenresolution get 09:01:27 INFO - 2017-05-10 09:01:27.570 screenresolution[1659:10856] Display 0: 1600x1200x32@60 09:01:27 INFO - 2017-05-10 09:01:27.576 screenresolution[1660:10859] starting screenresolution argv=screenresolution list 09:01:27 INFO - Available Modes on Display 0 09:01:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:01:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:01:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:01:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:01:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:01:27 INFO - Intel Iris: 09:01:27 INFO - Chipset Model: Intel Iris 09:01:27 INFO - Type: GPU 09:01:27 INFO - Bus: Built-In 09:01:27 INFO - VRAM (Dynamic, Max): 1536 MB 09:01:27 INFO - Vendor: Intel (0x8086) 09:01:27 INFO - Device ID: 0x0a2e 09:01:27 INFO - Revision ID: 0x0009 09:01:27 INFO - Displays: 09:01:27 INFO - Display: 09:01:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:01:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:01:27 INFO - Display Serial Number: 1600x1200 60 09:01:27 INFO - Main Display: Yes 09:01:27 INFO - Mirror: Off 09:01:27 INFO - Online: Yes 09:01:27 INFO - Rotation: Supported 09:01:27 INFO - Return code: 0 09:01:27 INFO - Running post-action listener: _resource_record_post_action 09:01:27 INFO - [mozharness: 2017-05-10 16:01:27.809598Z] Finished run-tests step (success) 09:01:27 INFO - Running post-run listener: _resource_record_post_run 09:01:27 INFO - Total resource usage - Wall time: 1198s; CPU: 53.0%; Read bytes: 33119744; Write bytes: 529903616; Read time: 208; Write time: 1604 09:01:27 INFO - TinderboxPrint: CPU usage
53.3% 09:01:27 INFO - TinderboxPrint: I/O read bytes / time
33,119,744 / 208 09:01:27 INFO - TinderboxPrint: I/O write bytes / time
529,903,616 / 1,604 09:01:27 INFO - TinderboxPrint: CPU idle
2,240.2 (46.7%) 09:01:27 INFO - TinderboxPrint: CPU system
954.2 (19.9%) 09:01:27 INFO - TinderboxPrint: CPU user
1,599.2 (33.4%) 09:01:27 INFO - TinderboxPrint: Swap in / out
244,129,792 / 0 09:01:27 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203100672; Write bytes: 195448832; Read time: 15641; Write time: 415 09:01:27 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 32189952; Write bytes: 314707968; Read time: 196; Write time: 1129 09:01:28 INFO - Running post-run listener: _upload_blobber_files 09:01:28 INFO - Blob upload gear active. 09:01:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:01:28 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 09:01:28 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'] 09:01:28 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 09:01:28 INFO - (blobuploader) - INFO - Open directory for files ... 09:01:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:01:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:01:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:29 INFO - (blobuploader) - INFO - Done attempting. 09:01:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:01:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:01:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:30 INFO - (blobuploader) - INFO - Done attempting. 09:01:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:01:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:01:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:31 INFO - (blobuploader) - INFO - Done attempting. 09:01:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:01:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:01:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:34 INFO - (blobuploader) - INFO - Done attempting. 09:01:34 INFO - (blobuploader) - INFO - Iteration through files over. 09:01:34 INFO - Return code: 0 09:01:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:01:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:01:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1b093c1c523c2ac9e9962cf435973e7d451269dcbf6dee81638d5ff87eddeb52474bb00810a4ff2deed7b29744b4f9031a40d31a5ae1f8d9b84b3a3e440c8d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa299ee9eb865a3f4cd396c5f3d8a7cdb845eede976bbe8cb3d8437f68c59402e8bf8a083311df1d734d912623330aee0b7bb2bb3b86ccb5f35c69d333143753", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/492ede45737b099d20ab2f7d2647ad326cce9d1f3a33f94f3b73ba570f5a1f45f1fdaa00faace8de7fc674ff5d594dc434f41999898df2a5ca589aa2ae04e13b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a62fba5d3634971868f675b67b2d42231f1d7d8cea56b8bcb237434bf7f3de662e4f267df9f19ce56e82697e255d3444867300dca918a273d842ed143b328c92"} 09:01:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:01:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:01:34 INFO - Contents: 09:01:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1b093c1c523c2ac9e9962cf435973e7d451269dcbf6dee81638d5ff87eddeb52474bb00810a4ff2deed7b29744b4f9031a40d31a5ae1f8d9b84b3a3e440c8d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa299ee9eb865a3f4cd396c5f3d8a7cdb845eede976bbe8cb3d8437f68c59402e8bf8a083311df1d734d912623330aee0b7bb2bb3b86ccb5f35c69d333143753", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/492ede45737b099d20ab2f7d2647ad326cce9d1f3a33f94f3b73ba570f5a1f45f1fdaa00faace8de7fc674ff5d594dc434f41999898df2a5ca589aa2ae04e13b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a62fba5d3634971868f675b67b2d42231f1d7d8cea56b8bcb237434bf7f3de662e4f267df9f19ce56e82697e255d3444867300dca918a273d842ed143b328c92"} 09:01:34 INFO - Running post-run listener: copy_logs_to_upload_dir 09:01:34 INFO - Copying logs to upload dir... 09:01:34 INFO - mkdir: /builds/slave/test/build/upload/logs 09:01:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.026394 ========= master_lag: 0.21 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-05-10 09:01:34.717012) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-10 09:01:34.720354) ========= 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.PPZKt5CQ6p/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.SD5nwqIdgP/Listeners TMPDIR=/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/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/e1b093c1c523c2ac9e9962cf435973e7d451269dcbf6dee81638d5ff87eddeb52474bb00810a4ff2deed7b29744b4f9031a40d31a5ae1f8d9b84b3a3e440c8d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa299ee9eb865a3f4cd396c5f3d8a7cdb845eede976bbe8cb3d8437f68c59402e8bf8a083311df1d734d912623330aee0b7bb2bb3b86ccb5f35c69d333143753", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/492ede45737b099d20ab2f7d2647ad326cce9d1f3a33f94f3b73ba570f5a1f45f1fdaa00faace8de7fc674ff5d594dc434f41999898df2a5ca589aa2ae04e13b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a62fba5d3634971868f675b67b2d42231f1d7d8cea56b8bcb237434bf7f3de662e4f267df9f19ce56e82697e255d3444867300dca918a273d842ed143b328c92"} build_url:https://queue.taskcluster.net/v1/task/E_59EUdWTLWqPg30BD7Xiw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010968 build_url: 'https://queue.taskcluster.net/v1/task/E_59EUdWTLWqPg30BD7Xiw/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/e1b093c1c523c2ac9e9962cf435973e7d451269dcbf6dee81638d5ff87eddeb52474bb00810a4ff2deed7b29744b4f9031a40d31a5ae1f8d9b84b3a3e440c8d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa299ee9eb865a3f4cd396c5f3d8a7cdb845eede976bbe8cb3d8437f68c59402e8bf8a083311df1d734d912623330aee0b7bb2bb3b86ccb5f35c69d333143753", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/492ede45737b099d20ab2f7d2647ad326cce9d1f3a33f94f3b73ba570f5a1f45f1fdaa00faace8de7fc674ff5d594dc434f41999898df2a5ca589aa2ae04e13b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a62fba5d3634971868f675b67b2d42231f1d7d8cea56b8bcb237434bf7f3de662e4f267df9f19ce56e82697e255d3444867300dca918a273d842ed143b328c92"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-10 09:01:34.758152) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 09:01:34.758837) ========= 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.PPZKt5CQ6p/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.SD5nwqIdgP/Listeners TMPDIR=/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/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.005144 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 09:01:34.812319) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-10 09:01:34.813126) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-10 09:01:34.813978) ========= ========= Total master_lag: 0.36 =========