builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0300 starttime: 1488562928.09 results: success (0) buildid: 20170303085451 builduid: 91f42156658742c98dc44efe989f6515 revision: c565a618690d15933c1cd3a2830bc87ca8d21e7f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-03 09:42:08.088969) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-03 09:42:08.089441) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-03 09:42:08.089757) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-03 09:42:08.116837) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 09:42:08.117253) ========= 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.l2uRgkltpe/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.46LsyCEzQk/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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-03-03 09:42:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.6M=0.001s 2017-03-03 09:42:08 (18.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.093281 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 09:42:08.235443) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 09:42:08.235773) ========= 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.l2uRgkltpe/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.46LsyCEzQk/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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.032645 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 09:42:08.294009) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-03 09:42:08.294393) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c565a618690d15933c1cd3a2830bc87ca8d21e7f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c565a618690d15933c1cd3a2830bc87ca8d21e7f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.l2uRgkltpe/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.46LsyCEzQk/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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-03-03 09:42:08,403 truncating revision to first 12 chars 2017-03-03 09:42:08,403 Setting DEBUG logging. 2017-03-03 09:42:08,403 attempt 1/10 2017-03-03 09:42:08,403 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c565a618690d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-03 09:42:09,497 unpacking tar archive at: mozilla-aurora-c565a618690d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.372912 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-03 09:42:09.692174) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-03 09:42:09.692564) ========= script_repo_revision: c565a618690d15933c1cd3a2830bc87ca8d21e7f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-03 09:42:09.693013) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-03 09:42:09.693456) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-03 09:42:09.713937) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-03-03 09:42:09.714344) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.l2uRgkltpe/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.46LsyCEzQk/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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 09:42:09 INFO - MultiFileLogger online at 20170303 09:42:09 in /builds/slave/test 09:42:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:42:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:42:09 INFO - {'append_to_log': False, 09:42:09 INFO - 'base_work_dir': '/builds/slave/test', 09:42:09 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:42:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:42:09 INFO - 'branch': 'Mozilla-Aurora', 09:42:09 INFO - 'buildbot_json_path': 'buildprops.json', 09:42:09 INFO - 'config_files': ('talos/mac_config.py',), 09:42:09 INFO - 'default_actions': ('clobber', 09:42:09 INFO - 'read-buildbot-config', 09:42:09 INFO - 'download-and-extract', 09:42:09 INFO - 'populate-webroot', 09:42:09 INFO - 'create-virtualenv', 09:42:09 INFO - 'install', 09:42:09 INFO - 'run-tests'), 09:42:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:42:09 INFO - 'download_minidump_stackwalk': True, 09:42:09 INFO - 'download_symbols': 'ondemand', 09:42:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:42:09 INFO - 'tooltool.py': '/tools/tooltool.py', 09:42:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:42:09 INFO - '/tools/misc-python/virtualenv.py')}, 09:42:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:42:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:42:09 INFO - 'installer_path': 'installer.exe', 09:42:09 INFO - 'log_level': 'info', 09:42:09 INFO - 'log_name': 'talos', 09:42:09 INFO - 'log_to_console': True, 09:42:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:42:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:42:09 INFO - 'opt_config_files': (), 09:42:09 INFO - 'pip_index': False, 09:42:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:42:09 INFO - 'cmd': ('bash', 09:42:09 INFO - '-c', 09:42:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:42:09 INFO - 'enabled': True, 09:42:09 INFO - 'halt_on_failure': False, 09:42:09 INFO - 'name': 'check_screen_resolution'},), 09:42:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:42:09 INFO - 'cmd': ('bash', 09:42:09 INFO - '-c', 09:42:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:42:09 INFO - 'enabled': True, 09:42:09 INFO - 'halt_on_failure': False, 09:42:09 INFO - 'name': 'check_screen_resolution'},), 09:42:09 INFO - 'run_cmd_checks_enabled': True, 09:42:09 INFO - 'sps_profile': False, 09:42:09 INFO - 'sps_profile_interval': 0, 09:42:09 INFO - 'suite': 'dromaeojs', 09:42:09 INFO - 'system_bits': '32', 09:42:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:42:09 INFO - 'title': 't-yosemite-r7-0300', 09:42:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:42:09 INFO - 'use_talos_json': True, 09:42:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:42:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:42:09 INFO - 'work_dir': 'build'} 09:42:09 INFO - [mozharness: 2017-03-03 17:42:09.929255Z] Running clobber step. 09:42:09 INFO - Running pre-action listener: _resource_record_pre_action 09:42:09 INFO - Running main action method: clobber 09:42:09 INFO - rmtree: /builds/slave/test/build 09:42:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:42:12 INFO - Running post-action listener: _resource_record_post_action 09:42:12 INFO - [mozharness: 2017-03-03 17:42:12.317049Z] Finished clobber step (success) 09:42:12 INFO - [mozharness: 2017-03-03 17:42:12.317171Z] Running read-buildbot-config step. 09:42:12 INFO - Running pre-action listener: _resource_record_pre_action 09:42:12 INFO - Running main action method: read_buildbot_config 09:42:12 INFO - Using buildbot properties: 09:42:12 INFO - { 09:42:12 INFO - "project": "", 09:42:12 INFO - "product": "firefox", 09:42:12 INFO - "script_repo_revision": "production", 09:42:12 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 09:42:12 INFO - "repository": "", 09:42:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 09:42:12 INFO - "buildid": "20170303085451", 09:42:12 INFO - "pgo_build": "False", 09:42:12 INFO - "basedir": "/builds/slave/test", 09:42:12 INFO - "buildnumber": 2, 09:42:12 INFO - "slavename": "t-yosemite-r7-0300", 09:42:12 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 09:42:12 INFO - "platform": "yosemite_r7", 09:42:12 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:42:12 INFO - "branch": "mozilla-aurora", 09:42:12 INFO - "repo_path": "releases/mozilla-aurora", 09:42:12 INFO - "revision": "c565a618690d15933c1cd3a2830bc87ca8d21e7f", 09:42:12 INFO - "stage_platform": "macosx64", 09:42:12 INFO - "builduid": "91f42156658742c98dc44efe989f6515", 09:42:12 INFO - "slavebuilddir": "test" 09:42:12 INFO - } 09:42:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/fXuSs949RBSJiFZrnc6Mig/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 09:42:12 INFO - Running post-action listener: _resource_record_post_action 09:42:12 INFO - [mozharness: 2017-03-03 17:42:12.320543Z] Finished read-buildbot-config step (success) 09:42:12 INFO - [mozharness: 2017-03-03 17:42:12.320678Z] Running download-and-extract step. 09:42:12 INFO - Running pre-action listener: _resource_record_pre_action 09:42:12 INFO - Running main action method: download_and_extract 09:42:12 INFO - mkdir: /builds/slave/test/build/tests 09:42:12 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')]} 09:42:12 INFO - trying https://queue.taskcluster.net/v1/task/fXuSs949RBSJiFZrnc6Mig/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 09:42:12 INFO - Downloading https://queue.taskcluster.net/v1/task/fXuSs949RBSJiFZrnc6Mig/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 09:42:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fXuSs949RBSJiFZrnc6Mig/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 09:42:13 INFO - Downloaded 1199 bytes. 09:42:13 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 09:42:13 INFO - Using the following test package requirements: 09:42:13 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 09:42:13 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:42:13 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 09:42:13 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:42:13 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 09:42:13 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:42:13 INFO - u'jsshell-mac.zip'], 09:42:13 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:42:13 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 09:42:13 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 09:42:13 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:42:13 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 09:42:13 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:42:13 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 09:42:13 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:42:13 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 09:42:13 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:42:13 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 09:42:13 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:42:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fXuSs949RBSJiFZrnc6Mig/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 09:42:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fXuSs949RBSJiFZrnc6Mig/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:42:13 INFO - Fetch https://queue.taskcluster.net/v1/task/fXuSs949RBSJiFZrnc6Mig/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 09:42:14 INFO - Expected file size: 16357680 09:42:14 INFO - Obtained file size: 16357680 09:42:21 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 09:42:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fXuSs949RBSJiFZrnc6Mig/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 09:42:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fXuSs949RBSJiFZrnc6Mig/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:42:21 INFO - Fetch https://queue.taskcluster.net/v1/task/fXuSs949RBSJiFZrnc6Mig/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 09:42:22 INFO - Expected file size: 16357680 09:42:22 INFO - Obtained file size: 16357680 09:42:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fXuSs949RBSJiFZrnc6Mig/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 09:42:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fXuSs949RBSJiFZrnc6Mig/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:42:28 INFO - Fetch https://queue.taskcluster.net/v1/task/fXuSs949RBSJiFZrnc6Mig/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 09:42:30 INFO - Expected file size: 14403650 09:42:30 INFO - Obtained file size: 14403650 09:42:30 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')]} 09:42:30 INFO - trying https://queue.taskcluster.net/v1/task/fXuSs949RBSJiFZrnc6Mig/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:42:30 INFO - Downloading https://queue.taskcluster.net/v1/task/fXuSs949RBSJiFZrnc6Mig/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 09:42:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fXuSs949RBSJiFZrnc6Mig/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 09:42:32 INFO - Downloaded 73927708 bytes. 09:42:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fXuSs949RBSJiFZrnc6Mig/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:42:32 INFO - mkdir: /builds/slave/test/properties 09:42:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:42:32 INFO - Writing to file /builds/slave/test/properties/build_url 09:42:32 INFO - Contents: 09:42:32 INFO - build_url:https://queue.taskcluster.net/v1/task/fXuSs949RBSJiFZrnc6Mig/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:42:33 INFO - Running post-action listener: _resource_record_post_action 09:42:33 INFO - Running post-action listener: set_extra_try_arguments 09:42:33 INFO - [mozharness: 2017-03-03 17:42:33.090679Z] Finished download-and-extract step (success) 09:42:33 INFO - [mozharness: 2017-03-03 17:42:33.090830Z] Running populate-webroot step. 09:42:33 INFO - Running pre-action listener: _resource_record_pre_action 09:42:33 INFO - Running main action method: populate_webroot 09:42:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:42:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:42:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:42:33 INFO - '--tppagecycles', 09:42:33 INFO - '7'], 09:42:33 INFO - 'tests': ['tsvgm']}}, 09:42:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:42:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:42:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:42:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:42:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:42:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:42:33 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:42:33 INFO - 'talos_options': ['--disable-e10s'], 09:42:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:42:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:42:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:42:33 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:42:33 INFO - 'talos_options': ['--disable-e10s'], 09:42:33 INFO - 'tests': ['damp', 'tps']}, 09:42:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:42:33 INFO - 'tests': ['damp', 'tps']}, 09:42:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:42:33 INFO - 'tests': ['dromaeo_dom']}, 09:42:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:42:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:42:33 INFO - 'tests': ['basic_compositor_video']}, 09:42:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:42:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:42:33 INFO - 'tests': ['a11yr', 09:42:33 INFO - 'ts_paint', 09:42:33 INFO - 'tpaint', 09:42:33 INFO - 'sessionrestore', 09:42:33 INFO - 'sessionrestore_no_auto_restore', 09:42:33 INFO - 'tabpaint']}, 09:42:33 INFO - 'other-e10s': {'tests': ['a11yr', 09:42:33 INFO - 'ts_paint', 09:42:33 INFO - 'tpaint', 09:42:33 INFO - 'sessionrestore', 09:42:33 INFO - 'sessionrestore_no_auto_restore', 09:42:33 INFO - 'tabpaint']}, 09:42:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:42:33 INFO - 'ts_paint', 09:42:33 INFO - 'tpaint', 09:42:33 INFO - 'sessionrestore', 09:42:33 INFO - 'sessionrestore_no_auto_restore', 09:42:33 INFO - 'tabpaint']}, 09:42:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:42:33 INFO - 'ts_paint', 09:42:33 INFO - 'tpaint', 09:42:33 INFO - 'sessionrestore', 09:42:33 INFO - 'sessionrestore_no_auto_restore', 09:42:33 INFO - 'tabpaint']}, 09:42:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:42:33 INFO - 'tests': ['a11yr', 09:42:33 INFO - 'ts_paint', 09:42:33 INFO - 'tpaint', 09:42:33 INFO - 'sessionrestore', 09:42:33 INFO - 'sessionrestore_no_auto_restore', 09:42:33 INFO - 'tabpaint']}, 09:42:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:42:33 INFO - 'tests': ['a11yr', 09:42:33 INFO - 'ts_paint', 09:42:33 INFO - 'tpaint', 09:42:33 INFO - 'sessionrestore', 09:42:33 INFO - 'sessionrestore_no_auto_restore', 09:42:33 INFO - 'tabpaint']}, 09:42:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:42:33 INFO - 'tests': ['tsvgx', 09:42:33 INFO - 'tsvgr_opacity', 09:42:33 INFO - 'tart', 09:42:33 INFO - 'tscrollx', 09:42:33 INFO - 'cart', 09:42:33 INFO - 'tsvg_static']}, 09:42:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:42:33 INFO - 'tsvgr_opacity', 09:42:33 INFO - 'tart', 09:42:33 INFO - 'tscrollx', 09:42:33 INFO - 'cart', 09:42:33 INFO - 'tsvg_static']}, 09:42:33 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:42:33 INFO - 'talos_options': ['--disable-e10s'], 09:42:33 INFO - 'tests': ['tp5o']}, 09:42:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:42:33 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:42:33 INFO - 'talos_options': ['--disable-e10s', 09:42:33 INFO - '--xperf_path', 09:42:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:42:33 INFO - 'tests': ['tp5n']}, 09:42:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:42:33 INFO - 'talos_options': ['--xperf_path', 09:42:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:42:33 INFO - 'tests': ['tp5n']}}, 09:42:33 INFO - 'talos.zip': {'path': '', 09:42:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:42:33 INFO - Running post-action listener: _resource_record_post_action 09:42:33 INFO - [mozharness: 2017-03-03 17:42:33.108996Z] Finished populate-webroot step (success) 09:42:33 INFO - [mozharness: 2017-03-03 17:42:33.109136Z] Running create-virtualenv step. 09:42:33 INFO - Running pre-action listener: _resource_record_pre_action 09:42:33 INFO - Running main action method: create_virtualenv 09:42:33 INFO - Creating virtualenv /builds/slave/test/build/venv 09:42:33 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 09:42:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:42:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:42:33 INFO - Using real prefix '/tools/python27' 09:42:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:42:33 INFO - Installing distribute.............................................................................................................................................................................................done. 09:42:36 INFO - Installing pip.................done. 09:42:36 INFO - Return code: 0 09:42:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:42:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:42:37 INFO - Reading from file tmpfile_stdout 09:42:37 INFO - Output received: 09:42:37 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) 09:42:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:42:37 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')]} 09:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:37 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')]} 09:42:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:37 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 0x10dadeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dae1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2f2c66000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8bcd30>, '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 0x10d7e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8b1be8>, '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.l2uRgkltpe/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.46LsyCEzQk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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 09:42:37 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 09:42:37 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 09:42:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l2uRgkltpe/Render', 09:42:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:42:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:42:37 INFO - 'HOME': '/Users/cltbld', 09:42:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:42:37 INFO - 'LOGNAME': 'cltbld', 09:42:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:37 INFO - 'MOZ_NO_REMOTE': '1', 09:42:37 INFO - 'NO_EM_RESTART': '1', 09:42:37 INFO - 'PAGER': '/bin/cat', 09:42:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:42:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:37 INFO - 'PWD': '/builds/slave/test', 09:42:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:42:37 INFO - 'SHELL': '/bin/bash', 09:42:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.46LsyCEzQk/Listeners', 09:42:37 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 09:42:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:42:37 INFO - 'USER': 'cltbld', 09:42:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:42:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:42:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:37 INFO - 'XPC_FLAGS': '0x0', 09:42:37 INFO - 'XPC_SERVICE_NAME': '0', 09:42:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:42:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:37 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 09:42:37 INFO - Cleaning up... 09:42:37 INFO - Return code: 0 09:42:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:42:37 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')]} 09:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:37 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')]} 09:42:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:37 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 0x10dadeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dae1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2f2c66000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8bcd30>, '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 0x10d7e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8b1be8>, '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.l2uRgkltpe/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.46LsyCEzQk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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 09:42:37 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 09:42:37 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 09:42:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l2uRgkltpe/Render', 09:42:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:42:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:42:37 INFO - 'HOME': '/Users/cltbld', 09:42:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:42:37 INFO - 'LOGNAME': 'cltbld', 09:42:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:37 INFO - 'MOZ_NO_REMOTE': '1', 09:42:37 INFO - 'NO_EM_RESTART': '1', 09:42:37 INFO - 'PAGER': '/bin/cat', 09:42:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:42:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:37 INFO - 'PWD': '/builds/slave/test', 09:42:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:42:37 INFO - 'SHELL': '/bin/bash', 09:42:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.46LsyCEzQk/Listeners', 09:42:37 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 09:42:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:42:37 INFO - 'USER': 'cltbld', 09:42:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:42:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:42:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:37 INFO - 'XPC_FLAGS': '0x0', 09:42:37 INFO - 'XPC_SERVICE_NAME': '0', 09:42:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:42:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:37 INFO - Downloading/unpacking psutil>=3.1.1 09:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:42:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:42:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:42:41 INFO - Installing collected packages: psutil 09:42:41 INFO - Running setup.py install for psutil 09:42:41 INFO - building 'psutil._psutil_osx' extension 09:42:41 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 09:42:41 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 09:42:41 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 09:42:41 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 09:42:41 INFO - building 'psutil._psutil_posix' extension 09:42:41 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 09:42:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:42:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:42:42 INFO - ^ 09:42:42 INFO - 1 warning generated. 09:42:42 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 09:42:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:42:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:42:42 INFO - Successfully installed psutil 09:42:42 INFO - Cleaning up... 09:42:42 INFO - Return code: 0 09:42:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:42 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 0x10dadeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dae1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2f2c66000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8bcd30>, '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 0x10d7e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8b1be8>, '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.l2uRgkltpe/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.46LsyCEzQk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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 09:42:42 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 09:42:42 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 09:42:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l2uRgkltpe/Render', 09:42:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:42:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:42:42 INFO - 'HOME': '/Users/cltbld', 09:42:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:42:42 INFO - 'LOGNAME': 'cltbld', 09:42:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:42 INFO - 'MOZ_NO_REMOTE': '1', 09:42:42 INFO - 'NO_EM_RESTART': '1', 09:42:42 INFO - 'PAGER': '/bin/cat', 09:42:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:42:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:42 INFO - 'PWD': '/builds/slave/test', 09:42:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:42:42 INFO - 'SHELL': '/bin/bash', 09:42:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.46LsyCEzQk/Listeners', 09:42:42 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 09:42:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:42:42 INFO - 'USER': 'cltbld', 09:42:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:42:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:42:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:42 INFO - 'XPC_FLAGS': '0x0', 09:42:42 INFO - 'XPC_SERVICE_NAME': '0', 09:42:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:42:42 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 09:42:42 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 09:42:42 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 09:42:42 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 09:42:42 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 09:42:42 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 09:42:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:42:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:42:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:42:45 INFO - Installing collected packages: mozsystemmonitor 09:42:45 INFO - Running setup.py install for mozsystemmonitor 09:42:45 INFO - Successfully installed mozsystemmonitor 09:42:45 INFO - Cleaning up... 09:42:45 INFO - Return code: 0 09:42:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:42:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:45 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 0x10dadeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dae1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2f2c66000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8bcd30>, '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 0x10d7e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8b1be8>, '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.l2uRgkltpe/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.46LsyCEzQk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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 09:42:45 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 09:42:45 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 09:42:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l2uRgkltpe/Render', 09:42:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:42:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:42:45 INFO - 'HOME': '/Users/cltbld', 09:42:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:42:45 INFO - 'LOGNAME': 'cltbld', 09:42:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:45 INFO - 'MOZ_NO_REMOTE': '1', 09:42:45 INFO - 'NO_EM_RESTART': '1', 09:42:45 INFO - 'PAGER': '/bin/cat', 09:42:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:42:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:45 INFO - 'PWD': '/builds/slave/test', 09:42:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:42:45 INFO - 'SHELL': '/bin/bash', 09:42:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.46LsyCEzQk/Listeners', 09:42:45 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 09:42:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:42:45 INFO - 'USER': 'cltbld', 09:42:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:42:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:42:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:45 INFO - 'XPC_FLAGS': '0x0', 09:42:45 INFO - 'XPC_SERVICE_NAME': '0', 09:42:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:42:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:45 INFO - Downloading/unpacking jsonschema==2.5.1 09:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:42:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:48 INFO - Downloading functools32-3.2.3-2.tar.gz 09:42:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:42:48 INFO - warning: no files found matching '*.txt' 09:42:48 INFO - no previously-included directories found matching 'build' 09:42:48 INFO - no previously-included directories found matching 'dist' 09:42:48 INFO - no previously-included directories found matching '.git*' 09:42:48 INFO - Installing collected packages: jsonschema, functools32 09:42:49 INFO - Running setup.py install for functools32 09:42:49 INFO - warning: no files found matching '*.txt' 09:42:49 INFO - no previously-included directories found matching 'build' 09:42:49 INFO - no previously-included directories found matching 'dist' 09:42:49 INFO - no previously-included directories found matching '.git*' 09:42:49 INFO - Successfully installed jsonschema functools32 09:42:49 INFO - Cleaning up... 09:42:49 INFO - Return code: 0 09:42:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:42: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')]} 09:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42: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')]} 09:42:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10dadeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dae1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2f2c66000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8bcd30>, '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 0x10d7e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8b1be8>, '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.l2uRgkltpe/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.46LsyCEzQk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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 09:42:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:42:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:42:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l2uRgkltpe/Render', 09:42:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:42:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:42:49 INFO - 'HOME': '/Users/cltbld', 09:42:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:42:49 INFO - 'LOGNAME': 'cltbld', 09:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:49 INFO - 'MOZ_NO_REMOTE': '1', 09:42:49 INFO - 'NO_EM_RESTART': '1', 09:42:49 INFO - 'PAGER': '/bin/cat', 09:42:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:49 INFO - 'PWD': '/builds/slave/test', 09:42:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:42:49 INFO - 'SHELL': '/bin/bash', 09:42:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.46LsyCEzQk/Listeners', 09:42:49 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 09:42:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:42:49 INFO - 'USER': 'cltbld', 09:42:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:42:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:49 INFO - 'XPC_FLAGS': '0x0', 09:42:49 INFO - 'XPC_SERVICE_NAME': '0', 09:42:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:42:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:42:49 INFO - Cleaning up... 09:42:49 INFO - Return code: 0 09:42:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:42: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')]} 09:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42: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')]} 09:42:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10dadeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dae1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2f2c66000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8bcd30>, '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 0x10d7e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8b1be8>, '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.l2uRgkltpe/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.46LsyCEzQk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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 09:42:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:42:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:42:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l2uRgkltpe/Render', 09:42:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:42:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:42:49 INFO - 'HOME': '/Users/cltbld', 09:42:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:42:49 INFO - 'LOGNAME': 'cltbld', 09:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:49 INFO - 'MOZ_NO_REMOTE': '1', 09:42:49 INFO - 'NO_EM_RESTART': '1', 09:42:49 INFO - 'PAGER': '/bin/cat', 09:42:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:49 INFO - 'PWD': '/builds/slave/test', 09:42:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:42:49 INFO - 'SHELL': '/bin/bash', 09:42:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.46LsyCEzQk/Listeners', 09:42:49 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 09:42:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:42:49 INFO - 'USER': 'cltbld', 09:42:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:42:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:49 INFO - 'XPC_FLAGS': '0x0', 09:42:49 INFO - 'XPC_SERVICE_NAME': '0', 09:42:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:42:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:49 INFO - Downloading/unpacking blobuploader==1.2.4 09:42:49 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 09:42:49 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 09:42:49 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 09:42:49 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 09:42:49 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 09:42:49 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 09:42:52 INFO - Downloading blobuploader-1.2.4.tar.gz 09:42:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:42:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:42:52 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 09:42:52 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 09:42:52 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 09:42:52 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 09:42:52 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 09:42:52 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 09:42:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:42:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:53 INFO - Downloading docopt-0.6.1.tar.gz 09:42:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:42:53 INFO - Installing collected packages: blobuploader, requests, docopt 09:42:53 INFO - Running setup.py install for blobuploader 09:42:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:42:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:42:53 INFO - Running setup.py install for requests 09:42:54 INFO - Running setup.py install for docopt 09:42:54 INFO - Successfully installed blobuploader requests docopt 09:42:54 INFO - Cleaning up... 09:42:54 INFO - Return code: 0 09:42:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:42:54 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')]} 09:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:54 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')]} 09:42:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:54 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 0x10dadeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dae1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2f2c66000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8bcd30>, '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 0x10d7e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8b1be8>, '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.l2uRgkltpe/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.46LsyCEzQk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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 09:42:54 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 09:42:54 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 09:42:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l2uRgkltpe/Render', 09:42:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:42:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:42:54 INFO - 'HOME': '/Users/cltbld', 09:42:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:42:54 INFO - 'LOGNAME': 'cltbld', 09:42:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:54 INFO - 'MOZ_NO_REMOTE': '1', 09:42:54 INFO - 'NO_EM_RESTART': '1', 09:42:54 INFO - 'PAGER': '/bin/cat', 09:42:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:42:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:54 INFO - 'PWD': '/builds/slave/test', 09:42:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:42:54 INFO - 'SHELL': '/bin/bash', 09:42:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.46LsyCEzQk/Listeners', 09:42:54 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 09:42:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:42:54 INFO - 'USER': 'cltbld', 09:42:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:42:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:42:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:54 INFO - 'XPC_FLAGS': '0x0', 09:42:54 INFO - 'XPC_SERVICE_NAME': '0', 09:42:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:42:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:42:54 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-ZOvlAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:42:54 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-0QytX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:42:55 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-fnphga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:42:55 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-lW9qKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:42:55 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-_ecEPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:42:55 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-ZIb4uU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:42:55 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-K4_eYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:42:55 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-8ZQFhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:42:55 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-kho2CZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:42:55 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-ugKHYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:42:55 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-5DmEmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:42:55 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-xviWuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:42:56 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-qbJUZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:42:56 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-pBdOl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:42:56 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-kuEUg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:42:56 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-P2eNt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:42:56 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-NfIxWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:42:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:42:56 INFO - Running setup.py install for manifestparser 09:42:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:42:56 INFO - Running setup.py install for mozcrash 09:42:56 INFO - Running setup.py install for mozdebug 09:42:57 INFO - Running setup.py install for mozdevice 09:42:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:42:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:42:57 INFO - Running setup.py install for mozfile 09:42:57 INFO - Running setup.py install for mozhttpd 09:42:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:42:57 INFO - Running setup.py install for mozinfo 09:42:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:42:57 INFO - Running setup.py install for mozInstall 09:42:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:42:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:42:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:42:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:42:57 INFO - Running setup.py install for mozleak 09:42:57 INFO - Running setup.py install for mozlog 09:42:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:42:58 INFO - Running setup.py install for moznetwork 09:42:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:42:58 INFO - Running setup.py install for mozprocess 09:42:58 INFO - Running setup.py install for mozprofile 09:42:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:42:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:42:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:42:58 INFO - Running setup.py install for mozrunner 09:42:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:42:58 INFO - Running setup.py install for mozscreenshot 09:42:58 INFO - Running setup.py install for moztest 09:42:59 INFO - Running setup.py install for mozversion 09:42:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:42:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:42:59 INFO - Cleaning up... 09:42:59 INFO - Return code: 0 09:42:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:42:59 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')]} 09:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:59 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')]} 09:42:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:59 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 0x10dadeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dae1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2f2c66000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8bcd30>, '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 0x10d7e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8b1be8>, '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.l2uRgkltpe/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.46LsyCEzQk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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 09:42:59 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 09:42:59 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 09:42:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l2uRgkltpe/Render', 09:42:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:42:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:42:59 INFO - 'HOME': '/Users/cltbld', 09:42:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:42:59 INFO - 'LOGNAME': 'cltbld', 09:42:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:59 INFO - 'MOZ_NO_REMOTE': '1', 09:42:59 INFO - 'NO_EM_RESTART': '1', 09:42:59 INFO - 'PAGER': '/bin/cat', 09:42:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:42:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:59 INFO - 'PWD': '/builds/slave/test', 09:42:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:42:59 INFO - 'SHELL': '/bin/bash', 09:42:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.46LsyCEzQk/Listeners', 09:42:59 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 09:42:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:42:59 INFO - 'USER': 'cltbld', 09:42:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:42:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:42:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:59 INFO - 'XPC_FLAGS': '0x0', 09:42:59 INFO - 'XPC_SERVICE_NAME': '0', 09:42:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:42:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:42:59 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-G9Ale2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:42:59 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)) 09:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:42:59 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-mr14vF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:42:59 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)) 09:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:42:59 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-rbfEny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:42:59 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)) 09:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:42:59 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-LScRJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:42:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 09:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:42:59 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-MHqieP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:42:59 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)) 09:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:42:59 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-m86i_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:43:00 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)) 09:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:43:00 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-zOqQA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:43:00 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)) 09:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:43:00 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-o0Dh7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:43:00 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)) 09:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:43:00 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-isSWwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:43:00 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)) 09:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:43:00 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-uwAyP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:43:00 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)) 09:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:43:00 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-YI73nc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:43:00 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)) 09:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:43:00 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-VZFdPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 09:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:43:00 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-gOO8EG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:43:00 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)) 09:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:43:00 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-_OWDKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:43:00 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)) 09:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:43:00 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-mdNn9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:43:01 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)) 09:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:43:01 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-IRgsnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:43:01 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)) 09:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:43:01 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-50aL4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:43:01 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)) 09:43:01 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)) 09:43:01 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)) 09:43:01 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)) 09:43:01 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:43:01 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:43:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:03 INFO - Downloading blessings-1.6.tar.gz 09:43:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:43:03 INFO - Installing collected packages: blessings 09:43:03 INFO - Running setup.py install for blessings 09:43:04 INFO - Successfully installed blessings 09:43:04 INFO - Cleaning up... 09:43:04 INFO - Return code: 0 09:43:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:43:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:43:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:43:04 INFO - Reading from file tmpfile_stdout 09:43:04 INFO - Current package versions: 09:43:04 INFO - blessings == 1.6 09:43:04 INFO - blobuploader == 1.2.4 09:43:04 INFO - docopt == 0.6.1 09:43:04 INFO - functools32 == 3.2.3-2 09:43:04 INFO - jsonschema == 2.5.1 09:43:04 INFO - manifestparser == 1.1 09:43:04 INFO - mozInstall == 1.12 09:43:04 INFO - mozcrash == 1.0 09:43:04 INFO - mozdebug == 0.1 09:43:04 INFO - mozdevice == 0.49 09:43:04 INFO - mozfile == 1.2 09:43:04 INFO - mozhttpd == 0.7 09:43:04 INFO - mozinfo == 0.9 09:43:04 INFO - mozleak == 0.1 09:43:04 INFO - mozlog == 3.4 09:43:04 INFO - moznetwork == 0.27 09:43:04 INFO - mozprocess == 0.24 09:43:04 INFO - mozprofile == 0.28 09:43:04 INFO - mozrunner == 6.13 09:43:04 INFO - mozscreenshot == 0.1 09:43:04 INFO - mozsystemmonitor == 0.3 09:43:04 INFO - moztest == 0.8 09:43:04 INFO - mozversion == 1.4 09:43:04 INFO - psutil == 3.1.1 09:43:04 INFO - requests == 1.2.3 09:43:04 INFO - wsgiref == 0.1.2 09:43:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:43:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:05 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 0x10dadeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dae1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2f2c66000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8bcd30>, '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 0x10d7e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8b1be8>, '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.l2uRgkltpe/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.46LsyCEzQk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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 09:43:05 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 09:43:05 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 09:43:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l2uRgkltpe/Render', 09:43:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:43:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:43:05 INFO - 'HOME': '/Users/cltbld', 09:43:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:43:05 INFO - 'LOGNAME': 'cltbld', 09:43:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:05 INFO - 'MOZ_NO_REMOTE': '1', 09:43:05 INFO - 'NO_EM_RESTART': '1', 09:43:05 INFO - 'PAGER': '/bin/cat', 09:43:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:43:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:05 INFO - 'PWD': '/builds/slave/test', 09:43:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:43:05 INFO - 'SHELL': '/bin/bash', 09:43:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.46LsyCEzQk/Listeners', 09:43:05 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 09:43:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:43:05 INFO - 'USER': 'cltbld', 09:43:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:43:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:43:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:05 INFO - 'XPC_FLAGS': '0x0', 09:43:05 INFO - 'XPC_SERVICE_NAME': '0', 09:43:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:43:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:05 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)) 09:43:05 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)) 09:43:05 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)) 09:43:05 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)) 09:43:05 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)) 09:43:05 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)) 09:43:05 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)) 09:43:05 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)) 09:43:05 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)) 09:43:05 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)) 09:43:05 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)) 09:43:05 INFO - Cleaning up... 09:43:05 INFO - Return code: 0 09:43:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:43:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:43:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:06 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 0x10dadeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dae1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2f2c66000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8bcd30>, '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 0x10d7e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8b1be8>, '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.l2uRgkltpe/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.46LsyCEzQk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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 09:43:06 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 09:43:06 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 09:43:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l2uRgkltpe/Render', 09:43:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:43:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:43:06 INFO - 'HOME': '/Users/cltbld', 09:43:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:43:06 INFO - 'LOGNAME': 'cltbld', 09:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:06 INFO - 'MOZ_NO_REMOTE': '1', 09:43:06 INFO - 'NO_EM_RESTART': '1', 09:43:06 INFO - 'PAGER': '/bin/cat', 09:43:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:06 INFO - 'PWD': '/builds/slave/test', 09:43:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:43:06 INFO - 'SHELL': '/bin/bash', 09:43:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.46LsyCEzQk/Listeners', 09:43:06 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 09:43:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:43:06 INFO - 'USER': 'cltbld', 09:43:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:43:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:06 INFO - 'XPC_FLAGS': '0x0', 09:43:06 INFO - 'XPC_SERVICE_NAME': '0', 09:43:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:43:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:43:06 INFO - Cleaning up... 09:43:06 INFO - Return code: 0 09:43:06 INFO - Running post-action listener: _resource_record_post_action 09:43:06 INFO - Running post-action listener: _start_resource_monitoring 09:43:06 INFO - Starting resource monitoring. 09:43:06 INFO - [mozharness: 2017-03-03 17:43:06.590279Z] Finished create-virtualenv step (success) 09:43:06 INFO - [mozharness: 2017-03-03 17:43:06.591230Z] Running install step. 09:43:06 INFO - Running pre-action listener: _resource_record_pre_action 09:43:06 INFO - Running main action method: install 09:43:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:43:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:43:06 INFO - Reading from file tmpfile_stdout 09:43:06 INFO - Detecting whether we're running mozinstall >=1.0... 09:43:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:43:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:43:06 INFO - Reading from file tmpfile_stdout 09:43:06 INFO - Output received: 09:43:06 INFO - Usage: mozinstall [options] installer 09:43:06 INFO - Options: 09:43:06 INFO - -h, --help show this help message and exit 09:43:06 INFO - -d DEST, --destination=DEST 09:43:06 INFO - Directory to install application into. [default: 09:43:06 INFO - "/builds/slave/test"] 09:43:06 INFO - --app=APP Application being installed. [default: firefox] 09:43:06 INFO - mkdir: /builds/slave/test/build/application 09:43:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:43:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 09:43:26 INFO - Reading from file tmpfile_stdout 09:43:26 INFO - Output received: 09:43:26 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:43:26 INFO - Running post-action listener: _resource_record_post_action 09:43:26 INFO - [mozharness: 2017-03-03 17:43:26.907320Z] Finished install step (success) 09:43:26 INFO - [mozharness: 2017-03-03 17:43:26.907479Z] Running run-tests step. 09:43:26 INFO - Running pre-action listener: _resource_record_pre_action 09:43:26 INFO - Running main action method: run_tests 09:43:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:43:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:43:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:43:26 INFO - 2017-03-03 09:43:26.921 screenresolution[1629:7368] starting screenresolution argv=screenresolution get 09:43:26 INFO - 2017-03-03 09:43:26.924 screenresolution[1629:7368] Display 0: 1600x1200x32@60 09:43:26 INFO - 2017-03-03 09:43:26.930 screenresolution[1630:7371] starting screenresolution argv=screenresolution list 09:43:26 INFO - Available Modes on Display 0 09:43:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:43:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:43:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:43:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:43:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:43:27 INFO - Intel Iris: 09:43:27 INFO - Chipset Model: Intel Iris 09:43:27 INFO - Type: GPU 09:43:27 INFO - Bus: Built-In 09:43:27 INFO - VRAM (Dynamic, Max): 1536 MB 09:43:27 INFO - Vendor: Intel (0x8086) 09:43:27 INFO - Device ID: 0x0a2e 09:43:27 INFO - Revision ID: 0x0009 09:43:27 INFO - Displays: 09:43:27 INFO - Display: 09:43:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:43:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:43:27 INFO - Display Serial Number: 1600x1200 60 09:43:27 INFO - Main Display: Yes 09:43:27 INFO - Mirror: Off 09:43:27 INFO - Online: Yes 09:43:27 INFO - Rotation: Supported 09:43:27 INFO - Return code: 0 09:43:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:43:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:43:27 INFO - Python 2.7.3 09:43:27 INFO - Return code: 0 09:43:27 INFO - grabbing minidump binary from tooltool 09:43:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:43:27 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 0x10d8bcd30>, '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 0x10d7e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8b1be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:43:27 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 09:43:27 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 09:43:27 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 09:43:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:43:27 INFO - Return code: 0 09:43:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:43:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:43:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:43:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:43:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:43:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fXuSs949RBSJiFZrnc6Mig/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0300', '--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 09:43:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fXuSs949RBSJiFZrnc6Mig/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0300 --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 09:43:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l2uRgkltpe/Render', 09:43:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:43:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:43:27 INFO - 'HOME': '/Users/cltbld', 09:43:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:43:27 INFO - 'LOGNAME': 'cltbld', 09:43:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:43:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:43:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:27 INFO - 'MOZ_NO_REMOTE': '1', 09:43:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:43:27 INFO - 'NO_EM_RESTART': '1', 09:43:27 INFO - 'PAGER': '/bin/cat', 09:43:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:43:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:27 INFO - 'PWD': '/builds/slave/test', 09:43:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:43:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:43:27 INFO - 'SHELL': '/bin/bash', 09:43:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.46LsyCEzQk/Listeners', 09:43:27 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 09:43:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:43:27 INFO - 'USER': 'cltbld', 09:43:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:43:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:43:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:27 INFO - 'XPC_FLAGS': '0x0', 09:43:27 INFO - 'XPC_SERVICE_NAME': '0', 09:43:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:43:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fXuSs949RBSJiFZrnc6Mig/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0300', '--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 09:43:27 INFO - mozversion application_buildid: 20170303085451 09:43:27 INFO - mozversion application_changeset: c565a618690d15933c1cd3a2830bc87ca8d21e7f 09:43:27 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:43:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:43:27 INFO - mozversion application_name: Firefox 09:43:27 INFO - mozversion application_remotingname: firefox-dev 09:43:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:43:27 INFO - mozversion application_vendor: Mozilla 09:43:27 INFO - mozversion application_version: 53.0a2 09:43:27 INFO - mozversion platform_buildid: 20170303085451 09:43:27 INFO - mozversion platform_changeset: c565a618690d15933c1cd3a2830bc87ca8d21e7f 09:43:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:43:27 INFO - mozversion platform_version: 53.0a2 09:43:27 INFO - using testdate: 1488563007 09:43:27 INFO - actual date: 1488563007 09:43:27 INFO - starting webserver on 'localhost:49249' 09:43:27 INFO - SUITE-START | Running 2 tests 09:43:27 INFO - TEST-START | dromaeo_css 09:43:27 INFO - operating with platform_type : mac_ 09:43:27 INFO - Initialising browser for dromaeo_css test... 09:43:27 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/tmpB3ds9v/profile http://localhost:49249/getInfo.html) 09:43:29 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 09:43:29 INFO - PROCESS | 1640 | colorDepth:24 09:43:29 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 09:43:29 INFO - PROCESS | 1640 | __metrics 09:43:29 INFO - PROCESS | 1640 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:43:29 INFO - PROCESS | 1640 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:43:30 INFO - TEST-INFO | 1640: exit 0 09:43:30 INFO - Browser initialized. 09:43:30 INFO - Running cycle 1/1 for dromaeo_css test... 09:43:30 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/tmpB3ds9v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:43:42 INFO - PROCESS | 1642 | RSS: Main: 212836352 09:43:42 INFO - PROCESS | 1642 | 09:46:46 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49249/tests/dromaeo/cssquery-ext.html) 09:46:47 INFO - PROCESS | 1642 | RSS: Main: 352706560 09:46:47 INFO - PROCESS | 1642 | 09:48:32 INFO - PROCESS | 1642 | ************************* 09:48:32 INFO - PROCESS | 1642 | A coding exception was thrown and uncaught in a Task. 09:48:32 INFO - PROCESS | 1642 | 09:48:32 ERROR - PROCESS | 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:48:32 INFO - PROCESS | 1642 | Full stack: 09:48:32 INFO - PROCESS | 1642 | ************************* 09:49:50 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-ext.html (next: http://localhost:49249/tests/dromaeo/cssquery-jquery.html) 09:49:51 INFO - PROCESS | 1642 | RSS: Main: 367501312 09:49:51 INFO - PROCESS | 1642 | 09:52:53 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49249/tests/dromaeo/cssquery-mootools.html) 09:52:54 INFO - PROCESS | 1642 | RSS: Main: 333053952 09:52:54 INFO - PROCESS | 1642 | 09:55:56 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49249/tests/dromaeo/cssquery-prototype.html) 09:55:57 INFO - PROCESS | 1642 | RSS: Main: 316280832 09:55:57 INFO - PROCESS | 1642 | 09:59:00 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49249/tests/dromaeo/cssquery-yui.html) 09:59:01 INFO - PROCESS | 1642 | RSS: Main: 311611392 09:59:01 INFO - PROCESS | 1642 | 10:02:05 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-yui.html (next: http://localhost:49249/tests/dromaeo/cssquery-dojo.html) 10:02:05 INFO - PROCESS | 1642 | RSS: Main: 411037696 10:02:05 INFO - PROCESS | 1642 | 10:02:05 INFO - PROCESS | 1642 | __start_tp_report 10:02:05 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 10:02:05 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 10:02:05 INFO - PROCESS | 1642 | |i|pagename|runs| 10:02:05 INFO - PROCESS | 1642 | |0;dojo.html;3352.0781785009126;3360.3111362170757;3371.612264589573;3384.27238143799;3418.982905085476;5768.1059435787465;5785.103308987109;5788.594798364116;5810.651360918343;5823.184754134425;5728.255326807509;5772.191893134954;5778.6243894146955;5794.594378393504;5803.477687008169;4932.728699921503;5219.608529360295;5231.450697676727;5321.308229930104;5347.224652425415;5173.198154286091;5177.689338639693;5343.492368225032;5346.385165705955;5351.117065684158;5208.140656791644;5284.313039304904;5289.761960711758;5294.894102117955;5299.33758280215;3922.6469617734397;5286.471352864722;5309.495597918191;5311.256424100629;5318.202269659543;5170.1727723564045;5249.553787927993;5258.027264955996;5261.842144735664;5272.420033796279;5765.048766953448;5766.509846663039;5767.423257674241;5777.62445441045;5779.075347944308;6099.346392253976;6151.384861513858;6193.194884665009;6222.408871157233;6244.469220116295;6216.316205217422;6251.3123556408755;6273.12176295319;6276.215473065867;6296.118543403882;5798.333191682968;5842.963495199901;5844.035734103868;5873;5906.23218981534;6188.721507532172;6208.844778880564;6242.438180563771;6276.215473065867;6295.401936815995;5153.793848246103;6218.440340369389;6231.563790534709;6256.843578910563;6260.280067792171;6303.842403939938;6325.177726895474;6331.493480521547;6334.809955701337;6335.556511044183;6113.510919126459;6137.083162720041;6264.310925798159;6278.811635650938;6314.8421289467215;5153.3558305211845;6014.278286605635;6037.45662890342;6179.62922224668;6188.783392581328;4324.610785029363;5010.749462526932;5020.196768517019;5061.620378471629;5066.9746651266505;4424.6239069678795;4473.709208901411;4480.484744254387;4495.078508905666;4498.8425405110665;5921.526277897758;5922.289325280994;5930.318013428425;5939.643621382731;5947.672877991752;6150.231221097363;6207.16203312547;6211.875762484816;6218.689065546795;6293.874122517524;5338.199270109437;5558.638688485235;5890.175375447441;5893.793717219963;5945.256842894638;5480.177973304037;5502.0371434998715;5511.200875872976;5531.723413829292;5533.22534845122;6205.689715514297;6253.906191407224;6276.874462510816;6349.428551430394;6387.648679322682;6246.406591373812;6259.906101408574;6289.905651415141;6305.306416294112;6324.051392291193;6350.714217860115;6359.49124070064;6361.491080713439;6369.45859601939;6370.267419246846;6029.336772954884;6131.835460087213;6279.309275979547;6288.842778930563;6295.464885484785;6075.149479073022;6236.656983865931;6246.625202487865;6299.464545513682;6360.77737279193;5985.371535988833;6009.338972713085;6172.351903050115;6177.96911015442;6190.535709821691;6003.669798161143;6023.27720673522;6142.570020098729;6179.3820617937845;6180.351063138485;5722.141678748221;5743.195952566561;5745.971270143623;5816.47651711348;5861.7655293787775;5887.0580707086665;5909.143174239625;5917.911231331447;5939.3466718661775;5949.077892926603;4854.2233242681;5802.941970580409;5810.983077961424;5811.215485909517;5814.5348372130975 10:02:05 INFO - PROCESS | 1642 | |1;ext.html;450.6687584625302;469.21640859764193;474.444899467623;492.85460789067224;507.1935622360446;27697.58453623195;31510.68489315106;31513.68486315136;31552.52671209931;39681;41302.38046429306;43866.56133438665;43950;44015;44158.779206104;8340.999080110396;9326.114019168203;9534.570944307523;9540.904590954106;9548.665796697116;7074.964625176867;8574.228319451247;9327.533623318841;9478.43129412234;9613.894402143738;11254.774904501905;11507.42462876857;11523.65429037126;11707.121965852553;11751.118666100077;11411.657650270505;11501.827472587918;11520.827187592193;11521.193516453852;11521.654350369503;8465.788355291106;8694.087120852282;9741.318107732392;11428.542858285658;11445.828312575319;39676.611318604;40504.18991620151;40573.754099671954;41666.958326041786;42668.57331426677;3958.2281455116263;3964.147708242742;3965.7620542767527;3972.6623237024887;3987.501562304712;29403.705962940312;29438.26404339887;29452.263693407836;31282.530762038587;31312;3077.569140320357;3176.491761318178;3287.161773747703;3289.473684210515;3366.6128395234373;365097;366312;366399;366897.9999999973;369931;49843;60168.495787604785;60276.698616507514;60399.39600604025;60414;64825.675871621286;65015.34984650188;65140.67429662821;65141.34858651353;65143.67428162924;16388;16671.83328166727;16678.749818752727;16684.49946501607;16695.165241737865;12936.223826570436;13002.219866808022;13011.154274972096;13023;13029.674258143623;12649.873501265054;14292.85707142936;14582.197979111039;14639.121652700873;16280.918595406947;5628.071368224197;6270.498360131179;6445.9355406446275;6510.9023364649565;6610.669466526654;731.5464412064554;836.983260334802;869.7651634058768;874.4097734029505;885.964561417549;26894;29953.700462995526;30052.248693782392;30752.53871191934;30762;1059.692689120162;1063.7872425514772;1096.550414330121;1098.0721290509507;1216.689744115245;14883.553493395215;15265.694686106215;15689;17630.118494075246;17636.73544896802;574348;598633.0136698665;646226;652997;666773;66212.66893665597;66754.66622666952;66935;66937;66955.66522167358;1452.4262916148061;1472.3153733513968;1484.2949598940634;1518.476125736597;1520.7186670465999;30629.387412251184;31834.522482162323;31912.36175276528;31946.68053319437;32647.510287346184;54207.91584168216;54905.72547137398;54944.72527637336;54955;55055;603121;607594;609185;610336;610606.9469652623;42870.78564607157;43036.83292363789;43099.56900431081;43146.13707725765;43543;46994.29508557306;47345.053098938515;47959.28061079017;47976.7601161992;48197;38329.80835095807;38449.03877403087;38771;39822.40266395948;39951.400728988505;38631.227375452894;38879.230700455795;39029;39036.60963390443;39830.20339593134;37866.432003520524;38561.2287754249;38679.80660096682;38762;38778;30399;33465;33830.815921442634;34069.829650851585;34091;24959.625605616293;24971.75028249694;25311.746882531676;25547.489050219265;25816.354591135372 10:02:05 INFO - PROCESS | 1642 | |2;jquery.html;375.6975634614138;392.3663283796668;394.0228233979732;402.1996227507261;425.7871064467766;13712.236438647722;15701.057936523817;18354.908225458872;20891.582168356625;20950.580988380225;20709.482262943435;20975.580488390224;21562.784372156275;21705.782942170572;21896.014679339427;5588.189712491707;5592.972035139818;5764.308283006045;5796.304443466769;5829.533637309027;4163.396307535406;5726.31284245891;5848;5853.180554722342;5856.853578660525;4342.32693932441;6254.9374506255035;6625.204975402959;6640.0703901453835;6643.6346000969925;6393.648349340784;6498.902516462257;6623.53635245533;6629.73481060757;6664.500162487784;5867.589268751189;5870.941290587082;5876.324222714357;5879.441453061952;5884.823455296348;26205;27209.591856122173;27237.727622723716;27409.31476713078;27651.446971060668;2644.563646998243;2700.9459810803673;2718.714534973839;2729.263098963269;2791.4975304445193;13109.164716939636;15179.848201518063;15869.04785712861;16044.43844465438;16581.336746530123;1827.6253368059515;1834.7431359609666;1848.621032688309;1865.2352535460395;1866.2721538599958;124954.12568811476;125334;130153;133147.6685233145;133586.66413335936;11234.606788762354;11684.298942063504;11781.76436471283;11904.702382440335;11905.226160299553;15091.698166036618;15140.318685659171;15141.924290378698;15151.166685832384;15161.772573411408;8571.614277357534;8829.508861661114;8845.51349675774;8884;8989.55052247385;8918.286537077018;8923.464592124494;8944.418612790148;9051.683191088412;9092.636294548276;6294.622322660563;6399.13611662429;7370.926290737024;7499.175090740015;7502.4748267621835;1939.9127039283267;1972.940811775649;1988.7514060742408;1990;1991.2532800199924;883.5847151838625;897.264243320471;905.3255324782947;942.7124726958343;947.7298969793576;22365.440863978205;23049.42376440569;23313.650295245585;23465.413364665677;23503.41241468943;918.875951746519;941.4915945389413;948.7343543807744;954.909283618069;962.4802606592501;11531.538738450536;11763.764724705628;12097.818532722016;12100.69748256283;12133.635990920286;760679;762076;771217;772198;792338;120692;143139;144043;151477.48522514635;154208;1032.550840384435;1035.7410647338165;1037.1754455207977;1058.7194393485731;1060.612876300145;15099.471518496799;19128.617427651647;20131.39605811828;20212.393628191177;20215.696764548837;49204;50219.748901256724;50632.481025569294;51257.974840503724;51309.71725706738;74605.50788984298;75904.62047689946;76281.61859190669;76649.23350766645;76734;7838.882416763867;8116.878246826184;8282.917170828456;8292.33661307106;8343.123971982854;9424.81150376975;12086.093542984136;12183.817242741188;12462.43919023628;12465.626031219077;8221.465604735673;8536.62803192723;8702.47785132894;9054.230390416888;9643.132118109123;10715.303505272132;10925.399103049409;11103.333799972028;11202.327860328407;11298.378589177673;11363.090952723927;11470.4264786762;11652;11686;12099.637010889688;8087.595620219083;8140.83718325642;8152.429329946846;8227.588620569068;8563.229309362187;10999.23005389615;11114.88885111171;11237.55049797999;11442.656720298404;11540.076793856304 10:02:05 INFO - PROCESS | 1642 | |3;mootools.html;1406.4022790314114;1426.5720283914823;1433.512605714057;1442.0770706747676;1446.0600609603753;8076.39427042972;8441.071482136975;8450.450720703158;8453.746387608366;8472.57637118144;7353.30143636355;7645.350145237661;7655.732049378273;8038.236367545074;8171.550564718938;2313.5835549601065;2347.448349637842;2347.6595893595504;2348.0020991078723;2349.060375849657;2316.6756654068445;2355.693759811222;2359.1742889988536;2360.8819559022068;2364.196173301077;2044.1925439451481;2122.660374340106;2126.766055733868;2129.968050479244;2301.873396963166;2075.3773867839586;2202.812760915332;2278.9658155127686;2281.4638559938403;2289.198780426854;1958.187352248815;2308.976910230893;2311.15642790382;2317.3627252505526;2318.7913087822008;8104.959475202645;8177.959110204471;8183.6726530938695;8194.959025204895;8199.508029518249;4941.925871111936;5110.693358398508;5123.077845987721;5125.179971204627;5128.230765385185;3214.2928555717704;3286.145602143436;3431.365197438482;3479.4780782882517;3518.419460788992;1149.2415006095937;1192.5320771335664;1206.849143857018;1207.2032458577296;1225.2036176485356;10797.5680972761;10900.618478353219;10911.018008379204;10916.781664366668;10925.180611454094;3966.702497312713;4393;4645.837395691202;4732.905341893143;4737.099951009297;9388.90611093894;9418.34071614994;9526.571304291323;9551.856722149174;9570.712878613653;5229.08491014071;5232.319798426256;5236.397814251333;5236.633435659467;5250.212468129811;3925.823337949799;4270.081932384553;4388.780560971939;4431.689781715249;4689.929651055237;3787.034306251888;3845.3655146901006;3949;3958.148997965394;3961.841526338972;1255.598208573266;1277.718901841612;1279.500994612102;1289.207137610363;1296.7989961555975;878.3851304087165;878.4904755241944;886.7738726624669;890.1098901098901;890.4167770110588;5613.354464236665;5670.631408958405;5748.281464816898;5768.903908257417;5936.643801371845;854.8544949767218;966.246327864267;974.2157563161581;975.7609385700407;1015.7003683913264;3199.936001279961;3297.2086699192023;3595.1551385424405;3658.6707196352454;3687.870924517629;8952.955235223782;9259.398139120936;9488.857667134998;9996.950015249877;10037.69886903394;9830.803383932282;9919;9943.45311007887;9958.701238962843;10002.34984726005;7735.497192682457;7754;7819.413543984224;7930.0880398753725;7943.563104029334;5316.787328506816;5414.485623865727;5427.918849926143;5554.222408862844;5659.518940890071;8838.204561589488;9150.496722680316;9189.356745027784;9253.352265341362;9368.578413971523;9171.037041110587;9205.76985575366;9355.953220233856;9492.003339649238;9495.810083798424;6586.110875031809;6808.659567021728;7072.646367681698;7312.780616581511;7332.193458719643;7487.775366739006;7660.961695191489;7954.00574928134;7967.800804979922;8059.83880322402;7042.507024508235;7130.607816570138;7197.1363436387965;7259.382952449101;7267.854642907218;7065.788026359218;7075.469339799432;7077.221505634479;7079.823004424725;7155.821104472429;5492.203630473638;6254.906176407449;6358.586691865014;6392;6464.515161362822;4764.190087685171;4769.998300356825;4809.9038019240115;4860.635452341018;4892.437369702529;4632.143053535106;4688.507706690748;4700.670953033255;4839.346688197048;4924.9507504924495 10:02:05 INFO - PROCESS | 1642 | |4;prototype.html;351.1922578070438;355.9960910233142;360.9584897736761;373.68236998551237;374.6665467733716;4958.380202474696;5010.624203184767;5147.974260128694;5343.465653434655;5412.783488660454;4826.32431459596;5073.162928116856;5165.38015438147;5211.843644690656;5215.739213039352;3538.3277177336354;3737.7009839212797;3926.9410958835642;4006.371048676614;4098.180363927227;3650.9777262366447;3808.9428658570146;4177.185448837478;4199.664026877857;4201.789910504478;3397.7961322320616;3537.770044947083;3977.2642061218767;4049.068714195737;4050.615191556812;3209.935801283973;4023.7786921719294;4032.74984754727;4046.332355161395;4052.412400201969;3530.947035794465;3545.3795585772646;3547.5565554305713;3547.875824346161;3560.092176495003;4598.8620341389815;4836.613070954315;5189.987952349294;5235.973820130875;5265.99730256258;4039.2527382434346;4072.7149099563044;4532.215599974025;4568.748718820463;4600.5169457207185;5322.099455796561;5564.805231816867;5584.9335745773915;5598.552115830724;5600.1599760035915;3706.1647839402876;3802.258559580883;3820.7134464914966;3831.3103641344546;3845.15406610548;4714.6464015199;5779.2775903012125;5816.563757718188;5867.181173836125;5903.262092238428;3420;3461.9826900865837;3909.667678247324;3919.8040097994985;3920.2551515212017;3676.8161591920298;3943.6647884930103;3948.993006783252;3952.940705889414;3970.940435893406;4148.045949431647;4308.612224899774;4541.795619197144;4596.6092882105395;4601.884952876205;5498.532624726863;5638.210650508932;5643.887122257532;5661.160122960055;5669.489745922887;1090.607381342716;1154.584349634131;1176.7411169542686;1227.2943057741657;1237.6101528018646;739.3641468337225;754.9883156570222;794.5987276425484;873.9512584898148;881.5415983688574;4827.903441931142;5054.21659642756;5061.670991385622;5074.594032477393;5094;4846.316799232538;4925.6700690814;5011.949880501221;5453.045716999509;5637.548996080303;4318.827246910151;5296.25852380667;5330.38700549434;5385.461453854661;5388.838334849961;2436.3189399314415;2626.290901456596;2766.4507875589734;2885.30752619374;2926.9707302927122;5045.495450454925;5389.844062375081;5546.391546451484;5585.385607583163;5735.971320143372;5685.317761868602;5718.885622287531;5721.742521586455;5741.301588253514;5785.82642520725;4961.6526843121355;5300.681959082467;5630.368412374078;5786.594938354359;5809.419058094072;4384.596928982695;4632.467266264288;5262.52649258193;5726.856828579319;5729.197912292199;5480.013597552479;5699.178906441338;5717.3996730342715;5728.79949201776;5736.483716465538;5019.7741101651245;5332.866678333073;5564.247262112422;5947.1079338099635;5992.760289588542;3500.964990350064;3812.3709587917683;4129.472095324749;4223.1975924574235;4237.25847976609;4770.451398089264;5424.213489044146;5832;5833.591648584728;5863.794767183128;5087.3386459759995;5398.840463814348;5581.330240371181;5693.231413759089;5731.856703582277;4708.246680531099;4820.325154478446;5570.498655121059;5616.241807356118;5641.661500309994;4504.707194032378;4616.722996620214;5216.626434972003;5240.973795131;5300.091966891993;5268.4731526848545;5612.800703598909;5612.943870561242;5618.438156184349;5672.432756724294;4155.480564929384;4859.902801944012;5253.763580638957;5371.033214021513;5536.536241372551 10:02:05 INFO - PROCESS | 1642 | |5;yui.html;704.3731079339385;745.7389913530266;751.9735560959289;806.4878801960755;819.5492479136474;14579.70840583189;14719.896007799405;15241;15250.542483725478;15619.765703514457;13979.860201397983;14010.159390436582;14103.224322662249;14291.071080379768;14305.856941430582;843.9704610338639;850.6172222499899;851.259404318244;852.0627309959026;852.3692467573982;673.0509980926894;690.5442408010714;819.7212947597816;843.8945131858518;844.4595458906305;894.061235702513;895.3463971300954;895.7805337692274;897.6633762339122;898.0480690468092;891.589868660417;891.9331050171263;892.1435421994893;892.5626443042895;894.6063731957951;527.1276038156857;535.2987586262009;539.1373801916901;666.4834753066364;670.9765158219438;12039.458224379836;12084.6374608761;12087.395630218542;13991;14505;13845.307734613229;13846.861531384659;13925.860741392658;13970.371333289924;14065.859341406558;10881.67354979344;11100.865581962584;11160.553577856876;11523.366214858179;11649.41752912351;3692.6861216796606;3794.90512737181;3834.5206849143856;3836.865709700147;3838.0404898775305;91479.54260228723;96156.9999999993;96399;98435.50782246042;107834;10746.032857042903;10779.89220107789;10863.782724345469;10924.726881828017;10960.177986651033;21619;21819.454513636967;22107.889460552593;22110.22614208495;22178.556428871332;7676.80807979805;7734.497257678346;7752.5736084514765;7779.287634275267;7809.258120478546;4141;4174.290370636999;4253.149370125987;4260.573942605776;4307.181635489247;3471.5486986691567;3541.9551232386507;3542.8228588570983;3547.52108465359;3571.39286321326;582.7785441532276;603.6589327030214;620.4292051312804;628.8082134948793;637.1684951138808;645.9922520867461;677.4140368581142;696.7317582730685;701.3897908819359;717.1322699533519;7219.711211551479;8698.173673501007;9903.45530995802;9954.751131221778;9968.601255949681;559.443353862909;585.68665763817;606.6087373644064;607.1772747926584;607.7174114036906;3881.5342158941107;4638.768061596907;4652.511486293958;4897.0450762101045;4934.925976110361;96612.68630225405;97725;98057.529137063;98101.01898981062;100328.49835750775;69901.65049174824;81216;83943;85726;87506.56246718725;60475;72553.27446725465;76038.47923041618;78583.03542411486;79126.92480191313;9441.480718560546;9609.711708648752;9624.422534647943;9627.759306017406;9631.277654176105;44979;45914.770426147654;48723.75638121787;50780;51017.74491127521;58878;60319.7936041268;61950.69024654848;63070.36929630645;67753.32246677668;12793;12990.220586764824;13184.60446186616;13299.601011969657;13584.36203770406;14048.367823447765;14133.6466588332;14383.856161438252;14687.412503500167;14776.556703298918;13258.66853328636;13266.602001939957;13358.465661373437;13539.323033848072;14001.929990349983;13405.66485837862;13607.931960340135;13652.726945461234;13891.52619884391;14504.202268875313;11088.722781930517;12439.937800310941;13241.3379331035;13249.13880597758;13987.650308742363;10547;10721.760182142736;11221.719457013314;11451.312921224753;11635.069194464591;9844.753881153028;11270.887291126985;11434.709009374516;11544.249623774427;11597.420128993685 10:02:05 INFO - PROCESS | 1642 | __end_tp_report 10:02:05 INFO - PROCESS | 1642 | __start_cc_report 10:02:05 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,1225 10:02:05 INFO - PROCESS | 1642 | __end_cc_report 10:02:05 INFO - PROCESS | 1642 | __startTimestamp1488564125343__endTimestamp 10:02:05 INFO - PROCESS | 1642 | 10:02:05 INFO - PROCESS | 1642 | ------- Summary: start ------- 10:02:05 INFO - PROCESS | 1642 | Number of tests: 6 10:02:05 INFO - PROCESS | 1642 | 10:02:05 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5741.21 Median:5909.14 stddev:650.99 (11.0%) stddev-sans-first:625.42 10:02:05 INFO - PROCESS | 1642 | Values: 3352.1 3360.3 3371.6 3384.3 3419.0 5768.1 5785.1 5788.6 5810.7 5823.2 5728.3 5772.2 5778.6 5794.6 5803.5 4932.7 5219.6 5231.5 5321.3 5347.2 5173.2 5177.7 5343.5 5346.4 5351.1 5208.1 5284.3 5289.8 5294.9 5299.3 3922.6 5286.5 5309.5 5311.3 5318.2 5170.2 5249.6 5258.0 5261.8 5272.4 5765.0 5766.5 5767.4 5777.6 5779.1 6099.3 6151.4 6193.2 6222.4 6244.5 6216.3 6251.3 6273.1 6276.2 6296.1 5798.3 5843.0 5844.0 5873.0 5906.2 6188.7 6208.8 6242.4 6276.2 6295.4 5153.8 6218.4 6231.6 6256.8 6260.3 6303.8 6325.2 6331.5 6334.8 6335.6 6113.5 6137.1 6264.3 6278.8 6314.8 5153.4 6014.3 6037.5 6179.6 6188.8 4324.6 5010.7 5020.2 5061.6 5067.0 4424.6 4473.7 4480.5 4495.1 4498.8 5921.5 5922.3 5930.3 5939.6 5947.7 6150.2 6207.2 6211.9 6218.7 6293.9 5338.2 5558.6 5890.2 5893.8 5945.3 5480.2 5502.0 5511.2 5531.7 5533.2 6205.7 6253.9 6276.9 6349.4 6387.6 6246.4 6259.9 6289.9 6305.3 6324.1 6350.7 6359.5 6361.5 6369.5 6370.3 6029.3 6131.8 6279.3 6288.8 6295.5 6075.1 6236.7 6246.6 6299.5 6360.8 5985.4 6009.3 6172.4 6178.0 6190.5 6003.7 6023.3 6142.6 6179.4 6180.4 5722.1 5743.2 5746.0 5816.5 5861.8 5887.1 5909.1 5917.9 5939.3 5949.1 4854.2 5802.9 5811.0 5811.2 5814.5 10:02:05 INFO - PROCESS | 1642 | 10:02:05 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:68085.69 Median:38954.12 stddev:146417.51 (375.9%) stddev-sans-first:146740.19 10:02:05 INFO - PROCESS | 1642 | Values: 450.7 469.2 474.4 492.9 507.2 27697.6 31510.7 31513.7 31552.5 39681.0 41302.4 43866.6 43950.0 44015.0 44158.8 8341.0 9326.1 9534.6 9540.9 9548.7 7075.0 8574.2 9327.5 9478.4 9613.9 11254.8 11507.4 11523.7 11707.1 11751.1 11411.7 11501.8 11520.8 11521.2 11521.7 8465.8 8694.1 9741.3 11428.5 11445.8 39676.6 40504.2 40573.8 41667.0 42668.6 3958.2 3964.1 3965.8 3972.7 3987.5 29403.7 29438.3 29452.3 31282.5 31312.0 3077.6 3176.5 3287.2 3289.5 3366.6 365097.0 366312.0 366399.0 366898.0 369931.0 49843.0 60168.5 60276.7 60399.4 60414.0 64825.7 65015.3 65140.7 65141.3 65143.7 16388.0 16671.8 16678.7 16684.5 16695.2 12936.2 13002.2 13011.2 13023.0 13029.7 12649.9 14292.9 14582.2 14639.1 16280.9 5628.1 6270.5 6445.9 6510.9 6610.7 731.5 837.0 869.8 874.4 886.0 26894.0 29953.7 30052.2 30752.5 30762.0 1059.7 1063.8 1096.6 1098.1 1216.7 14883.6 15265.7 15689.0 17630.1 17636.7 574348.0 598633.0 646226.0 652997.0 666773.0 66212.7 66754.7 66935.0 66937.0 66955.7 1452.4 1472.3 1484.3 1518.5 1520.7 30629.4 31834.5 31912.4 31946.7 32647.5 54207.9 54905.7 54944.7 54955.0 55055.0 603121.0 607594.0 609185.0 610336.0 610606.9 42870.8 43036.8 43099.6 43146.1 43543.0 46994.3 47345.1 47959.3 47976.8 48197.0 38329.8 38449.0 38771.0 39822.4 39951.4 38631.2 38879.2 39029.0 39036.6 39830.2 37866.4 38561.2 38679.8 38762.0 38778.0 30399.0 33465.0 33830.8 34069.8 34091.0 24959.6 24971.8 25311.7 25547.5 25816.4 10:02:05 INFO - PROCESS | 1642 | 10:02:05 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:40789.14 Median:15069.29 stddev:127904.66 (848.8%) stddev-sans-first:128227.47 10:02:05 INFO - PROCESS | 1642 | Values: 375.7 392.4 394.0 402.2 425.8 13712.2 15701.1 18354.9 20891.6 20950.6 20709.5 20975.6 21562.8 21705.8 21896.0 5588.2 5593.0 5764.3 5796.3 5829.5 4163.4 5726.3 5848.0 5853.2 5856.9 4342.3 6254.9 6625.2 6640.1 6643.6 6393.6 6498.9 6623.5 6629.7 6664.5 5867.6 5870.9 5876.3 5879.4 5884.8 26205.0 27209.6 27237.7 27409.3 27651.4 2644.6 2700.9 2718.7 2729.3 2791.5 13109.2 15179.8 15869.0 16044.4 16581.3 1827.6 1834.7 1848.6 1865.2 1866.3 124954.1 125334.0 130153.0 133147.7 133586.7 11234.6 11684.3 11781.8 11904.7 11905.2 15091.7 15140.3 15141.9 15151.2 15161.8 8571.6 8829.5 8845.5 8884.0 8989.6 8918.3 8923.5 8944.4 9051.7 9092.6 6294.6 6399.1 7370.9 7499.2 7502.5 1939.9 1972.9 1988.8 1990.0 1991.3 883.6 897.3 905.3 942.7 947.7 22365.4 23049.4 23313.7 23465.4 23503.4 918.9 941.5 948.7 954.9 962.5 11531.5 11763.8 12097.8 12100.7 12133.6 760679.0 762076.0 771217.0 772198.0 792338.0 120692.0 143139.0 144043.0 151477.5 154208.0 1032.6 1035.7 1037.2 1058.7 1060.6 15099.5 19128.6 20131.4 20212.4 20215.7 49204.0 50219.7 50632.5 51258.0 51309.7 74605.5 75904.6 76281.6 76649.2 76734.0 7838.9 8116.9 8282.9 8292.3 8343.1 9424.8 12086.1 12183.8 12462.4 12465.6 8221.5 8536.6 8702.5 9054.2 9643.1 10715.3 10925.4 11103.3 11202.3 11298.4 11363.1 11470.4 11652.0 11686.0 12099.6 8087.6 8140.8 8152.4 8227.6 8563.2 10999.2 11114.9 11237.6 11442.7 11540.1 10:02:05 INFO - PROCESS | 1642 | 10:02:05 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:5378.40 Median:5236.52 stddev:2948.41 (56.3%) stddev-sans-first:2941.57 10:02:05 INFO - PROCESS | 1642 | Values: 1406.4 1426.6 1433.5 1442.1 1446.1 8076.4 8441.1 8450.5 8453.7 8472.6 7353.3 7645.4 7655.7 8038.2 8171.6 2313.6 2347.4 2347.7 2348.0 2349.1 2316.7 2355.7 2359.2 2360.9 2364.2 2044.2 2122.7 2126.8 2130.0 2301.9 2075.4 2202.8 2279.0 2281.5 2289.2 1958.2 2309.0 2311.2 2317.4 2318.8 8105.0 8178.0 8183.7 8195.0 8199.5 4941.9 5110.7 5123.1 5125.2 5128.2 3214.3 3286.1 3431.4 3479.5 3518.4 1149.2 1192.5 1206.8 1207.2 1225.2 10797.6 10900.6 10911.0 10916.8 10925.2 3966.7 4393.0 4645.8 4732.9 4737.1 9388.9 9418.3 9526.6 9551.9 9570.7 5229.1 5232.3 5236.4 5236.6 5250.2 3925.8 4270.1 4388.8 4431.7 4689.9 3787.0 3845.4 3949.0 3958.1 3961.8 1255.6 1277.7 1279.5 1289.2 1296.8 878.4 878.5 886.8 890.1 890.4 5613.4 5670.6 5748.3 5768.9 5936.6 854.9 966.2 974.2 975.8 1015.7 3199.9 3297.2 3595.2 3658.7 3687.9 8953.0 9259.4 9488.9 9997.0 10037.7 9830.8 9919.0 9943.5 9958.7 10002.3 7735.5 7754.0 7819.4 7930.1 7943.6 5316.8 5414.5 5427.9 5554.2 5659.5 8838.2 9150.5 9189.4 9253.4 9368.6 9171.0 9205.8 9356.0 9492.0 9495.8 6586.1 6808.7 7072.6 7312.8 7332.2 7487.8 7661.0 7954.0 7967.8 8059.8 7042.5 7130.6 7197.1 7259.4 7267.9 7065.8 7075.5 7077.2 7079.8 7155.8 5492.2 6254.9 6358.6 6392.0 6464.5 4764.2 4770.0 4809.9 4860.6 4892.4 4632.1 4688.5 4700.7 4839.3 4925.0 10:02:05 INFO - PROCESS | 1642 | 10:02:05 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4465.36 Median:5015.86 stddev:1379.58 (27.5%) stddev-sans-first:1348.44 10:02:05 INFO - PROCESS | 1642 | Values: 351.2 356.0 361.0 373.7 374.7 4958.4 5010.6 5148.0 5343.5 5412.8 4826.3 5073.2 5165.4 5211.8 5215.7 3538.3 3737.7 3926.9 4006.4 4098.2 3651.0 3808.9 4177.2 4199.7 4201.8 3397.8 3537.8 3977.3 4049.1 4050.6 3209.9 4023.8 4032.7 4046.3 4052.4 3530.9 3545.4 3547.6 3547.9 3560.1 4598.9 4836.6 5190.0 5236.0 5266.0 4039.3 4072.7 4532.2 4568.7 4600.5 5322.1 5564.8 5584.9 5598.6 5600.2 3706.2 3802.3 3820.7 3831.3 3845.2 4714.6 5779.3 5816.6 5867.2 5903.3 3420.0 3462.0 3909.7 3919.8 3920.3 3676.8 3943.7 3949.0 3952.9 3970.9 4148.0 4308.6 4541.8 4596.6 4601.9 5498.5 5638.2 5643.9 5661.2 5669.5 1090.6 1154.6 1176.7 1227.3 1237.6 739.4 755.0 794.6 874.0 881.5 4827.9 5054.2 5061.7 5074.6 5094.0 4846.3 4925.7 5011.9 5453.0 5637.5 4318.8 5296.3 5330.4 5385.5 5388.8 2436.3 2626.3 2766.5 2885.3 2927.0 5045.5 5389.8 5546.4 5585.4 5736.0 5685.3 5718.9 5721.7 5741.3 5785.8 4961.7 5300.7 5630.4 5786.6 5809.4 4384.6 4632.5 5262.5 5726.9 5729.2 5480.0 5699.2 5717.4 5728.8 5736.5 5019.8 5332.9 5564.2 5947.1 5992.8 3501.0 3812.4 4129.5 4223.2 4237.3 4770.5 5424.2 5832.0 5833.6 5863.8 5087.3 5398.8 5581.3 5693.2 5731.9 4708.2 4820.3 5570.5 5616.2 5641.7 4504.7 4616.7 5216.6 5241.0 5300.1 5268.5 5612.8 5612.9 5618.4 5672.4 4155.5 4859.9 5253.8 5371.0 5536.5 10:02:05 INFO - PROCESS | 1642 | 10:02:05 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:19481.53 Median:26688.13 stddev:27455.90 (102.9%) stddev-sans-first:27496.72 10:02:05 INFO - PROCESS | 1642 | Values: 704.4 745.7 752.0 806.5 819.5 14579.7 14719.9 15241.0 15250.5 15619.8 13979.9 14010.2 14103.2 14291.1 14305.9 844.0 850.6 851.3 852.1 852.4 673.1 690.5 819.7 843.9 844.5 894.1 895.3 895.8 897.7 898.0 891.6 891.9 892.1 892.6 894.6 527.1 535.3 539.1 666.5 671.0 12039.5 12084.6 12087.4 13991.0 14505.0 13845.3 13846.9 13925.9 13970.4 14065.9 10881.7 11100.9 11160.6 11523.4 11649.4 3692.7 3794.9 3834.5 3836.9 3838.0 91479.5 96157.0 96399.0 98435.5 107834.0 10746.0 10779.9 10863.8 10924.7 10960.2 21619.0 21819.5 22107.9 22110.2 22178.6 7676.8 7734.5 7752.6 7779.3 7809.3 4141.0 4174.3 4253.1 4260.6 4307.2 3471.5 3542.0 3542.8 3547.5 3571.4 582.8 603.7 620.4 628.8 637.2 646.0 677.4 696.7 701.4 717.1 7219.7 8698.2 9903.5 9954.8 9968.6 559.4 585.7 606.6 607.2 607.7 3881.5 4638.8 4652.5 4897.0 4934.9 96612.7 97725.0 98057.5 98101.0 100328.5 69901.7 81216.0 83943.0 85726.0 87506.6 60475.0 72553.3 76038.5 78583.0 79126.9 9441.5 9609.7 9624.4 9627.8 9631.3 44979.0 45914.8 48723.8 50780.0 51017.7 58878.0 60319.8 61950.7 63070.4 67753.3 12793.0 12990.2 13184.6 13299.6 13584.4 14048.4 14133.6 14383.9 14687.4 14776.6 13258.7 13266.6 13358.5 13539.3 14001.9 13405.7 13607.9 13652.7 13891.5 14504.2 11088.7 12439.9 13241.3 13249.1 13987.7 10547.0 10721.8 11221.7 11451.3 11635.1 9844.8 11270.9 11434.7 11544.2 11597.4 10:02:05 INFO - PROCESS | 1642 | -------- Summary: end -------- 10:02:05 INFO - PROCESS | 1642 | 10:02:06 INFO - TEST-INFO | 1642: exit 0 10:02:06 INFO - TEST-OK | dromaeo_css | took 1118563ms 10:02:06 INFO - TEST-START | kraken 10:02:06 INFO - operating with platform_type : mac_ 10:02:06 INFO - Initialising browser for kraken test... 10:02:06 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/tmp_prayX/profile http://localhost:49249/getInfo.html) 10:02:08 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 10:02:08 INFO - PROCESS | 1651 | colorDepth:24 10:02:08 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 10:02:08 INFO - PROCESS | 1651 | __metrics 10:02:08 INFO - PROCESS | 1651 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:02:08 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:02:09 INFO - TEST-INFO | 1651: exit 0 10:02:09 INFO - Browser initialized. 10:02:09 INFO - Running cycle 1/1 for kraken test... 10:02:09 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/tmp_prayX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:02:21 INFO - PROCESS | 1652 | RSS: Main: 213012480 10:02:21 INFO - PROCESS | 1652 | 10:02:24 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection) 10:02:25 INFO - PROCESS | 1652 | RSS: Main: 265478144 10:02:25 INFO - PROCESS | 1652 | 10:02:27 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-dft) 10:02:28 INFO - PROCESS | 1652 | RSS: Main: 274481152 10:02:28 INFO - PROCESS | 1652 | 10:02:31 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-fft) 10:02:31 INFO - PROCESS | 1652 | RSS: Main: 373407744 10:02:31 INFO - PROCESS | 1652 | 10:02:33 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator) 10:02:34 INFO - PROCESS | 1652 | RSS: Main: 276258816 10:02:34 INFO - PROCESS | 1652 | 10:02:36 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:02:37 INFO - PROCESS | 1652 | RSS: Main: 278450176 10:02:37 INFO - PROCESS | 1652 | 10:02:40 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom) 10:02:40 INFO - PROCESS | 1652 | RSS: Main: 316850176 10:02:40 INFO - PROCESS | 1652 | 10:02:43 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate) 10:02:44 INFO - PROCESS | 1652 | RSS: Main: 318967808 10:02:44 INFO - PROCESS | 1652 | 10:02:46 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial) 10:02:47 INFO - PROCESS | 1652 | RSS: Main: 314679296 10:02:47 INFO - PROCESS | 1652 | 10:02:49 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:02:49 INFO - PROCESS | 1652 | RSS: Main: 294768640 10:02:49 INFO - PROCESS | 1652 | 10:02:51 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:02:52 INFO - PROCESS | 1652 | RSS: Main: 297345024 10:02:52 INFO - PROCESS | 1652 | 10:02:54 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:02:55 INFO - PROCESS | 1652 | RSS: Main: 301572096 10:02:55 INFO - PROCESS | 1652 | 10:02:57 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:02:58 INFO - PROCESS | 1652 | RSS: Main: 316583936 10:02:58 INFO - PROCESS | 1652 | 10:03:01 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:03:02 INFO - PROCESS | 1652 | RSS: Main: 309788672 10:03:02 INFO - PROCESS | 1652 | 10:03:03 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49249/tests/kraken/driver.html?testName=ai-astar) 10:03:04 INFO - PROCESS | 1652 | RSS: Main: 354181120 10:03:04 INFO - PROCESS | 1652 | 10:03:04 INFO - PROCESS | 1652 | __start_tp_report 10:03:04 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 10:03:04 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 10:03:04 INFO - PROCESS | 1652 | |i|pagename|runs| 10:03:04 INFO - PROCESS | 1652 | |0;ai-astar;115;114;114;114;113;113;113;113;113;113 10:03:04 INFO - PROCESS | 1652 | |1;audio-beat-detection;142;108;109;145;110;108;107;109;130;107 10:03:04 INFO - PROCESS | 1652 | |2;audio-dft;186;186;184;187;183;184;185;186;183;183 10:03:04 INFO - PROCESS | 1652 | |3;audio-fft;80;58;57;88;62;66;82;79;95;61 10:03:04 INFO - PROCESS | 1652 | |4;audio-oscillator;88;69;86;68;69;70;82;68;69;82 10:03:04 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;86;87;87;85;86;115;74;113;132;91 10:03:04 INFO - PROCESS | 1652 | |6;imaging-darkroom;94;94;95;97;94;94;94;98;94;93 10:03:04 INFO - PROCESS | 1652 | |7;imaging-desaturate;86;88;86;88;87;88;87;85;88;85 10:03:04 INFO - PROCESS | 1652 | |8;json-parse-financial;53;54;53;54;55;57;57;55;56;56 10:03:04 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;71;66;79;76;72;69;66;58;66;70 10:03:04 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;80;88;71;97;91;92;89;86;84;90 10:03:04 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;134;135;136;135;134;135;140;139;177;148 10:03:04 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;168;165;169;169;167;166;167;162;165;165 10:03:04 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;66;66;66;66;66;65;66;64;65;64 10:03:04 INFO - PROCESS | 1652 | __end_tp_report 10:03:04 INFO - PROCESS | 1652 | __start_cc_report 10:03:04 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,2051 10:03:04 INFO - PROCESS | 1652 | __end_cc_report 10:03:04 INFO - PROCESS | 1652 | __startTimestamp1488564184073__endTimestamp 10:03:04 INFO - PROCESS | 1652 | 10:03:04 INFO - PROCESS | 1652 | ------- Summary: start ------- 10:03:04 INFO - PROCESS | 1652 | Number of tests: 14 10:03:04 INFO - PROCESS | 1652 | 10:03:04 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:113.50 Median:113.50 stddev:0.71 (0.6%) stddev-sans-first:0.50 10:03:04 INFO - PROCESS | 1652 | Values: 115.0 114.0 114.0 114.0 113.0 113.0 113.0 113.0 113.0 113.0 10:03:04 INFO - PROCESS | 1652 | 10:03:04 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:117.50 Median:109.50 stddev:15.33 (14.0%) stddev-sans-first:13.45 10:03:04 INFO - PROCESS | 1652 | Values: 142.0 108.0 109.0 145.0 110.0 108.0 107.0 109.0 130.0 107.0 10:03:04 INFO - PROCESS | 1652 | 10:03:04 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:184.70 Median:185.50 stddev:1.49 (0.8%) stddev-sans-first:1.51 10:03:04 INFO - PROCESS | 1652 | Values: 186.0 186.0 184.0 187.0 183.0 184.0 185.0 186.0 183.0 183.0 10:03:04 INFO - PROCESS | 1652 | 10:03:04 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:72.80 Median:79.50 stddev:13.62 (17.1%) stddev-sans-first:14.20 10:03:04 INFO - PROCESS | 1652 | Values: 80.0 58.0 57.0 88.0 62.0 66.0 82.0 79.0 95.0 61.0 10:03:04 INFO - PROCESS | 1652 | 10:03:04 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:75.10 Median:76.00 stddev:8.29 (10.9%) stddev-sans-first:7.37 10:03:04 INFO - PROCESS | 1652 | Values: 88.0 69.0 86.0 68.0 69.0 70.0 82.0 68.0 69.0 82.0 10:03:04 INFO - PROCESS | 1652 | 10:03:04 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:95.60 Median:86.00 stddev:18.06 (21.0%) stddev-sans-first:18.82 10:03:04 INFO - PROCESS | 1652 | Values: 86.0 87.0 87.0 85.0 86.0 115.0 74.0 113.0 132.0 91.0 10:03:04 INFO - PROCESS | 1652 | 10:03:04 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:94.70 Median:94.00 stddev:1.57 (1.7%) stddev-sans-first:1.64 10:03:04 INFO - PROCESS | 1652 | Values: 94.0 94.0 95.0 97.0 94.0 94.0 94.0 98.0 94.0 93.0 10:03:04 INFO - PROCESS | 1652 | 10:03:04 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:86.80 Median:87.50 stddev:1.23 (1.4%) stddev-sans-first:1.27 10:03:04 INFO - PROCESS | 1652 | Values: 86.0 88.0 86.0 88.0 87.0 88.0 87.0 85.0 88.0 85.0 10:03:04 INFO - PROCESS | 1652 | 10:03:04 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.50 stddev:1.49 (2.7%) stddev-sans-first:1.39 10:03:04 INFO - PROCESS | 1652 | Values: 53.0 54.0 53.0 54.0 55.0 57.0 57.0 55.0 56.0 56.0 10:03:04 INFO - PROCESS | 1652 | 10:03:04 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:70.50 stddev:5.87 (8.3%) stddev-sans-first:6.19 10:03:04 INFO - PROCESS | 1652 | Values: 71.0 66.0 79.0 76.0 72.0 69.0 66.0 58.0 66.0 70.0 10:03:04 INFO - PROCESS | 1652 | 10:03:04 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:89.50 stddev:7.22 (8.1%) stddev-sans-first:7.23 10:03:04 INFO - PROCESS | 1652 | Values: 80.0 88.0 71.0 97.0 91.0 92.0 89.0 86.0 84.0 90.0 10:03:04 INFO - PROCESS | 1652 | 10:03:04 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:141.30 Median:137.50 stddev:13.25 (9.6%) stddev-sans-first:13.79 10:03:04 INFO - PROCESS | 1652 | Values: 134.0 135.0 136.0 135.0 134.0 135.0 140.0 139.0 177.0 148.0 10:03:04 INFO - PROCESS | 1652 | 10:03:04 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.30 Median:167.00 stddev:2.16 (1.3%) stddev-sans-first:2.20 10:03:04 INFO - PROCESS | 1652 | Values: 168.0 165.0 169.0 169.0 167.0 166.0 167.0 162.0 165.0 165.0 10:03:04 INFO - PROCESS | 1652 | 10:03:04 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:66.00 stddev:0.84 (1.3%) stddev-sans-first:0.87 10:03:04 INFO - PROCESS | 1652 | Values: 66.0 66.0 66.0 66.0 66.0 65.0 66.0 64.0 65.0 64.0 10:03:04 INFO - PROCESS | 1652 | -------- Summary: end -------- 10:03:04 INFO - PROCESS | 1652 | 10:03:05 INFO - TEST-INFO | 1652: exit 0 10:03:05 INFO - TEST-OK | kraken | took 59038ms 10:03:05 INFO - SUITE-END | took 1177s 10:03:05 INFO - Completed test suite (00:19:37) 10:03:05 INFO - javascript benchmark 10:03:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3352.0781785009126, 3360.3111362170757, 3371.612264589573, 3384.27238143799, 3418.982905085476, 5768.1059435787465, 5785.103308987109, 5788.594798364116, 5810.651360918343, 5823.184754134425, 5728.255326807509, 5772.191893134954, 5778.6243894146955, 5794.594378393504, 5803.477687008169, 4932.728699921503, 5219.608529360295, 5231.450697676727, 5321.308229930104, 5347.224652425415, 5173.198154286091, 5177.689338639693, 5343.492368225032, 5346.385165705955, 5351.117065684158, 5208.140656791644, 5284.313039304904, 5289.761960711758, 5294.894102117955, 5299.33758280215, 3922.6469617734397, 5286.471352864722, 5309.495597918191, 5311.256424100629, 5318.202269659543, 5170.1727723564045, 5249.553787927993, 5258.027264955996, 5261.842144735664, 5272.420033796279, 5765.048766953448, 5766.509846663039, 5767.423257674241, 5777.62445441045, 5779.075347944308, 6099.346392253976, 6151.384861513858, 6193.194884665009, 6222.408871157233, 6244.469220116295, 6216.316205217422, 6251.3123556408755, 6273.12176295319, 6276.215473065867, 6296.118543403882, 5798.333191682968, 5842.963495199901, 5844.035734103868, 5873.0, 5906.23218981534, 6188.721507532172, 6208.844778880564, 6242.438180563771, 6276.215473065867, 6295.401936815995, 5153.793848246103, 6218.440340369389, 6231.563790534709, 6256.843578910563, 6260.280067792171, 6303.842403939938, 6325.177726895474, 6331.493480521547, 6334.809955701337, 6335.556511044183, 6113.510919126459, 6137.083162720041, 6264.310925798159, 6278.811635650938, 6314.8421289467215, 5153.3558305211845, 6014.278286605635, 6037.45662890342, 6179.62922224668, 6188.783392581328, 4324.610785029363, 5010.749462526932, 5020.196768517019, 5061.620378471629, 5066.9746651266505, 4424.6239069678795, 4473.709208901411, 4480.484744254387, 4495.078508905666, 4498.8425405110665, 5921.526277897758, 5922.289325280994, 5930.318013428425, 5939.643621382731, 5947.672877991752, 6150.231221097363, 6207.16203312547, 6211.875762484816, 6218.689065546795, 6293.874122517524, 5338.199270109437, 5558.638688485235, 5890.175375447441, 5893.793717219963, 5945.256842894638, 5480.177973304037, 5502.0371434998715, 5511.200875872976, 5531.723413829292, 5533.22534845122, 6205.689715514297, 6253.906191407224, 6276.874462510816, 6349.428551430394, 6387.648679322682, 6246.406591373812, 6259.906101408574, 6289.905651415141, 6305.306416294112, 6324.051392291193, 6350.714217860115, 6359.49124070064, 6361.491080713439, 6369.45859601939, 6370.267419246846, 6029.336772954884, 6131.835460087213, 6279.309275979547, 6288.842778930563, 6295.464885484785, 6075.149479073022, 6236.656983865931, 6246.625202487865, 6299.464545513682, 6360.77737279193, 5985.371535988833, 6009.338972713085, 6172.351903050115, 6177.96911015442, 6190.535709821691, 6003.669798161143, 6023.27720673522, 6142.570020098729, 6179.3820617937845, 6180.351063138485, 5722.141678748221, 5743.195952566561, 5745.971270143623, 5816.47651711348, 5861.7655293787775, 5887.0580707086665, 5909.143174239625, 5917.911231331447, 5939.3466718661775, 5949.077892926603, 4854.2233242681, 5802.941970580409, 5810.983077961424, 5811.215485909517, 5814.5348372130975], "value": 5700.704660264148, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [450.6687584625302, 469.21640859764193, 474.444899467623, 492.85460789067224, 507.1935622360446, 27697.58453623195, 31510.68489315106, 31513.68486315136, 31552.52671209931, 39681.0, 41302.38046429306, 43866.56133438665, 43950.0, 44015.0, 44158.779206104, 8340.999080110396, 9326.114019168203, 9534.570944307523, 9540.904590954106, 9548.665796697116, 7074.964625176867, 8574.228319451247, 9327.533623318841, 9478.43129412234, 9613.894402143738, 11254.774904501905, 11507.42462876857, 11523.65429037126, 11707.121965852553, 11751.118666100077, 11411.657650270505, 11501.827472587918, 11520.827187592193, 11521.193516453852, 11521.654350369503, 8465.788355291106, 8694.087120852282, 9741.318107732392, 11428.542858285658, 11445.828312575319, 39676.611318604, 40504.18991620151, 40573.754099671954, 41666.958326041786, 42668.57331426677, 3958.2281455116263, 3964.147708242742, 3965.7620542767527, 3972.6623237024887, 3987.501562304712, 29403.705962940312, 29438.26404339887, 29452.263693407836, 31282.530762038587, 31312.0, 3077.569140320357, 3176.491761318178, 3287.161773747703, 3289.473684210515, 3366.6128395234373, 365097.0, 366312.0, 366399.0, 366897.9999999973, 369931.0, 49843.0, 60168.495787604785, 60276.698616507514, 60399.39600604025, 60414.0, 64825.675871621286, 65015.34984650188, 65140.67429662821, 65141.34858651353, 65143.67428162924, 16388.0, 16671.83328166727, 16678.749818752727, 16684.49946501607, 16695.165241737865, 12936.223826570436, 13002.219866808022, 13011.154274972096, 13023.0, 13029.674258143623, 12649.873501265054, 14292.85707142936, 14582.197979111039, 14639.121652700873, 16280.918595406947, 5628.071368224197, 6270.498360131179, 6445.9355406446275, 6510.9023364649565, 6610.669466526654, 731.5464412064554, 836.983260334802, 869.7651634058768, 874.4097734029505, 885.964561417549, 26894.0, 29953.700462995526, 30052.248693782392, 30752.53871191934, 30762.0, 1059.692689120162, 1063.7872425514772, 1096.550414330121, 1098.0721290509507, 1216.689744115245, 14883.553493395215, 15265.694686106215, 15689.0, 17630.118494075246, 17636.73544896802, 574348.0, 598633.0136698665, 646226.0, 652997.0, 666773.0, 66212.66893665597, 66754.66622666952, 66935.0, 66937.0, 66955.66522167358, 1452.4262916148061, 1472.3153733513968, 1484.2949598940634, 1518.476125736597, 1520.7186670465999, 30629.387412251184, 31834.522482162323, 31912.36175276528, 31946.68053319437, 32647.510287346184, 54207.91584168216, 54905.72547137398, 54944.72527637336, 54955.0, 55055.0, 603121.0, 607594.0, 609185.0, 610336.0, 610606.9469652623, 42870.78564607157, 43036.83292363789, 43099.56900431081, 43146.13707725765, 43543.0, 46994.29508557306, 47345.053098938515, 47959.28061079017, 47976.7601161992, 48197.0, 38329.80835095807, 38449.03877403087, 38771.0, 39822.40266395948, 39951.400728988505, 38631.227375452894, 38879.230700455795, 39029.0, 39036.60963390443, 39830.20339593134, 37866.432003520524, 38561.2287754249, 38679.80660096682, 38762.0, 38778.0, 30399.0, 33465.0, 33830.815921442634, 34069.829650851585, 34091.0, 24959.625605616293, 24971.75028249694, 25311.746882531676, 25547.489050219265, 25816.354591135372], "value": 20185.939586593584, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.6975634614138, 392.3663283796668, 394.0228233979732, 402.1996227507261, 425.7871064467766, 13712.236438647722, 15701.057936523817, 18354.908225458872, 20891.582168356625, 20950.580988380225, 20709.482262943435, 20975.580488390224, 21562.784372156275, 21705.782942170572, 21896.014679339427, 5588.189712491707, 5592.972035139818, 5764.308283006045, 5796.304443466769, 5829.533637309027, 4163.396307535406, 5726.31284245891, 5848.0, 5853.180554722342, 5856.853578660525, 4342.32693932441, 6254.9374506255035, 6625.204975402959, 6640.0703901453835, 6643.6346000969925, 6393.648349340784, 6498.902516462257, 6623.53635245533, 6629.73481060757, 6664.500162487784, 5867.589268751189, 5870.941290587082, 5876.324222714357, 5879.441453061952, 5884.823455296348, 26205.0, 27209.591856122173, 27237.727622723716, 27409.31476713078, 27651.446971060668, 2644.563646998243, 2700.9459810803673, 2718.714534973839, 2729.263098963269, 2791.4975304445193, 13109.164716939636, 15179.848201518063, 15869.04785712861, 16044.43844465438, 16581.336746530123, 1827.6253368059515, 1834.7431359609666, 1848.621032688309, 1865.2352535460395, 1866.2721538599958, 124954.12568811476, 125334.0, 130153.0, 133147.6685233145, 133586.66413335936, 11234.606788762354, 11684.298942063504, 11781.76436471283, 11904.702382440335, 11905.226160299553, 15091.698166036618, 15140.318685659171, 15141.924290378698, 15151.166685832384, 15161.772573411408, 8571.614277357534, 8829.508861661114, 8845.51349675774, 8884.0, 8989.55052247385, 8918.286537077018, 8923.464592124494, 8944.418612790148, 9051.683191088412, 9092.636294548276, 6294.622322660563, 6399.13611662429, 7370.926290737024, 7499.175090740015, 7502.4748267621835, 1939.9127039283267, 1972.940811775649, 1988.7514060742408, 1990.0, 1991.2532800199924, 883.5847151838625, 897.264243320471, 905.3255324782947, 942.7124726958343, 947.7298969793576, 22365.440863978205, 23049.42376440569, 23313.650295245585, 23465.413364665677, 23503.41241468943, 918.875951746519, 941.4915945389413, 948.7343543807744, 954.909283618069, 962.4802606592501, 11531.538738450536, 11763.764724705628, 12097.818532722016, 12100.69748256283, 12133.635990920286, 760679.0, 762076.0, 771217.0, 772198.0, 792338.0, 120692.0, 143139.0, 144043.0, 151477.48522514635, 154208.0, 1032.550840384435, 1035.7410647338165, 1037.1754455207977, 1058.7194393485731, 1060.612876300145, 15099.471518496799, 19128.617427651647, 20131.39605811828, 20212.393628191177, 20215.696764548837, 49204.0, 50219.748901256724, 50632.481025569294, 51257.974840503724, 51309.71725706738, 74605.50788984298, 75904.62047689946, 76281.61859190669, 76649.23350766645, 76734.0, 7838.882416763867, 8116.878246826184, 8282.917170828456, 8292.33661307106, 8343.123971982854, 9424.81150376975, 12086.093542984136, 12183.817242741188, 12462.43919023628, 12465.626031219077, 8221.465604735673, 8536.62803192723, 8702.47785132894, 9054.230390416888, 9643.132118109123, 10715.303505272132, 10925.399103049409, 11103.333799972028, 11202.327860328407, 11298.378589177673, 11363.090952723927, 11470.4264786762, 11652.0, 11686.0, 12099.637010889688, 8087.595620219083, 8140.83718325642, 8152.429329946846, 8227.588620569068, 8563.229309362187, 10999.23005389615, 11114.88885111171, 11237.55049797999, 11442.656720298404, 11540.076793856304], "value": 10052.66904572155, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1406.4022790314114, 1426.5720283914823, 1433.512605714057, 1442.0770706747676, 1446.0600609603753, 8076.39427042972, 8441.071482136975, 8450.450720703158, 8453.746387608366, 8472.57637118144, 7353.30143636355, 7645.350145237661, 7655.732049378273, 8038.236367545074, 8171.550564718938, 2313.5835549601065, 2347.448349637842, 2347.6595893595504, 2348.0020991078723, 2349.060375849657, 2316.6756654068445, 2355.693759811222, 2359.1742889988536, 2360.8819559022068, 2364.196173301077, 2044.1925439451481, 2122.660374340106, 2126.766055733868, 2129.968050479244, 2301.873396963166, 2075.3773867839586, 2202.812760915332, 2278.9658155127686, 2281.4638559938403, 2289.198780426854, 1958.187352248815, 2308.976910230893, 2311.15642790382, 2317.3627252505526, 2318.7913087822008, 8104.959475202645, 8177.959110204471, 8183.6726530938695, 8194.959025204895, 8199.508029518249, 4941.925871111936, 5110.693358398508, 5123.077845987721, 5125.179971204627, 5128.230765385185, 3214.2928555717704, 3286.145602143436, 3431.365197438482, 3479.4780782882517, 3518.419460788992, 1149.2415006095937, 1192.5320771335664, 1206.849143857018, 1207.2032458577296, 1225.2036176485356, 10797.5680972761, 10900.618478353219, 10911.018008379204, 10916.781664366668, 10925.180611454094, 3966.702497312713, 4393.0, 4645.837395691202, 4732.905341893143, 4737.099951009297, 9388.90611093894, 9418.34071614994, 9526.571304291323, 9551.856722149174, 9570.712878613653, 5229.08491014071, 5232.319798426256, 5236.397814251333, 5236.633435659467, 5250.212468129811, 3925.823337949799, 4270.081932384553, 4388.780560971939, 4431.689781715249, 4689.929651055237, 3787.034306251888, 3845.3655146901006, 3949.0, 3958.148997965394, 3961.841526338972, 1255.598208573266, 1277.718901841612, 1279.500994612102, 1289.207137610363, 1296.7989961555975, 878.3851304087165, 878.4904755241944, 886.7738726624669, 890.1098901098901, 890.4167770110588, 5613.354464236665, 5670.631408958405, 5748.281464816898, 5768.903908257417, 5936.643801371845, 854.8544949767218, 966.246327864267, 974.2157563161581, 975.7609385700407, 1015.7003683913264, 3199.936001279961, 3297.2086699192023, 3595.1551385424405, 3658.6707196352454, 3687.870924517629, 8952.955235223782, 9259.398139120936, 9488.857667134998, 9996.950015249877, 10037.69886903394, 9830.803383932282, 9919.0, 9943.45311007887, 9958.701238962843, 10002.34984726005, 7735.497192682457, 7754.0, 7819.413543984224, 7930.0880398753725, 7943.563104029334, 5316.787328506816, 5414.485623865727, 5427.918849926143, 5554.222408862844, 5659.518940890071, 8838.204561589488, 9150.496722680316, 9189.356745027784, 9253.352265341362, 9368.578413971523, 9171.037041110587, 9205.76985575366, 9355.953220233856, 9492.003339649238, 9495.810083798424, 6586.110875031809, 6808.659567021728, 7072.646367681698, 7312.780616581511, 7332.193458719643, 7487.775366739006, 7660.961695191489, 7954.00574928134, 7967.800804979922, 8059.83880322402, 7042.507024508235, 7130.607816570138, 7197.1363436387965, 7259.382952449101, 7267.854642907218, 7065.788026359218, 7075.469339799432, 7077.221505634479, 7079.823004424725, 7155.821104472429, 5492.203630473638, 6254.906176407449, 6358.586691865014, 6392.0, 6464.515161362822, 4764.190087685171, 4769.998300356825, 4809.9038019240115, 4860.635452341018, 4892.437369702529, 4632.143053535106, 4688.507706690748, 4700.670953033255, 4839.346688197048, 4924.9507504924495], "value": 4370.740646297975, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.1922578070438, 355.9960910233142, 360.9584897736761, 373.68236998551237, 374.6665467733716, 4958.380202474696, 5010.624203184767, 5147.974260128694, 5343.465653434655, 5412.783488660454, 4826.32431459596, 5073.162928116856, 5165.38015438147, 5211.843644690656, 5215.739213039352, 3538.3277177336354, 3737.7009839212797, 3926.9410958835642, 4006.371048676614, 4098.180363927227, 3650.9777262366447, 3808.9428658570146, 4177.185448837478, 4199.664026877857, 4201.789910504478, 3397.7961322320616, 3537.770044947083, 3977.2642061218767, 4049.068714195737, 4050.615191556812, 3209.935801283973, 4023.7786921719294, 4032.74984754727, 4046.332355161395, 4052.412400201969, 3530.947035794465, 3545.3795585772646, 3547.5565554305713, 3547.875824346161, 3560.092176495003, 4598.8620341389815, 4836.613070954315, 5189.987952349294, 5235.973820130875, 5265.99730256258, 4039.2527382434346, 4072.7149099563044, 4532.215599974025, 4568.748718820463, 4600.5169457207185, 5322.099455796561, 5564.805231816867, 5584.9335745773915, 5598.552115830724, 5600.1599760035915, 3706.1647839402876, 3802.258559580883, 3820.7134464914966, 3831.3103641344546, 3845.15406610548, 4714.6464015199, 5779.2775903012125, 5816.563757718188, 5867.181173836125, 5903.262092238428, 3420.0, 3461.9826900865837, 3909.667678247324, 3919.8040097994985, 3920.2551515212017, 3676.8161591920298, 3943.6647884930103, 3948.993006783252, 3952.940705889414, 3970.940435893406, 4148.045949431647, 4308.612224899774, 4541.795619197144, 4596.6092882105395, 4601.884952876205, 5498.532624726863, 5638.210650508932, 5643.887122257532, 5661.160122960055, 5669.489745922887, 1090.607381342716, 1154.584349634131, 1176.7411169542686, 1227.2943057741657, 1237.6101528018646, 739.3641468337225, 754.9883156570222, 794.5987276425484, 873.9512584898148, 881.5415983688574, 4827.903441931142, 5054.21659642756, 5061.670991385622, 5074.594032477393, 5094.0, 4846.316799232538, 4925.6700690814, 5011.949880501221, 5453.045716999509, 5637.548996080303, 4318.827246910151, 5296.25852380667, 5330.38700549434, 5385.461453854661, 5388.838334849961, 2436.3189399314415, 2626.290901456596, 2766.4507875589734, 2885.30752619374, 2926.9707302927122, 5045.495450454925, 5389.844062375081, 5546.391546451484, 5585.385607583163, 5735.971320143372, 5685.317761868602, 5718.885622287531, 5721.742521586455, 5741.301588253514, 5785.82642520725, 4961.6526843121355, 5300.681959082467, 5630.368412374078, 5786.594938354359, 5809.419058094072, 4384.596928982695, 4632.467266264288, 5262.52649258193, 5726.856828579319, 5729.197912292199, 5480.013597552479, 5699.178906441338, 5717.3996730342715, 5728.79949201776, 5736.483716465538, 5019.7741101651245, 5332.866678333073, 5564.247262112422, 5947.1079338099635, 5992.760289588542, 3500.964990350064, 3812.3709587917683, 4129.472095324749, 4223.1975924574235, 4237.25847976609, 4770.451398089264, 5424.213489044146, 5832.0, 5833.591648584728, 5863.794767183128, 5087.3386459759995, 5398.840463814348, 5581.330240371181, 5693.231413759089, 5731.856703582277, 4708.246680531099, 4820.325154478446, 5570.498655121059, 5616.241807356118, 5641.661500309994, 4504.707194032378, 4616.722996620214, 5216.626434972003, 5240.973795131, 5300.091966891993, 5268.4731526848545, 5612.800703598909, 5612.943870561242, 5618.438156184349, 5672.432756724294, 4155.480564929384, 4859.902801944012, 5253.763580638957, 5371.033214021513, 5536.536241372551], "value": 4032.503494935972, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.3731079339385, 745.7389913530266, 751.9735560959289, 806.4878801960755, 819.5492479136474, 14579.70840583189, 14719.896007799405, 15241.0, 15250.542483725478, 15619.765703514457, 13979.860201397983, 14010.159390436582, 14103.224322662249, 14291.071080379768, 14305.856941430582, 843.9704610338639, 850.6172222499899, 851.259404318244, 852.0627309959026, 852.3692467573982, 673.0509980926894, 690.5442408010714, 819.7212947597816, 843.8945131858518, 844.4595458906305, 894.061235702513, 895.3463971300954, 895.7805337692274, 897.6633762339122, 898.0480690468092, 891.589868660417, 891.9331050171263, 892.1435421994893, 892.5626443042895, 894.6063731957951, 527.1276038156857, 535.2987586262009, 539.1373801916901, 666.4834753066364, 670.9765158219438, 12039.458224379836, 12084.6374608761, 12087.395630218542, 13991.0, 14505.0, 13845.307734613229, 13846.861531384659, 13925.860741392658, 13970.371333289924, 14065.859341406558, 10881.67354979344, 11100.865581962584, 11160.553577856876, 11523.366214858179, 11649.41752912351, 3692.6861216796606, 3794.90512737181, 3834.5206849143856, 3836.865709700147, 3838.0404898775305, 91479.54260228723, 96156.9999999993, 96399.0, 98435.50782246042, 107834.0, 10746.032857042903, 10779.89220107789, 10863.782724345469, 10924.726881828017, 10960.177986651033, 21619.0, 21819.454513636967, 22107.889460552593, 22110.22614208495, 22178.556428871332, 7676.80807979805, 7734.497257678346, 7752.5736084514765, 7779.287634275267, 7809.258120478546, 4141.0, 4174.290370636999, 4253.149370125987, 4260.573942605776, 4307.181635489247, 3471.5486986691567, 3541.9551232386507, 3542.8228588570983, 3547.52108465359, 3571.39286321326, 582.7785441532276, 603.6589327030214, 620.4292051312804, 628.8082134948793, 637.1684951138808, 645.9922520867461, 677.4140368581142, 696.7317582730685, 701.3897908819359, 717.1322699533519, 7219.711211551479, 8698.173673501007, 9903.45530995802, 9954.751131221778, 9968.601255949681, 559.443353862909, 585.68665763817, 606.6087373644064, 607.1772747926584, 607.7174114036906, 3881.5342158941107, 4638.768061596907, 4652.511486293958, 4897.0450762101045, 4934.925976110361, 96612.68630225405, 97725.0, 98057.529137063, 98101.01898981062, 100328.49835750775, 69901.65049174824, 81216.0, 83943.0, 85726.0, 87506.56246718725, 60475.0, 72553.27446725465, 76038.47923041618, 78583.03542411486, 79126.92480191313, 9441.480718560546, 9609.711708648752, 9624.422534647943, 9627.759306017406, 9631.277654176105, 44979.0, 45914.770426147654, 48723.75638121787, 50780.0, 51017.74491127521, 58878.0, 60319.7936041268, 61950.69024654848, 63070.36929630645, 67753.32246677668, 12793.0, 12990.220586764824, 13184.60446186616, 13299.601011969657, 13584.36203770406, 14048.367823447765, 14133.6466588332, 14383.856161438252, 14687.412503500167, 14776.556703298918, 13258.66853328636, 13266.602001939957, 13358.465661373437, 13539.323033848072, 14001.929990349983, 13405.66485837862, 13607.931960340135, 13652.726945461234, 13891.52619884391, 14504.202268875313, 11088.722781930517, 12439.937800310941, 13241.3379331035, 13249.13880597758, 13987.650308742363, 10547.0, 10721.760182142736, 11221.719457013314, 11451.312921224753, 11635.069194464591, 9844.753881153028, 11270.887291126985, 11434.709009374516, 11544.249623774427, 11597.420128993685], "value": 7276.704935907054, "unit": "score"}], "name": "dromaeo_css", "value": 7276.046936477257, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 108.0, 109.0, 145.0, 110.0, 108.0, 107.0, 109.0, 130.0, 107.0], "value": 117.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 186.0, 184.0, 187.0, 183.0, 184.0, 185.0, 186.0, 183.0, 183.0], "value": 184.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 57.0, 88.0, 62.0, 66.0, 82.0, 79.0, 95.0, 61.0], "value": 72.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 69.0, 86.0, 68.0, 69.0, 70.0, 82.0, 68.0, 69.0, 82.0], "value": 75.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 87.0, 85.0, 86.0, 115.0, 74.0, 113.0, 132.0, 91.0], "value": 95.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 97.0, 94.0, 94.0, 94.0, 98.0, 94.0, 93.0], "value": 94.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 86.0, 88.0, 87.0, 88.0, 87.0, 85.0, 88.0, 85.0], "value": 86.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 54.0, 55.0, 57.0, 57.0, 55.0, 56.0, 56.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 66.0, 79.0, 76.0, 72.0, 69.0, 66.0, 58.0, 66.0, 70.0], "value": 69.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 88.0, 71.0, 97.0, 91.0, 92.0, 89.0, 86.0, 84.0, 90.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 135.0, 136.0, 135.0, 134.0, 135.0, 140.0, 139.0, 177.0, 148.0], "value": 141.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 165.0, 169.0, 169.0, 167.0, 166.0, 167.0, 162.0, 165.0, 165.0], "value": 166.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0, 64.0, 65.0, 64.0], "value": 65.4, "unit": "score"}], "name": "kraken", "value": 1424.8, "alertThreshold": 2.0}]} 10:03:05 INFO - Return code: 0 10:03:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:03:05 ERROR - # TBPL SUCCESS # 10:03:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:03:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:03:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:03:05 INFO - 2017-03-03 10:03:05.416 screenresolution[1656:9794] starting screenresolution argv=screenresolution get 10:03:05 INFO - 2017-03-03 10:03:05.420 screenresolution[1656:9794] Display 0: 1600x1200x32@60 10:03:05 INFO - 2017-03-03 10:03:05.426 screenresolution[1657:9797] starting screenresolution argv=screenresolution list 10:03:05 INFO - Available Modes on Display 0 10:03:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:03:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:03:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:03:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:03:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:03:05 INFO - Intel Iris: 10:03:05 INFO - Chipset Model: Intel Iris 10:03:05 INFO - Type: GPU 10:03:05 INFO - Bus: Built-In 10:03:05 INFO - VRAM (Dynamic, Max): 1536 MB 10:03:05 INFO - Vendor: Intel (0x8086) 10:03:05 INFO - Device ID: 0x0a2e 10:03:05 INFO - Revision ID: 0x0009 10:03:05 INFO - Displays: 10:03:05 INFO - Display: 10:03:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:03:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:03:05 INFO - Display Serial Number: 1600x1200 60 10:03:05 INFO - Main Display: Yes 10:03:05 INFO - Mirror: Off 10:03:05 INFO - Online: Yes 10:03:05 INFO - Rotation: Supported 10:03:05 INFO - Return code: 0 10:03:05 INFO - Running post-action listener: _resource_record_post_action 10:03:05 INFO - [mozharness: 2017-03-03 18:03:05.669366Z] Finished run-tests step (success) 10:03:05 INFO - Running post-run listener: _resource_record_post_run 10:03:05 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 37377024; Write bytes: 507894272; Read time: 250; Write time: 1599 10:03:05 INFO - TinderboxPrint: CPU usage
53.6% 10:03:05 INFO - TinderboxPrint: I/O read bytes / time
37,377,024 / 250 10:03:05 INFO - TinderboxPrint: I/O write bytes / time
507,894,272 / 1,599 10:03:05 INFO - TinderboxPrint: CPU idle
2,222.2 (46.4%) 10:03:05 INFO - TinderboxPrint: CPU system
956.4 (20.0%) 10:03:05 INFO - TinderboxPrint: CPU user
1,615.1 (33.7%) 10:03:05 INFO - TinderboxPrint: Swap in / out
245,518,336 / 0 10:03:05 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205675008; Write bytes: 200840704; Read time: 15756; Write time: 455 10:03:05 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 35292160; Write bytes: 296076288; Read time: 230; Write time: 1113 10:03:06 INFO - Running post-run listener: _upload_blobber_files 10:03:06 INFO - Blob upload gear active. 10:03:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:03:06 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:03:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:03:06 INFO - (blobuploader) - INFO - Open directory for files ... 10:03:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:03:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:03:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:03:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:03:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:03:07 INFO - (blobuploader) - INFO - Done attempting. 10:03:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:03:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:03:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:03:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:03:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:03:08 INFO - (blobuploader) - INFO - Done attempting. 10:03:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:03:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:03:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:03:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:03:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:03:09 INFO - (blobuploader) - INFO - Done attempting. 10:03:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:03:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:03:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:03:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:03:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:03:12 INFO - (blobuploader) - INFO - Done attempting. 10:03:12 INFO - (blobuploader) - INFO - Iteration through files over. 10:03:12 INFO - Return code: 0 10:03:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:03:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:03:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3b73eba47985c85119bec086efd2bddc369448337f9664abbf1ea29c856b37911fc9baaa338f300673d9aaeedaf8f0772d5117f57a235db5348a2e4cafa77871", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/550702dd9f492bcebdbb0b9eb29d98f2a52ee6bca82cb5878dc1e7e684ccd97d3a8cb03e95e753191c0b3ef6e5ebea991a08ef54bcc2543d4507c61e02f6af4f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/72622a33316525382e59c061690fe9f4af0377a96ee732d11d8a121dda9ee87f5a4018e286b709df53da0eaf9831c0af59db89dc8faa440c29a32d4917b9c898", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/168f48d1bbda0971c249b57b84105bc952a1ed104f6402cc7ec358a181fdae13e58ec2c4b66a0f41456c5379f8a53c4e4c204550d3f59cb9e05da6e937a55024"} 10:03:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:03:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:03:12 INFO - Contents: 10:03:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3b73eba47985c85119bec086efd2bddc369448337f9664abbf1ea29c856b37911fc9baaa338f300673d9aaeedaf8f0772d5117f57a235db5348a2e4cafa77871", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/550702dd9f492bcebdbb0b9eb29d98f2a52ee6bca82cb5878dc1e7e684ccd97d3a8cb03e95e753191c0b3ef6e5ebea991a08ef54bcc2543d4507c61e02f6af4f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/72622a33316525382e59c061690fe9f4af0377a96ee732d11d8a121dda9ee87f5a4018e286b709df53da0eaf9831c0af59db89dc8faa440c29a32d4917b9c898", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/168f48d1bbda0971c249b57b84105bc952a1ed104f6402cc7ec358a181fdae13e58ec2c4b66a0f41456c5379f8a53c4e4c204550d3f59cb9e05da6e937a55024"} 10:03:12 INFO - Running post-run listener: copy_logs_to_upload_dir 10:03:12 INFO - Copying logs to upload dir... 10:03:12 INFO - mkdir: /builds/slave/test/build/upload/logs 10:03:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.706420 ========= master_lag: 1.15 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-03-03 10:03:13.573181) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2017-03-03 10:03:13.579680) ========= 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.l2uRgkltpe/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.46LsyCEzQk/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3b73eba47985c85119bec086efd2bddc369448337f9664abbf1ea29c856b37911fc9baaa338f300673d9aaeedaf8f0772d5117f57a235db5348a2e4cafa77871", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/550702dd9f492bcebdbb0b9eb29d98f2a52ee6bca82cb5878dc1e7e684ccd97d3a8cb03e95e753191c0b3ef6e5ebea991a08ef54bcc2543d4507c61e02f6af4f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/72622a33316525382e59c061690fe9f4af0377a96ee732d11d8a121dda9ee87f5a4018e286b709df53da0eaf9831c0af59db89dc8faa440c29a32d4917b9c898", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/168f48d1bbda0971c249b57b84105bc952a1ed104f6402cc7ec358a181fdae13e58ec2c4b66a0f41456c5379f8a53c4e4c204550d3f59cb9e05da6e937a55024"} build_url:https://queue.taskcluster.net/v1/task/fXuSs949RBSJiFZrnc6Mig/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010663 build_url: 'https://queue.taskcluster.net/v1/task/fXuSs949RBSJiFZrnc6Mig/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3b73eba47985c85119bec086efd2bddc369448337f9664abbf1ea29c856b37911fc9baaa338f300673d9aaeedaf8f0772d5117f57a235db5348a2e4cafa77871", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/550702dd9f492bcebdbb0b9eb29d98f2a52ee6bca82cb5878dc1e7e684ccd97d3a8cb03e95e753191c0b3ef6e5ebea991a08ef54bcc2543d4507c61e02f6af4f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/72622a33316525382e59c061690fe9f4af0377a96ee732d11d8a121dda9ee87f5a4018e286b709df53da0eaf9831c0af59db89dc8faa440c29a32d4917b9c898", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/168f48d1bbda0971c249b57b84105bc952a1ed104f6402cc7ec358a181fdae13e58ec2c4b66a0f41456c5379f8a53c4e4c204550d3f59cb9e05da6e937a55024"}' ========= master_lag: 1.14 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2017-03-03 10:03:14.729851) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2017-03-03 10:03:14.730199) ========= 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.l2uRgkltpe/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.46LsyCEzQk/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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.005069 ========= master_lag: 3.24 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2017-03-03 10:03:17.977161) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-03 10:03:17.977509) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-03 10:03:17.984024) ========= ========= Total master_lag: 5.61 =========