builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0029 starttime: 1488577134.64 results: success (0) buildid: 20170303121751 builduid: 6ebe2975b0e24af6ad15b44862207b59 revision: 9b921f750287da0bb330d799658da45f37ca14d7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-03 13:38:54.643153) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-03 13:38:54.643659) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-03 13:38:54.643957) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-03 13:38:54.671275) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 13:38:54.671671) ========= 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.obVQmqNfyP/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.mza1N0Gm9m/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 13:38:54-- 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% 12.2M=0.001s 2017-03-03 13:38:54 (12.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127635 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 13:38:54.825283) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 13:38:54.825638) ========= 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.obVQmqNfyP/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.mza1N0Gm9m/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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.036639 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 13:38:54.887401) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-03 13:38:54.888180) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9b921f750287da0bb330d799658da45f37ca14d7 --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 9b921f750287da0bb330d799658da45f37ca14d7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.obVQmqNfyP/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.mza1N0Gm9m/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 13:38:54,993 truncating revision to first 12 chars 2017-03-03 13:38:54,993 Setting DEBUG logging. 2017-03-03 13:38:54,993 attempt 1/10 2017-03-03 13:38:54,993 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9b921f750287?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-03 13:38:56,023 unpacking tar archive at: mozilla-aurora-9b921f750287/testing/mozharness/ program finished with exit code 0 elapsedTime=1.300213 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-03 13:38:56.214166) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-03 13:38:56.214505) ========= script_repo_revision: 9b921f750287da0bb330d799658da45f37ca14d7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-03 13:38:56.214998) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-03 13:38:56.215264) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-03 13:38:56.235571) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-03 13:38:56.235944) ========= /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.obVQmqNfyP/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.mza1N0Gm9m/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 13:38:56 INFO - MultiFileLogger online at 20170303 13:38:56 in /builds/slave/test 13:38:56 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 13:38:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:38:56 INFO - {'append_to_log': False, 13:38:56 INFO - 'base_work_dir': '/builds/slave/test', 13:38:56 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:38:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:38:56 INFO - 'branch': 'Mozilla-Aurora', 13:38:56 INFO - 'buildbot_json_path': 'buildprops.json', 13:38:56 INFO - 'config_files': ('talos/mac_config.py',), 13:38:56 INFO - 'default_actions': ('clobber', 13:38:56 INFO - 'read-buildbot-config', 13:38:56 INFO - 'download-and-extract', 13:38:56 INFO - 'populate-webroot', 13:38:56 INFO - 'create-virtualenv', 13:38:56 INFO - 'install', 13:38:56 INFO - 'run-tests'), 13:38:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:38:56 INFO - 'download_minidump_stackwalk': True, 13:38:56 INFO - 'download_symbols': 'ondemand', 13:38:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:38:56 INFO - 'tooltool.py': '/tools/tooltool.py', 13:38:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:38:56 INFO - '/tools/misc-python/virtualenv.py')}, 13:38:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:38:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:38:56 INFO - 'installer_path': 'installer.exe', 13:38:56 INFO - 'log_level': 'info', 13:38:56 INFO - 'log_name': 'talos', 13:38:56 INFO - 'log_to_console': True, 13:38:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:38:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:38:56 INFO - 'opt_config_files': (), 13:38:56 INFO - 'pip_index': False, 13:38:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:38:56 INFO - 'cmd': ('bash', 13:38:56 INFO - '-c', 13:38:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:38:56 INFO - 'enabled': True, 13:38:56 INFO - 'halt_on_failure': False, 13:38:56 INFO - 'name': 'check_screen_resolution'},), 13:38:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:38:56 INFO - 'cmd': ('bash', 13:38:56 INFO - '-c', 13:38:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:38:56 INFO - 'enabled': True, 13:38:56 INFO - 'halt_on_failure': False, 13:38:56 INFO - 'name': 'check_screen_resolution'},), 13:38:56 INFO - 'run_cmd_checks_enabled': True, 13:38:56 INFO - 'sps_profile': False, 13:38:56 INFO - 'sps_profile_interval': 0, 13:38:56 INFO - 'suite': 'dromaeojs', 13:38:56 INFO - 'system_bits': '32', 13:38:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:38:56 INFO - 'title': 't-yosemite-r7-0029', 13:38:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:38:56 INFO - 'use_talos_json': True, 13:38:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:38:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:38:56 INFO - 'work_dir': 'build'} 13:38:56 INFO - [mozharness: 2017-03-03 21:38:56.453811Z] Running clobber step. 13:38:56 INFO - Running pre-action listener: _resource_record_pre_action 13:38:56 INFO - Running main action method: clobber 13:38:56 INFO - rmtree: /builds/slave/test/build 13:38:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:38:59 INFO - Running post-action listener: _resource_record_post_action 13:38:59 INFO - [mozharness: 2017-03-03 21:38:59.068489Z] Finished clobber step (success) 13:38:59 INFO - [mozharness: 2017-03-03 21:38:59.068620Z] Running read-buildbot-config step. 13:38:59 INFO - Running pre-action listener: _resource_record_pre_action 13:38:59 INFO - Running main action method: read_buildbot_config 13:38:59 INFO - Using buildbot properties: 13:38:59 INFO - { 13:38:59 INFO - "project": "", 13:38:59 INFO - "product": "firefox", 13:38:59 INFO - "script_repo_revision": "production", 13:38:59 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 13:38:59 INFO - "repository": "", 13:38:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 13:38:59 INFO - "buildid": "20170303121751", 13:38:59 INFO - "pgo_build": "False", 13:38:59 INFO - "basedir": "/builds/slave/test", 13:38:59 INFO - "buildnumber": 45, 13:38:59 INFO - "slavename": "t-yosemite-r7-0029", 13:38:59 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 13:38:59 INFO - "platform": "yosemite_r7", 13:38:59 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 13:38:59 INFO - "branch": "mozilla-aurora", 13:38:59 INFO - "repo_path": "releases/mozilla-aurora", 13:38:59 INFO - "revision": "9b921f750287da0bb330d799658da45f37ca14d7", 13:38:59 INFO - "stage_platform": "macosx64", 13:38:59 INFO - "builduid": "6ebe2975b0e24af6ad15b44862207b59", 13:38:59 INFO - "slavebuilddir": "test" 13:38:59 INFO - } 13:38:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/d5XDJ_MnSW6WSXn2C5vygQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 13:38:59 INFO - Running post-action listener: _resource_record_post_action 13:38:59 INFO - [mozharness: 2017-03-03 21:38:59.072023Z] Finished read-buildbot-config step (success) 13:38:59 INFO - [mozharness: 2017-03-03 21:38:59.072162Z] Running download-and-extract step. 13:38:59 INFO - Running pre-action listener: _resource_record_pre_action 13:38:59 INFO - Running main action method: download_and_extract 13:38:59 INFO - mkdir: /builds/slave/test/build/tests 13:38: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')]} 13:38:59 INFO - trying https://queue.taskcluster.net/v1/task/d5XDJ_MnSW6WSXn2C5vygQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 13:38:59 INFO - Downloading https://queue.taskcluster.net/v1/task/d5XDJ_MnSW6WSXn2C5vygQ/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 13:38:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d5XDJ_MnSW6WSXn2C5vygQ/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 13:39:00 INFO - Downloaded 1199 bytes. 13:39:00 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 13:39:00 INFO - Using the following test package requirements: 13:39:00 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 13:39:00 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:39:00 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 13:39:00 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:39:00 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 13:39:00 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:39:00 INFO - u'jsshell-mac.zip'], 13:39:00 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:39:00 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 13:39:00 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 13:39:00 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:39:00 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 13:39:00 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:39:00 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 13:39:00 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:39:00 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 13:39:00 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:39:00 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 13:39:00 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 13:39:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d5XDJ_MnSW6WSXn2C5vygQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 13:39:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d5XDJ_MnSW6WSXn2C5vygQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:39:00 INFO - Fetch https://queue.taskcluster.net/v1/task/d5XDJ_MnSW6WSXn2C5vygQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 13:39:01 INFO - Expected file size: 16357791 13:39:01 INFO - Obtained file size: 16357791 13:39:08 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 13:39:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d5XDJ_MnSW6WSXn2C5vygQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 13:39:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d5XDJ_MnSW6WSXn2C5vygQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:39:08 INFO - Fetch https://queue.taskcluster.net/v1/task/d5XDJ_MnSW6WSXn2C5vygQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 13:39:08 INFO - Expected file size: 16357791 13:39:08 INFO - Obtained file size: 16357791 13:39:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d5XDJ_MnSW6WSXn2C5vygQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 13:39:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d5XDJ_MnSW6WSXn2C5vygQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 13:39:15 INFO - Fetch https://queue.taskcluster.net/v1/task/d5XDJ_MnSW6WSXn2C5vygQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 13:39:16 INFO - Expected file size: 14403650 13:39:16 INFO - Obtained file size: 14403650 13:39:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:16 INFO - trying https://queue.taskcluster.net/v1/task/d5XDJ_MnSW6WSXn2C5vygQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 13:39:16 INFO - Downloading https://queue.taskcluster.net/v1/task/d5XDJ_MnSW6WSXn2C5vygQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 13:39:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d5XDJ_MnSW6WSXn2C5vygQ/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 13:39:19 INFO - Downloaded 73933084 bytes. 13:39:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d5XDJ_MnSW6WSXn2C5vygQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 13:39:19 INFO - mkdir: /builds/slave/test/properties 13:39:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:39:19 INFO - Writing to file /builds/slave/test/properties/build_url 13:39:19 INFO - Contents: 13:39:19 INFO - build_url:https://queue.taskcluster.net/v1/task/d5XDJ_MnSW6WSXn2C5vygQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 13:39:19 INFO - Running post-action listener: _resource_record_post_action 13:39:19 INFO - Running post-action listener: set_extra_try_arguments 13:39:19 INFO - [mozharness: 2017-03-03 21:39:19.840370Z] Finished download-and-extract step (success) 13:39:19 INFO - [mozharness: 2017-03-03 21:39:19.840489Z] Running populate-webroot step. 13:39:19 INFO - Running pre-action listener: _resource_record_pre_action 13:39:19 INFO - Running main action method: populate_webroot 13:39:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:39:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:39:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:39:19 INFO - '--tppagecycles', 13:39:19 INFO - '7'], 13:39:19 INFO - 'tests': ['tsvgm']}}, 13:39:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:39:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:39:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:39:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:39:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:39:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:39:19 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:39:19 INFO - 'talos_options': ['--disable-e10s'], 13:39:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:39:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:39:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:39:19 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:39:19 INFO - 'talos_options': ['--disable-e10s'], 13:39:19 INFO - 'tests': ['damp', 'tps']}, 13:39:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:39:19 INFO - 'tests': ['damp', 'tps']}, 13:39:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:39:19 INFO - 'tests': ['dromaeo_dom']}, 13:39:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:39:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:39:19 INFO - 'tests': ['basic_compositor_video']}, 13:39:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:39:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:39:19 INFO - 'tests': ['a11yr', 13:39:19 INFO - 'ts_paint', 13:39:19 INFO - 'tpaint', 13:39:19 INFO - 'sessionrestore', 13:39:19 INFO - 'sessionrestore_no_auto_restore', 13:39:19 INFO - 'tabpaint']}, 13:39:19 INFO - 'other-e10s': {'tests': ['a11yr', 13:39:19 INFO - 'ts_paint', 13:39:19 INFO - 'tpaint', 13:39:19 INFO - 'sessionrestore', 13:39:19 INFO - 'sessionrestore_no_auto_restore', 13:39:19 INFO - 'tabpaint']}, 13:39:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:39:19 INFO - 'ts_paint', 13:39:19 INFO - 'tpaint', 13:39:19 INFO - 'sessionrestore', 13:39:19 INFO - 'sessionrestore_no_auto_restore', 13:39:19 INFO - 'tabpaint']}, 13:39:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:39:19 INFO - 'ts_paint', 13:39:19 INFO - 'tpaint', 13:39:19 INFO - 'sessionrestore', 13:39:19 INFO - 'sessionrestore_no_auto_restore', 13:39:19 INFO - 'tabpaint']}, 13:39:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:39:19 INFO - 'tests': ['a11yr', 13:39:19 INFO - 'ts_paint', 13:39:19 INFO - 'tpaint', 13:39:19 INFO - 'sessionrestore', 13:39:19 INFO - 'sessionrestore_no_auto_restore', 13:39:19 INFO - 'tabpaint']}, 13:39:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:39:19 INFO - 'tests': ['a11yr', 13:39:19 INFO - 'ts_paint', 13:39:19 INFO - 'tpaint', 13:39:19 INFO - 'sessionrestore', 13:39:19 INFO - 'sessionrestore_no_auto_restore', 13:39:19 INFO - 'tabpaint']}, 13:39:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:39:19 INFO - 'tests': ['tsvgx', 13:39:19 INFO - 'tsvgr_opacity', 13:39:19 INFO - 'tart', 13:39:19 INFO - 'tscrollx', 13:39:19 INFO - 'cart', 13:39:19 INFO - 'tsvg_static']}, 13:39:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:39:19 INFO - 'tsvgr_opacity', 13:39:19 INFO - 'tart', 13:39:19 INFO - 'tscrollx', 13:39:19 INFO - 'cart', 13:39:19 INFO - 'tsvg_static']}, 13:39:19 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:39:19 INFO - 'talos_options': ['--disable-e10s'], 13:39:19 INFO - 'tests': ['tp5o']}, 13:39:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:39:19 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:39:19 INFO - 'talos_options': ['--disable-e10s', 13:39:19 INFO - '--xperf_path', 13:39:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:39:19 INFO - 'tests': ['tp5n']}, 13:39:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:39:19 INFO - 'talos_options': ['--xperf_path', 13:39:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:39:19 INFO - 'tests': ['tp5n']}}, 13:39:19 INFO - 'talos.zip': {'path': '', 13:39:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:39:19 INFO - Running post-action listener: _resource_record_post_action 13:39:19 INFO - [mozharness: 2017-03-03 21:39:19.858711Z] Finished populate-webroot step (success) 13:39:19 INFO - [mozharness: 2017-03-03 21:39:19.858837Z] Running create-virtualenv step. 13:39:19 INFO - Running pre-action listener: _resource_record_pre_action 13:39:19 INFO - Running main action method: create_virtualenv 13:39:19 INFO - Creating virtualenv /builds/slave/test/build/venv 13:39:19 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 13:39:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:39:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:39:19 INFO - Using real prefix '/tools/python27' 13:39:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:39:20 INFO - Installing distribute.............................................................................................................................................................................................done. 13:39:23 INFO - Installing pip.................done. 13:39:23 INFO - Return code: 0 13:39:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:39:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:39:23 INFO - Reading from file tmpfile_stdout 13:39:23 INFO - Output received: 13:39:23 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) 13:39:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:39:23 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')]} 13:39:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:23 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')]} 13:39:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:23 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 0x109656b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109659768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82ab587380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109434d30>, '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 0x10935bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109429be8>, '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.obVQmqNfyP/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.mza1N0Gm9m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 13:39:23 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 13:39:23 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 13:39:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obVQmqNfyP/Render', 13:39:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:39:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:39:23 INFO - 'HOME': '/Users/cltbld', 13:39:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:39:23 INFO - 'LOGNAME': 'cltbld', 13:39:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:23 INFO - 'MOZ_NO_REMOTE': '1', 13:39:23 INFO - 'NO_EM_RESTART': '1', 13:39:23 INFO - 'PAGER': '/bin/cat', 13:39:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:39:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:23 INFO - 'PWD': '/builds/slave/test', 13:39:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:39:23 INFO - 'SHELL': '/bin/bash', 13:39:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mza1N0Gm9m/Listeners', 13:39:23 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 13:39:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:39:23 INFO - 'USER': 'cltbld', 13:39:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:39:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:39:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:23 INFO - 'XPC_FLAGS': '0x0', 13:39:23 INFO - 'XPC_SERVICE_NAME': '0', 13:39:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:39:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:24 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:39:24 INFO - Cleaning up... 13:39:24 INFO - Return code: 0 13:39:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109656b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109659768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82ab587380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109434d30>, '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 0x10935bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109429be8>, '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.obVQmqNfyP/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.mza1N0Gm9m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 13:39:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:39:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:39:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obVQmqNfyP/Render', 13:39:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:39:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:39:24 INFO - 'HOME': '/Users/cltbld', 13:39:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:39:24 INFO - 'LOGNAME': 'cltbld', 13:39:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:24 INFO - 'MOZ_NO_REMOTE': '1', 13:39:24 INFO - 'NO_EM_RESTART': '1', 13:39:24 INFO - 'PAGER': '/bin/cat', 13:39:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:39:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:24 INFO - 'PWD': '/builds/slave/test', 13:39:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:39:24 INFO - 'SHELL': '/bin/bash', 13:39:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mza1N0Gm9m/Listeners', 13:39:24 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 13:39:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:39:24 INFO - 'USER': 'cltbld', 13:39:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:39:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:39:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:24 INFO - 'XPC_FLAGS': '0x0', 13:39:24 INFO - 'XPC_SERVICE_NAME': '0', 13:39:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:39:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:24 INFO - Downloading/unpacking psutil>=3.1.1 13:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:39:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:39:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:39:27 INFO - Installing collected packages: psutil 13:39:27 INFO - Running setup.py install for psutil 13:39:27 INFO - building 'psutil._psutil_osx' extension 13:39:27 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 13:39:28 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 13:39:28 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 13:39:28 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 13:39:28 INFO - building 'psutil._psutil_posix' extension 13:39:28 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 13:39:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:39:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:39:28 INFO - ^ 13:39:28 INFO - 1 warning generated. 13:39:28 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 13:39:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:39:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:39:29 INFO - Successfully installed psutil 13:39:29 INFO - Cleaning up... 13:39:29 INFO - Return code: 0 13:39:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109656b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109659768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82ab587380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109434d30>, '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 0x10935bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109429be8>, '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.obVQmqNfyP/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.mza1N0Gm9m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 13:39:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:39:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:39:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obVQmqNfyP/Render', 13:39:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:39:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:39:29 INFO - 'HOME': '/Users/cltbld', 13:39:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:39:29 INFO - 'LOGNAME': 'cltbld', 13:39:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:29 INFO - 'MOZ_NO_REMOTE': '1', 13:39:29 INFO - 'NO_EM_RESTART': '1', 13:39:29 INFO - 'PAGER': '/bin/cat', 13:39:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:39:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:29 INFO - 'PWD': '/builds/slave/test', 13:39:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:39:29 INFO - 'SHELL': '/bin/bash', 13:39:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mza1N0Gm9m/Listeners', 13:39:29 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 13:39:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:39:29 INFO - 'USER': 'cltbld', 13:39:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:39:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:39:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:29 INFO - 'XPC_FLAGS': '0x0', 13:39:29 INFO - 'XPC_SERVICE_NAME': '0', 13:39:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:39:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:39:29 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 13:39:29 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 13:39:29 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 13:39:29 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 13:39:29 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 13:39:29 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 13:39:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:39:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:39:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:39:32 INFO - Installing collected packages: mozsystemmonitor 13:39:32 INFO - Running setup.py install for mozsystemmonitor 13:39:32 INFO - Successfully installed mozsystemmonitor 13:39:32 INFO - Cleaning up... 13:39:32 INFO - Return code: 0 13:39:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:39:32 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')]} 13:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:32 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')]} 13:39:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:32 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 0x109656b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109659768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82ab587380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109434d30>, '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 0x10935bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109429be8>, '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.obVQmqNfyP/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.mza1N0Gm9m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 13:39:32 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 13:39:32 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 13:39:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obVQmqNfyP/Render', 13:39:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:39:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:39:32 INFO - 'HOME': '/Users/cltbld', 13:39:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:39:32 INFO - 'LOGNAME': 'cltbld', 13:39:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:32 INFO - 'MOZ_NO_REMOTE': '1', 13:39:32 INFO - 'NO_EM_RESTART': '1', 13:39:32 INFO - 'PAGER': '/bin/cat', 13:39:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:39:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:32 INFO - 'PWD': '/builds/slave/test', 13:39:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:39:32 INFO - 'SHELL': '/bin/bash', 13:39:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mza1N0Gm9m/Listeners', 13:39:32 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 13:39:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:39:32 INFO - 'USER': 'cltbld', 13:39:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:39:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:39:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:32 INFO - 'XPC_FLAGS': '0x0', 13:39:32 INFO - 'XPC_SERVICE_NAME': '0', 13:39:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:39:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:32 INFO - Downloading/unpacking jsonschema==2.5.1 13:39:32 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 13:39:32 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 13:39:32 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 13:39:32 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 13:39:32 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 13:39:32 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 13:39:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:39:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:35 INFO - Downloading functools32-3.2.3-2.tar.gz 13:39:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:39:35 INFO - warning: no files found matching '*.txt' 13:39:35 INFO - no previously-included directories found matching 'build' 13:39:35 INFO - no previously-included directories found matching 'dist' 13:39:35 INFO - no previously-included directories found matching '.git*' 13:39:35 INFO - Installing collected packages: jsonschema, functools32 13:39:35 INFO - Running setup.py install for functools32 13:39:36 INFO - warning: no files found matching '*.txt' 13:39:36 INFO - no previously-included directories found matching 'build' 13:39:36 INFO - no previously-included directories found matching 'dist' 13:39:36 INFO - no previously-included directories found matching '.git*' 13:39:36 INFO - Successfully installed jsonschema functools32 13:39:36 INFO - Cleaning up... 13:39:36 INFO - Return code: 0 13:39:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:39:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109656b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109659768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82ab587380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109434d30>, '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 0x10935bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109429be8>, '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.obVQmqNfyP/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.mza1N0Gm9m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 13:39:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:39:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:39:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obVQmqNfyP/Render', 13:39:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:39:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:39:36 INFO - 'HOME': '/Users/cltbld', 13:39:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:39:36 INFO - 'LOGNAME': 'cltbld', 13:39:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:36 INFO - 'MOZ_NO_REMOTE': '1', 13:39:36 INFO - 'NO_EM_RESTART': '1', 13:39:36 INFO - 'PAGER': '/bin/cat', 13:39:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:39:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:36 INFO - 'PWD': '/builds/slave/test', 13:39:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:39:36 INFO - 'SHELL': '/bin/bash', 13:39:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mza1N0Gm9m/Listeners', 13:39:36 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 13:39:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:39:36 INFO - 'USER': 'cltbld', 13:39:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:39:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:39:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:36 INFO - 'XPC_FLAGS': '0x0', 13:39:36 INFO - 'XPC_SERVICE_NAME': '0', 13:39:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:39:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:39:36 INFO - Cleaning up... 13:39:36 INFO - Return code: 0 13:39:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:39:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109656b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109659768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82ab587380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109434d30>, '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 0x10935bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109429be8>, '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.obVQmqNfyP/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.mza1N0Gm9m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 13:39:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:39:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:39:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obVQmqNfyP/Render', 13:39:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:39:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:39:36 INFO - 'HOME': '/Users/cltbld', 13:39:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:39:36 INFO - 'LOGNAME': 'cltbld', 13:39:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:36 INFO - 'MOZ_NO_REMOTE': '1', 13:39:36 INFO - 'NO_EM_RESTART': '1', 13:39:36 INFO - 'PAGER': '/bin/cat', 13:39:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:39:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:36 INFO - 'PWD': '/builds/slave/test', 13:39:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:39:36 INFO - 'SHELL': '/bin/bash', 13:39:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mza1N0Gm9m/Listeners', 13:39:36 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 13:39:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:39:36 INFO - 'USER': 'cltbld', 13:39:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:39:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:39:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:36 INFO - 'XPC_FLAGS': '0x0', 13:39:36 INFO - 'XPC_SERVICE_NAME': '0', 13:39:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:39:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:36 INFO - Downloading/unpacking blobuploader==1.2.4 13:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:39 INFO - Downloading blobuploader-1.2.4.tar.gz 13:39:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:39:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:39:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:39:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:40 INFO - Downloading docopt-0.6.1.tar.gz 13:39:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:39:40 INFO - Installing collected packages: blobuploader, requests, docopt 13:39:40 INFO - Running setup.py install for blobuploader 13:39:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:39:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:39:40 INFO - Running setup.py install for requests 13:39:41 INFO - Running setup.py install for docopt 13:39:41 INFO - Successfully installed blobuploader requests docopt 13:39:41 INFO - Cleaning up... 13:39:41 INFO - Return code: 0 13:39:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:39:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:41 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 0x109656b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109659768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82ab587380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109434d30>, '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 0x10935bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109429be8>, '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.obVQmqNfyP/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.mza1N0Gm9m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 13:39:41 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 13:39:41 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 13:39:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obVQmqNfyP/Render', 13:39:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:39:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:39:41 INFO - 'HOME': '/Users/cltbld', 13:39:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:39:41 INFO - 'LOGNAME': 'cltbld', 13:39:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:41 INFO - 'MOZ_NO_REMOTE': '1', 13:39:41 INFO - 'NO_EM_RESTART': '1', 13:39:41 INFO - 'PAGER': '/bin/cat', 13:39:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:39:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:41 INFO - 'PWD': '/builds/slave/test', 13:39:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:39:41 INFO - 'SHELL': '/bin/bash', 13:39:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mza1N0Gm9m/Listeners', 13:39:41 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 13:39:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:39:41 INFO - 'USER': 'cltbld', 13:39:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:39:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:39:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:41 INFO - 'XPC_FLAGS': '0x0', 13:39:41 INFO - 'XPC_SERVICE_NAME': '0', 13:39:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:39:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:39:41 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-ErZ38U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:39:41 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Rsok3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:39:42 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-bBs0c8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:39:42 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-cQshbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:39:42 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-SqOPtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:39:42 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-kvMXn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:39:42 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-jfTPVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:39:42 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-2PNO8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:39:42 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-fGrSVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:39:42 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-goXE1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:39:42 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-G1cghd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:39:42 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-qKbInz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:39:43 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-xaoCxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:39:43 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-s2wf2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:39:43 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-ZbWkXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:39:43 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-_Gs818-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:39:43 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-uz6sZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:39:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:39:43 INFO - Running setup.py install for manifestparser 13:39:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:39:43 INFO - Running setup.py install for mozcrash 13:39:43 INFO - Running setup.py install for mozdebug 13:39:44 INFO - Running setup.py install for mozdevice 13:39:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:39:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:39:44 INFO - Running setup.py install for mozfile 13:39:44 INFO - Running setup.py install for mozhttpd 13:39:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:39:44 INFO - Running setup.py install for mozinfo 13:39:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:39:44 INFO - Running setup.py install for mozInstall 13:39:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:39:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:39:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:39:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:39:44 INFO - Running setup.py install for mozleak 13:39:44 INFO - Running setup.py install for mozlog 13:39:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:39:45 INFO - Running setup.py install for moznetwork 13:39:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:39:45 INFO - Running setup.py install for mozprocess 13:39:45 INFO - Running setup.py install for mozprofile 13:39:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:39:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:39:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:39:45 INFO - Running setup.py install for mozrunner 13:39:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:39:45 INFO - Running setup.py install for mozscreenshot 13:39:45 INFO - Running setup.py install for moztest 13:39:46 INFO - Running setup.py install for mozversion 13:39:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:39:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:39:46 INFO - Cleaning up... 13:39:46 INFO - Return code: 0 13:39:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109656b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109659768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82ab587380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109434d30>, '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 0x10935bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109429be8>, '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.obVQmqNfyP/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.mza1N0Gm9m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 13:39:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:39:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:39:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obVQmqNfyP/Render', 13:39:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:39:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:39:46 INFO - 'HOME': '/Users/cltbld', 13:39:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:39:46 INFO - 'LOGNAME': 'cltbld', 13:39:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:46 INFO - 'MOZ_NO_REMOTE': '1', 13:39:46 INFO - 'NO_EM_RESTART': '1', 13:39:46 INFO - 'PAGER': '/bin/cat', 13:39:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:39:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:46 INFO - 'PWD': '/builds/slave/test', 13:39:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:39:46 INFO - 'SHELL': '/bin/bash', 13:39:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mza1N0Gm9m/Listeners', 13:39:46 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 13:39:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:39:46 INFO - 'USER': 'cltbld', 13:39:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:39:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:39:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:46 INFO - 'XPC_FLAGS': '0x0', 13:39:46 INFO - 'XPC_SERVICE_NAME': '0', 13:39:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:39:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:39:46 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-P7BVcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:39:46 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)) 13:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:39:46 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-mzXoBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:39:46 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)) 13:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:39:46 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-aop2oA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:39:46 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)) 13:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:39:46 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-4257zR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:39:46 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)) 13:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:39:46 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-nINMpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:39:46 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)) 13:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:39:46 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-kTTK7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:39:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:39:47 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-PCNZcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:39:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:39:47 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-EJsR1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:39:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:39:47 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-GJBGzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:39:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:39:47 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-rEprqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:39:47 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)) 13:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:39:47 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-hgJ5jw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:39:47 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)) 13:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:39:47 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-i4L434-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:39:47 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)) 13:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:39:47 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-xCvxWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:39:47 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)) 13:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:39:47 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-f1Eu1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:39:47 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)) 13:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:39:47 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-wS5rSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:39:48 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-_VUipl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:39:48 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-fRqiE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:39:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39:50 INFO - Downloading blessings-1.6.tar.gz 13:39:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:39:50 INFO - Installing collected packages: blessings 13:39:50 INFO - Running setup.py install for blessings 13:39:51 INFO - Successfully installed blessings 13:39:51 INFO - Cleaning up... 13:39:51 INFO - Return code: 0 13:39:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:39:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:39:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:39:51 INFO - Reading from file tmpfile_stdout 13:39:51 INFO - Current package versions: 13:39:51 INFO - blessings == 1.6 13:39:51 INFO - blobuploader == 1.2.4 13:39:51 INFO - docopt == 0.6.1 13:39:51 INFO - functools32 == 3.2.3-2 13:39:51 INFO - jsonschema == 2.5.1 13:39:51 INFO - manifestparser == 1.1 13:39:51 INFO - mozInstall == 1.12 13:39:51 INFO - mozcrash == 1.0 13:39:51 INFO - mozdebug == 0.1 13:39:51 INFO - mozdevice == 0.49 13:39:51 INFO - mozfile == 1.2 13:39:51 INFO - mozhttpd == 0.7 13:39:51 INFO - mozinfo == 0.9 13:39:51 INFO - mozleak == 0.1 13:39:51 INFO - mozlog == 3.4 13:39:51 INFO - moznetwork == 0.27 13:39:51 INFO - mozprocess == 0.24 13:39:51 INFO - mozprofile == 0.28 13:39:51 INFO - mozrunner == 6.13 13:39:51 INFO - mozscreenshot == 0.1 13:39:51 INFO - mozsystemmonitor == 0.3 13:39:51 INFO - moztest == 0.8 13:39:51 INFO - mozversion == 1.4 13:39:51 INFO - psutil == 3.1.1 13:39:51 INFO - requests == 1.2.3 13:39:51 INFO - wsgiref == 0.1.2 13:39:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:39:51 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')]} 13:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:51 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')]} 13:39:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109656b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109659768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82ab587380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109434d30>, '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 0x10935bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109429be8>, '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.obVQmqNfyP/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.mza1N0Gm9m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 13:39:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:39:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:39:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obVQmqNfyP/Render', 13:39:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:39:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:39:52 INFO - 'HOME': '/Users/cltbld', 13:39:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:39:52 INFO - 'LOGNAME': 'cltbld', 13:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:52 INFO - 'MOZ_NO_REMOTE': '1', 13:39:52 INFO - 'NO_EM_RESTART': '1', 13:39:52 INFO - 'PAGER': '/bin/cat', 13:39:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:52 INFO - 'PWD': '/builds/slave/test', 13:39:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:39:52 INFO - 'SHELL': '/bin/bash', 13:39:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mza1N0Gm9m/Listeners', 13:39:52 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 13:39:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:39:52 INFO - 'USER': 'cltbld', 13:39:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:39:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:52 INFO - 'XPC_FLAGS': '0x0', 13:39:52 INFO - 'XPC_SERVICE_NAME': '0', 13:39:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:39:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:39:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:39:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:39:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:39:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:39:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:39:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:39:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:39:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:39:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:39:52 INFO - Cleaning up... 13:39:52 INFO - Return code: 0 13:39:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109656b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109659768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82ab587380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109434d30>, '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 0x10935bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109429be8>, '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.obVQmqNfyP/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.mza1N0Gm9m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 13:39:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:39:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:39:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obVQmqNfyP/Render', 13:39:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:39:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:39:52 INFO - 'HOME': '/Users/cltbld', 13:39:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:39:52 INFO - 'LOGNAME': 'cltbld', 13:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:52 INFO - 'MOZ_NO_REMOTE': '1', 13:39:52 INFO - 'NO_EM_RESTART': '1', 13:39:52 INFO - 'PAGER': '/bin/cat', 13:39:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:52 INFO - 'PWD': '/builds/slave/test', 13:39:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:39:52 INFO - 'SHELL': '/bin/bash', 13:39:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mza1N0Gm9m/Listeners', 13:39:52 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 13:39:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:39:52 INFO - 'USER': 'cltbld', 13:39:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:39:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:52 INFO - 'XPC_FLAGS': '0x0', 13:39:52 INFO - 'XPC_SERVICE_NAME': '0', 13:39:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:39:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:39:53 INFO - Cleaning up... 13:39:53 INFO - Return code: 0 13:39:53 INFO - Running post-action listener: _resource_record_post_action 13:39:53 INFO - Running post-action listener: _start_resource_monitoring 13:39:53 INFO - Starting resource monitoring. 13:39:53 INFO - [mozharness: 2017-03-03 21:39:53.238271Z] Finished create-virtualenv step (success) 13:39:53 INFO - [mozharness: 2017-03-03 21:39:53.239203Z] Running install step. 13:39:53 INFO - Running pre-action listener: _resource_record_pre_action 13:39:53 INFO - Running main action method: install 13:39:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:39:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:39:53 INFO - Reading from file tmpfile_stdout 13:39:53 INFO - Detecting whether we're running mozinstall >=1.0... 13:39:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:39:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:39:53 INFO - Reading from file tmpfile_stdout 13:39:53 INFO - Output received: 13:39:53 INFO - Usage: mozinstall [options] installer 13:39:53 INFO - Options: 13:39:53 INFO - -h, --help show this help message and exit 13:39:53 INFO - -d DEST, --destination=DEST 13:39:53 INFO - Directory to install application into. [default: 13:39:53 INFO - "/builds/slave/test"] 13:39:53 INFO - --app=APP Application being installed. [default: firefox] 13:39:53 INFO - mkdir: /builds/slave/test/build/application 13:39:53 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'] 13:39:53 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 13:40:13 INFO - Reading from file tmpfile_stdout 13:40:13 INFO - Output received: 13:40:13 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 13:40:13 INFO - Running post-action listener: _resource_record_post_action 13:40:13 INFO - [mozharness: 2017-03-03 21:40:13.565067Z] Finished install step (success) 13:40:13 INFO - [mozharness: 2017-03-03 21:40:13.565206Z] Running run-tests step. 13:40:13 INFO - Running pre-action listener: _resource_record_pre_action 13:40:13 INFO - Running main action method: run_tests 13:40:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:40:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:40:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:40:13 INFO - 2017-03-03 13:40:13.579 screenresolution[1622:7300] starting screenresolution argv=screenresolution get 13:40:13 INFO - 2017-03-03 13:40:13.581 screenresolution[1622:7300] Display 0: 1600x1200x32@60 13:40:13 INFO - 2017-03-03 13:40:13.588 screenresolution[1623:7303] starting screenresolution argv=screenresolution list 13:40:13 INFO - Available Modes on Display 0 13:40:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:40:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:40:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:40:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:40:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:40:13 INFO - Intel Iris: 13:40:13 INFO - Chipset Model: Intel Iris 13:40:13 INFO - Type: GPU 13:40:13 INFO - Bus: Built-In 13:40:13 INFO - VRAM (Dynamic, Max): 1536 MB 13:40:13 INFO - Vendor: Intel (0x8086) 13:40:13 INFO - Device ID: 0x0a2e 13:40:13 INFO - Revision ID: 0x0009 13:40:13 INFO - Displays: 13:40:13 INFO - Display: 13:40:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:40:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:40:13 INFO - Display Serial Number: 1600x1200 60 13:40:13 INFO - Main Display: Yes 13:40:13 INFO - Mirror: Off 13:40:13 INFO - Online: Yes 13:40:13 INFO - Rotation: Supported 13:40:13 INFO - Return code: 0 13:40:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:40:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:40:13 INFO - Python 2.7.3 13:40:13 INFO - Return code: 0 13:40:13 INFO - grabbing minidump binary from tooltool 13:40:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:40:13 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 0x109434d30>, '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 0x10935bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109429be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:40:13 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 13:40:13 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 13:40:13 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 13:40:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:40:13 INFO - Return code: 0 13:40:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:40:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:40:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:40:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:40:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:40:13 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/d5XDJ_MnSW6WSXn2C5vygQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0029', '--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 13:40:13 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/d5XDJ_MnSW6WSXn2C5vygQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0029 --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 13:40:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obVQmqNfyP/Render', 13:40:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:40:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:40:13 INFO - 'HOME': '/Users/cltbld', 13:40:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:40:13 INFO - 'LOGNAME': 'cltbld', 13:40:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:40:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:40:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:40:13 INFO - 'MOZ_NO_REMOTE': '1', 13:40:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:40:13 INFO - 'NO_EM_RESTART': '1', 13:40:13 INFO - 'PAGER': '/bin/cat', 13:40:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:40:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:40:13 INFO - 'PWD': '/builds/slave/test', 13:40:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:40:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:40:13 INFO - 'SHELL': '/bin/bash', 13:40:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mza1N0Gm9m/Listeners', 13:40:13 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 13:40:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:40:13 INFO - 'USER': 'cltbld', 13:40:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:40:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:40:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:40:13 INFO - 'XPC_FLAGS': '0x0', 13:40:13 INFO - 'XPC_SERVICE_NAME': '0', 13:40:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:40:13 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/d5XDJ_MnSW6WSXn2C5vygQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0029', '--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 13:40:14 INFO - mozversion application_buildid: 20170303121751 13:40:14 INFO - mozversion application_changeset: 9b921f750287da0bb330d799658da45f37ca14d7 13:40:14 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:40:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:40:14 INFO - mozversion application_name: Firefox 13:40:14 INFO - mozversion application_remotingname: firefox-dev 13:40:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:40:14 INFO - mozversion application_vendor: Mozilla 13:40:14 INFO - mozversion application_version: 53.0a2 13:40:14 INFO - mozversion platform_buildid: 20170303121751 13:40:14 INFO - mozversion platform_changeset: 9b921f750287da0bb330d799658da45f37ca14d7 13:40:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:40:14 INFO - mozversion platform_version: 53.0a2 13:40:14 INFO - using testdate: 1488577214 13:40:14 INFO - actual date: 1488577214 13:40:14 INFO - starting webserver on 'localhost:49244' 13:40:14 INFO - SUITE-START | Running 2 tests 13:40:14 INFO - TEST-START | dromaeo_css 13:40:14 INFO - operating with platform_type : mac_ 13:40:14 INFO - Initialising browser for dromaeo_css test... 13:40:14 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpZK2p6Z/profile http://localhost:49244/getInfo.html) 13:40:16 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 13:40:16 INFO - PROCESS | 1633 | colorDepth:24 13:40:16 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 13:40:16 INFO - PROCESS | 1633 | __metrics 13:40:16 INFO - PROCESS | 1633 | 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" 13:40:16 INFO - PROCESS | 1633 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:40:17 INFO - TEST-INFO | 1633: exit 0 13:40:17 INFO - Browser initialized. 13:40:17 INFO - Running cycle 1/1 for dromaeo_css test... 13:40:17 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpZK2p6Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:40:29 INFO - PROCESS | 1635 | RSS: Main: 213520384 13:40:29 INFO - PROCESS | 1635 | 13:43:33 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 13:43:35 INFO - PROCESS | 1635 | RSS: Main: 390553600 13:43:35 INFO - PROCESS | 1635 | 13:45:19 INFO - PROCESS | 1635 | ************************* 13:45:19 INFO - PROCESS | 1635 | A coding exception was thrown and uncaught in a Task. 13:45:19 INFO - PROCESS | 1635 | 13:45:19 ERROR - PROCESS | 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:45:19 INFO - PROCESS | 1635 | Full stack: 13:45:19 INFO - PROCESS | 1635 | ************************* 13:46:38 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 13:46:38 INFO - PROCESS | 1635 | RSS: Main: 350511104 13:46:38 INFO - PROCESS | 1635 | 13:49:41 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 13:49:41 INFO - PROCESS | 1635 | RSS: Main: 324128768 13:49:41 INFO - PROCESS | 1635 | 13:52:44 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 13:52:44 INFO - PROCESS | 1635 | RSS: Main: 318087168 13:52:44 INFO - PROCESS | 1635 | 13:55:48 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 13:55:48 INFO - PROCESS | 1635 | RSS: Main: 318062592 13:55:48 INFO - PROCESS | 1635 | 13:58:52 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 13:58:52 INFO - PROCESS | 1635 | RSS: Main: 475078656 13:58:52 INFO - PROCESS | 1635 | 13:58:52 INFO - PROCESS | 1635 | __start_tp_report 13:58:52 INFO - PROCESS | 1635 | _x_x_mozilla_page_load 13:58:52 INFO - PROCESS | 1635 | _x_x_mozilla_page_load_details 13:58:52 INFO - PROCESS | 1635 | |i|pagename|runs| 13:58:52 INFO - PROCESS | 1635 | |0;dojo.html;3370.966290337097;3390.066894796353;3403.778754380965;3413.7781044232124;3454.740894432918;5784.768609255625;5796.130580412941;5820.708964551772;5830.854228644281;5841.53267738581;5747.683877386742;5788.160716696077;5814.7092645367775;5852.151438041481;5869.559783016281;5304.734763261821;5309.230161626571;5337.653052551591;5338.62629615927;5429.104197807357;5187.93647302304;5189.325387699594;5217.087009773293;5233.607479439038;5292.947070529284;5310.7610157543;5335.359756829186;5340;5340.06548853951;5344.7862085516535;5301.496357845998;5305.336832895888;5307.389650190239;5322.707251101168;5332.68003919766;5172.405173405032;5276.3140791697215;5278.709670968095;5302.6023048271145;5335.413104558495;5824.30108386992;5831.970840145772;5839.620424672383;5853.209816674737;5866.941330586682;6195;6212.844678883019;6232.158658581079;6238.656873871935;6258.624482531062;6225.501959843202;6270.561060725751;6280.654563998978;6302.527310451735;6305.96847015762;5912.231409916726;5916.598430229085;5920.733566989496;5967.075103358986;5982.042873140276;6230.252369715663;6294.464970477561;6418.839529011812;6447.903281450735;6472.838179045561;6144.078388241799;6167.660778657128;6187.969060154671;6218.440340369389;6248.843778905563;6262.436380725757;6269.0909818076125;6272.435480806749;6276.592021518587;6280.780172693934;6256.43692067707;6268.780592679234;6268.937310626927;6270.9372906271265;6280.0893870389455;6112.144299798032;6168.784092556739;6208.286047104551;6225.657588832567;6265.310815810257;5081.644284900095;5081.8729531762;5083.87290317745;5102.872428189251;5125.026245013435;4441.422615060022;4460.04109116535;4467.329900514948;4501.369808226851;4510.774461276923;5776;5817.941820581825;5826.446487583673;5894.38108998549;5967.701614919237;6193.318734939153;6214.533909956771;6244.0321750128805;6252.155958945576;6267.9373206268265;5905.40945905406;5953.613015154001;5970.940290597038;5981.611195272293;5986.461218490357;4718.598919091915;5517.751701173457;5536.557075433956;5539.889202215933;5584.162375643686;6274.8431289216305;6285.874282514415;6375.458086062737;6429.164208652845;6443.838904027437;6178.443940045418;6244.344343843831;6260.40526150015;6260.499160067093;6262.812115636538;6321.715522801577;6329.841753956188;6374.107624932606;6382.489400848014;6387.361263873761;6238.500919926486;6247.812565623039;6263.812085637438;6266.624002559861;6283.497320214463;6282.403171698681;6289.182406287337;6289.874202515833;6290.654014029273;6294.433500984934;5412.242286080031;6151.66165860864;6162.845928851814;6194.256689197326;6221.688915554295;6228.626282423069;6244.781432649836;6247.0629405589525;6249.531285153541;6254.28075771274;6116.418940200674;6131.570790044654;6156.384361563808;6174.197354343906;6198;6110.327863934875;6146.955017646921;6159.384061593805;6183.443490085914;6264.874702505833;6117.785877494266;6123.130109042811;6137.9693101535995;6140.293866205265;6151.292601350902 13:58:52 INFO - PROCESS | 1635 | |1;ext.html;440.4428398076433;444.7309377826417;471.6816149099357;519.8076711616702;544.5072209650268;31018.68981310189;41200.793996030014;43041.35437968433;43062.56937430625;43398.13203735923;44198;44642.776786116025;44672;44803.655890323345;44830;9284.3500954933;9511.191548718367;9511.476868772215;9516.762080947998;9529.618815247382;8491.490510569385;8713.738587842376;11328.376939268337;11565.884341156607;11578.073754099652;11562.13284003699;11606.36165010924;11619.302841829474;11626.534938602446;11628;11545.191836571443;11605.303681779036;11637.301761894314;11637.47631356591;11638.418079096054;8435.11431299717;8640.65437382504;11171.83242251367;11409.345644881445;11424.02895753862;42184;42482.78758606218;42836.57163428388;42854.78572607148;42964.14071718548;3880.1463677990796;3969.5435024972207;3986.1629057897876;4014.2573623879675;4087.3664581989838;27475.725242747518;27687.169384918485;27748.722512775017;28238.858805706044;28324;2562.5131225067175;3207.903762887117;3345.6152542457444;3346.9497957530657;3347.280334728021;478054;487553;487878;490117;491192.0880791182;59130.70434647885;59529.70235148796;59552.70223648854;59669.40330596725;59692;62210.0668489973;62212;62222.755544889755;62292.44268893314;62357.68821155865;15870.44453444124;16110.113943732973;16128;16133.193340332937;16153.67692646164;11254.831177532344;12484.188527745668;12518.624441266777;12582.24506529611;12593.118481706193;15948.687440321088;16445.342186312413;18257.81742182561;18666.440006799545;18684.81315186858;6601.834954126185;7202.955571442217;7893.486923349964;8038.437309388287;8047.315978141806;823.5347028928636;873.9381651293709;899.1727610598265;901.4861528928448;918.6922381002439;30763.077107686804;30821.537676934862;30883.382332353227;31293.8435307822;31610.683893160774;789.4118881433369;1031.9587216511256;1058.687687132298;1113.2819331531116;1182.5033485935928;15486.380544778309;16012.119333436773;16043.876928615118;16145.838541614668;16228.107454089903;665885;672691;672872;673022;673636;63905.36094639087;64370;64389;64709.02936455957;64743.676281619235;1440.2150827798876;1441.2217402602478;1483.7106764181312;1484.7253258147277;1485.8588434098742;27785.44429111447;29010.12969610915;29750.553741694326;29912.85043574768;30343.544846826873;53958.46041539534;54298;54445;54531.454685452634;54596.72701636466;547545;549952;550819;550965;551401;27986.58020129659;28238.71761282361;28256.15231543057;28291.43417131687;28319.716802832532;48720.26919596138;48909;49219.753901230266;49256.26115608197;50393.74015649492;40036.999075023356;40429.79785101055;40527.79736101301;41545.79227103845;41858.1628367437;39500;39759;40531.59468405278;41193.38209926793;41306.380404293355;37756.811215943744;38140.42789358217;38219.61780382161;38363.61636383712;38661.80669096637;33155;33398.49902251517;35099;35249.471257930636;35262.64737352696;24351;25622.743772562037;25702.485950280516;26137.869310653325;26292.21123366302 13:58:52 INFO - PROCESS | 1635 | |2;jquery.html;371.90330514066335;382.95213098362706;392.41726036835314;403.66899142702977;423.6081624497341;12340;14856.702865942689;17537.386191483285;20471;20961.16155353784;17920.19359128839;18609.162587683553;21124.366269011916;21793.891030544826;21857.67213491795;4628.259478483444;5539.889202215963;5771.826845194651;5778.595498315099;5781.71091445426;4152.68854835887;4353.934690979638;4358.738475691453;4765.475797662254;4910.631702622318;6144.5698801083945;6419.8395040123905;6432.807015789511;6483;6499.1876015498065;6188.412100850434;6392.584482008701;6445.581037232565;6457.45111665509;6479.6760161991715;5438.592105592096;5643.520300774439;5650.886982260332;5654.547636189095;5656.688882111483;26322.47355052888;26551.203463896112;26577.73422265772;26823.92704291826;27027.72972270272;2726.3729342251195;2727.481778462086;2727.836329820217;2732.562789953598;2739.8767055482353;14861.628459288604;15314.27662704246;15441.459548915846;15741.449049283334;16319.347226110942;1771.3268957796083;1777.4934143769094;1780.2967827707982;1782.6630027479391;1787.767590213277;126240.36879815542;126450;134635;146797.2660136703;153068;11472.4837382318;11592.246503977383;11705.297682139098;11732.765344693058;11937;15525.068495890282;15591.142487163315;15611.921940390226;15612.3755049799;15616.375344986074;8472.57637118154;8747.518886461306;8770.693025744196;8899.110088991049;8911.643534258557;8618.655253789779;8669.653213871374;8670.089640587648;8830.955845220862;8832.160944710242;4590.449146102489;4668.5564871337165;4676.134915040729;4684.718916864999;4701.553352431513;1754.1353598263065;1856.5729882127187;1999.8200161985492;2039.826614737764;2041.7958204179463;1021.4841505040056;1025.6564051042985;1032.1381646325403;1034.99482502587;1068.5672302717412;16477.423290184786;21964.89017554934;22089.620804330203;22119.44701382446;22183.32161327823;1041.13065590233;1043.874735031801;1053.641761800976;1077.369738702852;1078.5308390850005;11203.439828008566;11533.826992595117;11570.305781653127;11571.884281157249;11602;767474;774029.1298543471;795054;803984;806855;124456;125099;135355;142160;159916;995.4574756757585;1024.4058446101392;1050.8003479338902;1053.7365658585354;1054.1514081164737;18898.433047008613;19367.709484358027;19561.413157605293;19745.308914187935;19930.00349982466;41678.58321416747;54363.72818135884;55469.72265138649;57148.71425642845;57455.42544574501;81116.59441702753;81299.5935020321;82264.47545385061;84322;85710.57144714237;7248.782536523912;7473.364763994904;7626.771196864103;8005.559694216641;8549.230569248797;9215.940166880626;12191;12441.37793110359;13204.471821127046;13482.595522134352;10974.615888443866;11090.057345125755;11108.666739997812;11307.717307067389;11494.19540632181;10773.299735517166;11155.665330040112;11236.606718764804;11631.88368116308;11743.823842642538;10435.956404359504;11053.778924421627;11402.20184587071;11893.345865977455;12011.879881201075;6697.196336439659;7105.640451795511;7495.938616880401;7610.086789585285;7622.2758837910305;9599.760005999626;11157.88842111601;11284.661460156209;11519.424028798694;11656.941715291368 13:58:52 INFO - PROCESS | 1635 | |3;mootools.html;1435.1604311477786;1454.716330315589;1466.963325916852;1472.6686495538506;1479.0977503722731;8065.596720163998;8499;8502.319814414848;8512.616932238048;8518.148185181479;7430.479866409353;7658.693652253917;7676.270754278348;8030;8311.002679678431;2313.895874685639;2347.929562113139;2355.6819829322994;2355.7644235576477;2355.8115350771895;2348.3307257431634;2364.7280562735245;2383.2373640435067;2384.558856611524;2385.33210701004;2314.5949458844634;2326.127702111708;2338.707661542307;2356.705411823522;2360.5160942006846;2305.2853615379204;2306.8615883047073;2333.230034088747;2334.766523347652;2337.6493525971155;2315.6642286868478;2376.0614557249964;2383.0348708772804;2383.785459308653;2386.5823480890776;8431.957840210822;8472.957635211846;8490.957545212234;8495.575221238974;8499.235068843835;5070.492950704936;5132.640715149941;5231.372235331746;5237.528622424;5247.2653828464045;3273.1817045738567;3339.8163101029436;3475.391806433864;3522.3835828730125;3552.2540266544056;1212.672578403826;1231.2489381477292;1717.3559915031863;1759.375421725282;1836.834684878354;10845.891541084646;10935.726606834813;10937.507812148473;10950.39772812495;10953.945230273797;4614.676972611885;4766.332713420124;4801.01579176268;4802.759862006886;4825.30033145192;8702.390057839193;8784.077671844492;8786.297096232285;8797;8797.252233560092;5148.073346797612;5157.716325602053;5159.922601160985;5162.432132465426;5171.482851714798;4731.455882573479;4732.550407711262;4790.736509491941;4862.294967229732;4865.5620994109995;3072.7234548890706;3184.2198661328125;3737.2525494900583;3795.3737633290198;3821.3503704370323;1151.1884121694352;1156.7570810129967;1159.3217967488945;1166.731651720109;1167.0022131077976;790.3361176611559;867.9931279715499;911.5761171055359;919.4988731141544;935.4013431403907;5750.108733146369;5876.9118463223085;5903.203067585907;6036.124761909498;6182.845428864314;979.4906648542718;987.2102318145598;1005.2058873490007;1010.0808264479289;1061.570064124031;3761.9059523511582;3786.905327366838;3901.9609803902167;3911.6870650347905;3946.743461674982;9925.15636170919;10139.493025348704;10257.17942564593;10283.53724082418;10293.845592316122;9554.426734395958;10055.346402483961;10070.144037756727;10136.442495662663;10157.9492102539;7794;8021.077576078709;8025.31784798287;8043.276105150565;8050.5169689818795;5508.20131080999;5587.3015873015875;5607.831765047055;5728.1694154348215;5831.125331200354;9464.006279340845;9468.337216394786;9475.289353298393;9481.95259023728;9565.378250413702;8598.871016934625;8922;9090.636374545209;9537.952310238405;9549.427034377959;6753.628550429577;7086.610236437045;7264.745733899288;7293.343599076109;7332.376747976482;7834.804129896798;7991.560464174526;8062.032556093071;8102.513849169069;8109.189081091844;7084.22073571917;7169.928300716926;7186.173590037212;7232.349088581843;7332.413406927326;7051.612161331176;7052.506324557232;7082.645867706698;7105;7124.180719217149;6148.661823599566;6401.7119229633845;6425;6551.377619126175;6556.704948277244;5030.496950304941;5034.270030845433;5037.143685573388;5121.692698438105;5156;4964.92120994382;5027.446980832178;5076.517730815566;5214.921776173284;5256.421793602624 13:58:52 INFO - PROCESS | 1635 | |4;prototype.html;288.65505720663805;352.3587071529816;363.56190790097935;363.6999475432768;373.6226411324561;4536.160810250106;5295.596666883279;5325.973370133144;5365.302510673612;5372.650777699447;4628.490866004745;4931.679440836352;4967.453580106186;5293.735313234342;5340.332458442695;3803.2013277211818;3900.5709371969133;3926.666233370167;4056.8640780581336;4116.732412393199;4151.792410379484;4168.228877657628;4170.52039015514;4173.433338496818;4240.646441225119;3526.5944416392185;3799.6580307772297;4113.56807535209;4116.341385378325;4144.979275103636;3762.418921831818;3935.763854168759;4122.196171746511;4178.435911151986;4190.596150289642;3213.373392188524;3661.6887564557046;3671.559412870446;3673.9632603674154;3685.4287585424304;3994.900127496807;4375.309184851325;4787.042591481682;4968.627352948543;5156.561692256163;3967.563568007517;4058.797060146981;4530.297803840377;4776.498467660915;4782.187028205213;5617.297837770278;5619.185218143387;5621.8594535136945;5630.634008789416;5694.5159661428825;3334.8832790852202;4103;4109.794510274504;4116.444280022189;4121.381792731115;4789.137955168103;5170.508801663836;5641.787015791583;5934.6142500737315;5969.671668058255;3385.8476368563474;3553.680168784822;4123.422720819088;4158.459400277945;4191.015111448807;3797.6771974381936;4232.153569286155;4254.468191476066;4286.678499112579;4302.26861433557;4857.53853383935;4863;4880.853574392774;4885.2427873679635;4887.29134275528;4686.929696054562;5273.365256770413;5374.946250537523;5614.803481878114;5659.660420374791;1381.2127087559995;1389.805427240187;1390.0261628487572;1398.8601139886134;1400.250865786799;889.8343170446735;900.4736970834504;928.3832154359169;980.4999450280409;988.2933702402672;5040.344755181876;5178.508041736029;5178.508041736029;5265.4997775211295;5336.038498633218;4888.804447822047;4956.578690811321;5780.71096445176;5808.332041815245;5841.299044114733;4771.9522804772205;5033.062271025681;5330.040592693274;5353.544948679328;5364.275822763955;2683.6511253536914;2787.804853660224;2899.289674029876;2924.947019073132;2932.4574953633646;4919.926201106986;5163.974180129076;5194.792208311701;5543.750531226105;5779.739911703983;4735.692180008288;5084.8220312288895;5269.631125821155;5419.349678038582;5703.600747947687;5760.798372057042;5761.3950535194035;5783.652980821164;5802.243934131254;5817.5055120313555;5153.6907785532985;5519.779208831602;5549.500544950974;5567.610267281251;5580.488780048913;4596.4254468191475;4815.422149341961;4896.6572339935865;5450.754716037709;5519.69641669712;4983.455128910049;5186.948130518646;5511.614187006871;5773.018586840331;5802.6808525531505;3158;3571.821079239427;3667.6882464990776;3702.851885924533;3711.628837116267;4714.434267887876;4965.8013679452415;5083.46623604531;5412.648177868426;5607.859803504945;4680.882977925443;5338.225957236256;5355.491228333302;5393.244945707683;5412.648177868426;4845.103655823684;4972.204447288416;5146.716930568855;5343.061316275955;5364.409914909279;4425.74287113568;4498.200719712141;5239.869003274948;5253.054450199001;5256.684598924076;4373.825046998085;4996.450390457119;5034.130545588979;5349.491798279158;5452.209429632601;4712.293156026486;4746.833860814855;5264.289320941777;5344.625876188629;5461.34463864323 13:58:52 INFO - PROCESS | 1635 | |5;yui.html;703.3423748794874;744.4081954845897;748.1060133140899;805.532790981231;827.0695467598952;12985.935070324635;14823.481178158767;15483.612909677264;16400.917995410036;17215.741763873553;16076.115813630246;16192.75710864338;16400.507984760447;16402;16516.66966660669;842.8946381702272;860.4149178558578;862.4566523090444;864.779481232288;864.9697260595881;680.4318394140898;700.1178515071022;701.484408959417;867.6399294292861;869.2654706772798;879.5953861223845;904.0417157812707;908.9454632722058;911.098012967161;911.7583840282331;891.1801142948503;902.0753727429437;903.2006674093475;905.6830109461702;905.8233644439337;523.450377104043;539.2989114151587;671.717878491035;672.1933679584519;672.3310306245318;14624.926875365662;15257;15271.236438178046;15299.770503442458;15494.612634684223;13874.653133671638;13938;13939.16365018102;13987.65030874226;13996.370163342674;12218.389080545938;12404.875951240463;12424.689382765504;12771.680707982281;12906.612801615873;4436.212683973247;4574.634029277683;4678.391809064834;4679.227927391977;4717.103750287434;89805.55097224537;105649.47175264152;109796;110072.4496377521;118231.40884295524;10771.89228107709;10927.344359338465;11204;11298.830517542243;11375.488103035383;23053.423664408525;23107.306780796604;23108.07567697307;23122.19072332494;23126;6580.703868325937;7472.738454154079;7717.807054823562;7866.72466463671;7936.206379362133;4059.0258337999257;4187.476565429321;4275.572442755762;4332.263515202423;4367.519572846984;3327.101682545699;3369.292448585775;3499.755017148826;3501.649835016529;3503.3518799022263;649.5193556768052;658.924223714279;659.5020759326677;659.8518577674811;660.2671035150978;508.5575549272157;521.1817446608787;548.8627843039241;553.1067326268048;565.4006752842;7974.960125199337;9143.451392916313;9440.57517411718;9580.904190958141;9639.228861691048;632.1308201223318;649.5355820588302;661.9669016549153;665.7936039827669;678.6403206300669;4389.561043895585;4662.766861656972;4667.719936803803;4692.202325604587;4745.311929770164;108395;110498;110573;111569;111886.76226475424;67143;96337.51831240799;97428;98530.5073474628;98917.01082989221;65556;77855.61072194716;78269.60865195752;79663.40673186503;80644;8949.59726812308;9092.863607045767;9160.954195228982;9199.477607122828;9239.39943903644;50598;52971.73514132405;53391.39825805232;53488.1976770341;54434.18348724851;70546.64726676539;70963.64518177582;72372.63813680898;72413.82758517253;72470;11364.602238921598;11599;11750.412479376168;11776.70558236051;11947.522099115939;11463.312201267618;11674.357910314675;11844.538567082278;12172.878271217174;12338.81491777642;10780.137588993019;11594.594189203337;11599.594014209462;11666.70833229176;11704.239224450383;10685.635092913253;11491.253068550517;11511;11558.364289964133;11724.70688232767;10635.042846143884;11310.830337545109;11345.943270283926;11373.31760094397;11472.483738231967;9073.863892041756;9473.905260947578;9541.856872147062;9542.379745316532;9570.760730981781;8095.2714255717265;8787.736367908972;9183.173514383738;9222.861657075015;9223.58493867764 13:58:52 INFO - PROCESS | 1635 | __end_tp_report 13:58:52 INFO - PROCESS | 1635 | __start_cc_report 13:58:52 INFO - PROCESS | 1635 | _x_x_mozilla_cycle_collect,1791 13:58:52 INFO - PROCESS | 1635 | __end_cc_report 13:58:52 INFO - PROCESS | 1635 | __startTimestamp1488578332383__endTimestamp 13:58:52 INFO - PROCESS | 1635 | 13:58:52 INFO - PROCESS | 1635 | ------- Summary: start ------- 13:58:52 INFO - PROCESS | 1635 | Number of tests: 6 13:58:52 INFO - PROCESS | 1635 | 13:58:52 INFO - PROCESS | 1635 | [#0] dojo.html Cycles:165 Average:5829.23 Median:6137.97 stddev:636.26 (10.4%) stddev-sans-first:608.29 13:58:52 INFO - PROCESS | 1635 | Values: 3371.0 3390.1 3403.8 3413.8 3454.7 5784.8 5796.1 5820.7 5830.9 5841.5 5747.7 5788.2 5814.7 5852.2 5869.6 5304.7 5309.2 5337.7 5338.6 5429.1 5187.9 5189.3 5217.1 5233.6 5292.9 5310.8 5335.4 5340.0 5340.1 5344.8 5301.5 5305.3 5307.4 5322.7 5332.7 5172.4 5276.3 5278.7 5302.6 5335.4 5824.3 5832.0 5839.6 5853.2 5866.9 6195.0 6212.8 6232.2 6238.7 6258.6 6225.5 6270.6 6280.7 6302.5 6306.0 5912.2 5916.6 5920.7 5967.1 5982.0 6230.3 6294.5 6418.8 6447.9 6472.8 6144.1 6167.7 6188.0 6218.4 6248.8 6262.4 6269.1 6272.4 6276.6 6280.8 6256.4 6268.8 6268.9 6270.9 6280.1 6112.1 6168.8 6208.3 6225.7 6265.3 5081.6 5081.9 5083.9 5102.9 5125.0 4441.4 4460.0 4467.3 4501.4 4510.8 5776.0 5817.9 5826.4 5894.4 5967.7 6193.3 6214.5 6244.0 6252.2 6267.9 5905.4 5953.6 5970.9 5981.6 5986.5 4718.6 5517.8 5536.6 5539.9 5584.2 6274.8 6285.9 6375.5 6429.2 6443.8 6178.4 6244.3 6260.4 6260.5 6262.8 6321.7 6329.8 6374.1 6382.5 6387.4 6238.5 6247.8 6263.8 6266.6 6283.5 6282.4 6289.2 6289.9 6290.7 6294.4 5412.2 6151.7 6162.8 6194.3 6221.7 6228.6 6244.8 6247.1 6249.5 6254.3 6116.4 6131.6 6156.4 6174.2 6198.0 6110.3 6147.0 6159.4 6183.4 6264.9 6117.8 6123.1 6138.0 6140.3 6151.3 13:58:52 INFO - PROCESS | 1635 | 13:58:52 INFO - PROCESS | 1635 | [#1] ext.html Cycles:180 Average:71004.33 Median:22011.58 stddev:153493.84 (697.3%) stddev-sans-first:153832.99 13:58:52 INFO - PROCESS | 1635 | Values: 440.4 444.7 471.7 519.8 544.5 31018.7 41200.8 43041.4 43062.6 43398.1 44198.0 44642.8 44672.0 44803.7 44830.0 9284.4 9511.2 9511.5 9516.8 9529.6 8491.5 8713.7 11328.4 11565.9 11578.1 11562.1 11606.4 11619.3 11626.5 11628.0 11545.2 11605.3 11637.3 11637.5 11638.4 8435.1 8640.7 11171.8 11409.3 11424.0 42184.0 42482.8 42836.6 42854.8 42964.1 3880.1 3969.5 3986.2 4014.3 4087.4 27475.7 27687.2 27748.7 28238.9 28324.0 2562.5 3207.9 3345.6 3346.9 3347.3 478054.0 487553.0 487878.0 490117.0 491192.1 59130.7 59529.7 59552.7 59669.4 59692.0 62210.1 62212.0 62222.8 62292.4 62357.7 15870.4 16110.1 16128.0 16133.2 16153.7 11254.8 12484.2 12518.6 12582.2 12593.1 15948.7 16445.3 18257.8 18666.4 18684.8 6601.8 7203.0 7893.5 8038.4 8047.3 823.5 873.9 899.2 901.5 918.7 30763.1 30821.5 30883.4 31293.8 31610.7 789.4 1032.0 1058.7 1113.3 1182.5 15486.4 16012.1 16043.9 16145.8 16228.1 665885.0 672691.0 672872.0 673022.0 673636.0 63905.4 64370.0 64389.0 64709.0 64743.7 1440.2 1441.2 1483.7 1484.7 1485.9 27785.4 29010.1 29750.6 29912.9 30343.5 53958.5 54298.0 54445.0 54531.5 54596.7 547545.0 549952.0 550819.0 550965.0 551401.0 27986.6 28238.7 28256.2 28291.4 28319.7 48720.3 48909.0 49219.8 49256.3 50393.7 40037.0 40429.8 40527.8 41545.8 41858.2 39500.0 39759.0 40531.6 41193.4 41306.4 37756.8 38140.4 38219.6 38363.6 38661.8 33155.0 33398.5 35099.0 35249.5 35262.6 24351.0 25622.7 25702.5 26137.9 26292.2 13:58:52 INFO - PROCESS | 1635 | 13:58:52 INFO - PROCESS | 1635 | [#2] jquery.html Cycles:180 Average:41445.68 Median:21459.13 stddev:130921.99 (610.1%) stddev-sans-first:131252.93 13:58:52 INFO - PROCESS | 1635 | Values: 371.9 383.0 392.4 403.7 423.6 12340.0 14856.7 17537.4 20471.0 20961.2 17920.2 18609.2 21124.4 21793.9 21857.7 4628.3 5539.9 5771.8 5778.6 5781.7 4152.7 4353.9 4358.7 4765.5 4910.6 6144.6 6419.8 6432.8 6483.0 6499.2 6188.4 6392.6 6445.6 6457.5 6479.7 5438.6 5643.5 5650.9 5654.5 5656.7 26322.5 26551.2 26577.7 26823.9 27027.7 2726.4 2727.5 2727.8 2732.6 2739.9 14861.6 15314.3 15441.5 15741.4 16319.3 1771.3 1777.5 1780.3 1782.7 1787.8 126240.4 126450.0 134635.0 146797.3 153068.0 11472.5 11592.2 11705.3 11732.8 11937.0 15525.1 15591.1 15611.9 15612.4 15616.4 8472.6 8747.5 8770.7 8899.1 8911.6 8618.7 8669.7 8670.1 8831.0 8832.2 4590.4 4668.6 4676.1 4684.7 4701.6 1754.1 1856.6 1999.8 2039.8 2041.8 1021.5 1025.7 1032.1 1035.0 1068.6 16477.4 21964.9 22089.6 22119.4 22183.3 1041.1 1043.9 1053.6 1077.4 1078.5 11203.4 11533.8 11570.3 11571.9 11602.0 767474.0 774029.1 795054.0 803984.0 806855.0 124456.0 125099.0 135355.0 142160.0 159916.0 995.5 1024.4 1050.8 1053.7 1054.2 18898.4 19367.7 19561.4 19745.3 19930.0 41678.6 54363.7 55469.7 57148.7 57455.4 81116.6 81299.6 82264.5 84322.0 85710.6 7248.8 7473.4 7626.8 8005.6 8549.2 9215.9 12191.0 12441.4 13204.5 13482.6 10974.6 11090.1 11108.7 11307.7 11494.2 10773.3 11155.7 11236.6 11631.9 11743.8 10436.0 11053.8 11402.2 11893.3 12011.9 6697.2 7105.6 7495.9 7610.1 7622.3 9599.8 11157.9 11284.7 11519.4 11656.9 13:58:52 INFO - PROCESS | 1635 | 13:58:52 INFO - PROCESS | 1635 | [#3] mootools.html Cycles:180 Average:5483.33 Median:5152.04 stddev:2946.78 (57.2%) stddev-sans-first:2939.34 13:58:52 INFO - PROCESS | 1635 | Values: 1435.2 1454.7 1467.0 1472.7 1479.1 8065.6 8499.0 8502.3 8512.6 8518.1 7430.5 7658.7 7676.3 8030.0 8311.0 2313.9 2347.9 2355.7 2355.8 2355.8 2348.3 2364.7 2383.2 2384.6 2385.3 2314.6 2326.1 2338.7 2356.7 2360.5 2305.3 2306.9 2333.2 2334.8 2337.6 2315.7 2376.1 2383.0 2383.8 2386.6 8432.0 8473.0 8491.0 8495.6 8499.2 5070.5 5132.6 5231.4 5237.5 5247.3 3273.2 3339.8 3475.4 3522.4 3552.3 1212.7 1231.2 1717.4 1759.4 1836.8 10845.9 10935.7 10937.5 10950.4 10953.9 4614.7 4766.3 4801.0 4802.8 4825.3 8702.4 8784.1 8786.3 8797.0 8797.3 5148.1 5157.7 5159.9 5162.4 5171.5 4731.5 4732.6 4790.7 4862.3 4865.6 3072.7 3184.2 3737.3 3795.4 3821.4 1151.2 1156.8 1159.3 1166.7 1167.0 790.3 868.0 911.6 919.5 935.4 5750.1 5876.9 5903.2 6036.1 6182.8 979.5 987.2 1005.2 1010.1 1061.6 3761.9 3786.9 3902.0 3911.7 3946.7 9925.2 10139.5 10257.2 10283.5 10293.8 9554.4 10055.3 10070.1 10136.4 10157.9 7794.0 8021.1 8025.3 8043.3 8050.5 5508.2 5587.3 5607.8 5728.2 5831.1 9464.0 9468.3 9475.3 9482.0 9565.4 8598.9 8922.0 9090.6 9538.0 9549.4 6753.6 7086.6 7264.7 7293.3 7332.4 7834.8 7991.6 8062.0 8102.5 8109.2 7084.2 7169.9 7186.2 7232.3 7332.4 7051.6 7052.5 7082.6 7105.0 7124.2 6148.7 6401.7 6425.0 6551.4 6556.7 5030.5 5034.3 5037.1 5121.7 5156.0 4964.9 5027.4 5076.5 5214.9 5256.4 13:58:52 INFO - PROCESS | 1635 | 13:58:52 INFO - PROCESS | 1635 | [#4] prototype.html Cycles:180 Average:4449.75 Median:4908.29 stddev:1307.74 (26.6%) stddev-sans-first:1273.57 13:58:52 INFO - PROCESS | 1635 | Values: 288.7 352.4 363.6 363.7 373.6 4536.2 5295.6 5326.0 5365.3 5372.7 4628.5 4931.7 4967.5 5293.7 5340.3 3803.2 3900.6 3926.7 4056.9 4116.7 4151.8 4168.2 4170.5 4173.4 4240.6 3526.6 3799.7 4113.6 4116.3 4145.0 3762.4 3935.8 4122.2 4178.4 4190.6 3213.4 3661.7 3671.6 3674.0 3685.4 3994.9 4375.3 4787.0 4968.6 5156.6 3967.6 4058.8 4530.3 4776.5 4782.2 5617.3 5619.2 5621.9 5630.6 5694.5 3334.9 4103.0 4109.8 4116.4 4121.4 4789.1 5170.5 5641.8 5934.6 5969.7 3385.8 3553.7 4123.4 4158.5 4191.0 3797.7 4232.2 4254.5 4286.7 4302.3 4857.5 4863.0 4880.9 4885.2 4887.3 4686.9 5273.4 5374.9 5614.8 5659.7 1381.2 1389.8 1390.0 1398.9 1400.3 889.8 900.5 928.4 980.5 988.3 5040.3 5178.5 5178.5 5265.5 5336.0 4888.8 4956.6 5780.7 5808.3 5841.3 4772.0 5033.1 5330.0 5353.5 5364.3 2683.7 2787.8 2899.3 2924.9 2932.5 4919.9 5164.0 5194.8 5543.8 5779.7 4735.7 5084.8 5269.6 5419.3 5703.6 5760.8 5761.4 5783.7 5802.2 5817.5 5153.7 5519.8 5549.5 5567.6 5580.5 4596.4 4815.4 4896.7 5450.8 5519.7 4983.5 5186.9 5511.6 5773.0 5802.7 3158.0 3571.8 3667.7 3702.9 3711.6 4714.4 4965.8 5083.5 5412.6 5607.9 4680.9 5338.2 5355.5 5393.2 5412.6 4845.1 4972.2 5146.7 5343.1 5364.4 4425.7 4498.2 5239.9 5253.1 5256.7 4373.8 4996.5 5034.1 5349.5 5452.2 4712.3 4746.8 5264.3 5344.6 5461.3 13:58:52 INFO - PROCESS | 1635 | 13:58:52 INFO - PROCESS | 1635 | [#5] yui.html Cycles:180 Average:20641.97 Median:514.87 stddev:30648.26 (5952.6%) stddev-sans-first:30697.67 13:58:52 INFO - PROCESS | 1635 | Values: 703.3 744.4 748.1 805.5 827.1 12985.9 14823.5 15483.6 16400.9 17215.7 16076.1 16192.8 16400.5 16402.0 16516.7 842.9 860.4 862.5 864.8 865.0 680.4 700.1 701.5 867.6 869.3 879.6 904.0 908.9 911.1 911.8 891.2 902.1 903.2 905.7 905.8 523.5 539.3 671.7 672.2 672.3 14624.9 15257.0 15271.2 15299.8 15494.6 13874.7 13938.0 13939.2 13987.7 13996.4 12218.4 12404.9 12424.7 12771.7 12906.6 4436.2 4574.6 4678.4 4679.2 4717.1 89805.6 105649.5 109796.0 110072.4 118231.4 10771.9 10927.3 11204.0 11298.8 11375.5 23053.4 23107.3 23108.1 23122.2 23126.0 6580.7 7472.7 7717.8 7866.7 7936.2 4059.0 4187.5 4275.6 4332.3 4367.5 3327.1 3369.3 3499.8 3501.6 3503.4 649.5 658.9 659.5 659.9 660.3 508.6 521.2 548.9 553.1 565.4 7975.0 9143.5 9440.6 9580.9 9639.2 632.1 649.5 662.0 665.8 678.6 4389.6 4662.8 4667.7 4692.2 4745.3 108395.0 110498.0 110573.0 111569.0 111886.8 67143.0 96337.5 97428.0 98530.5 98917.0 65556.0 77855.6 78269.6 79663.4 80644.0 8949.6 9092.9 9161.0 9199.5 9239.4 50598.0 52971.7 53391.4 53488.2 54434.2 70546.6 70963.6 72372.6 72413.8 72470.0 11364.6 11599.0 11750.4 11776.7 11947.5 11463.3 11674.4 11844.5 12172.9 12338.8 10780.1 11594.6 11599.6 11666.7 11704.2 10685.6 11491.3 11511.0 11558.4 11724.7 10635.0 11310.8 11345.9 11373.3 11472.5 9073.9 9473.9 9541.9 9542.4 9570.8 8095.3 8787.7 9183.2 9222.9 9223.6 13:58:52 INFO - PROCESS | 1635 | -------- Summary: end -------- 13:58:52 INFO - PROCESS | 1635 | 13:58:52 INFO - TEST-INFO | 1635: exit 0 13:58:53 INFO - TEST-OK | dromaeo_css | took 1118852ms 13:58:53 INFO - TEST-START | kraken 13:58:53 INFO - operating with platform_type : mac_ 13:58:53 INFO - Initialising browser for kraken test... 13:58:53 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpaPN1oB/profile http://localhost:49244/getInfo.html) 13:58:55 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 13:58:55 INFO - PROCESS | 1645 | colorDepth:24 13:58:55 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 13:58:55 INFO - PROCESS | 1645 | __metrics 13:58:55 INFO - PROCESS | 1645 | 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" 13:58:55 INFO - PROCESS | 1645 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:58:56 INFO - TEST-INFO | 1645: exit 0 13:58:56 INFO - Browser initialized. 13:58:56 INFO - Running cycle 1/1 for kraken test... 13:58:56 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpaPN1oB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:59:08 INFO - PROCESS | 1646 | RSS: Main: 212975616 13:59:08 INFO - PROCESS | 1646 | 13:59:10 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 13:59:11 INFO - PROCESS | 1646 | RSS: Main: 265797632 13:59:11 INFO - PROCESS | 1646 | 13:59:14 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 13:59:15 INFO - PROCESS | 1646 | RSS: Main: 274874368 13:59:15 INFO - PROCESS | 1646 | 13:59:18 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 13:59:18 INFO - PROCESS | 1646 | RSS: Main: 373567488 13:59:18 INFO - PROCESS | 1646 | 13:59:20 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 13:59:21 INFO - PROCESS | 1646 | RSS: Main: 276914176 13:59:21 INFO - PROCESS | 1646 | 13:59:23 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:59:24 INFO - PROCESS | 1646 | RSS: Main: 278704128 13:59:24 INFO - PROCESS | 1646 | 13:59:26 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 13:59:27 INFO - PROCESS | 1646 | RSS: Main: 319979520 13:59:27 INFO - PROCESS | 1646 | 13:59:30 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 13:59:31 INFO - PROCESS | 1646 | RSS: Main: 320192512 13:59:31 INFO - PROCESS | 1646 | 13:59:33 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 13:59:34 INFO - PROCESS | 1646 | RSS: Main: 317751296 13:59:34 INFO - PROCESS | 1646 | 13:59:36 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:59:36 INFO - PROCESS | 1646 | RSS: Main: 295628800 13:59:36 INFO - PROCESS | 1646 | 13:59:38 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:59:39 INFO - PROCESS | 1646 | RSS: Main: 298115072 13:59:39 INFO - PROCESS | 1646 | 13:59:41 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:59:42 INFO - PROCESS | 1646 | RSS: Main: 307744768 13:59:42 INFO - PROCESS | 1646 | 13:59:44 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:59:45 INFO - PROCESS | 1646 | RSS: Main: 318070784 13:59:45 INFO - PROCESS | 1646 | 13:59:48 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:59:49 INFO - PROCESS | 1646 | RSS: Main: 312152064 13:59:49 INFO - PROCESS | 1646 | 13:59:50 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 13:59:51 INFO - PROCESS | 1646 | RSS: Main: 356155392 13:59:51 INFO - PROCESS | 1646 | 13:59:51 INFO - PROCESS | 1646 | __start_tp_report 13:59:51 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 13:59:51 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 13:59:51 INFO - PROCESS | 1646 | |i|pagename|runs| 13:59:51 INFO - PROCESS | 1646 | |0;ai-astar;113;114;114;114;116;113;111;112;113;114 13:59:51 INFO - PROCESS | 1646 | |1;audio-beat-detection;136;107;108;143;107;108;133;133;129;105 13:59:51 INFO - PROCESS | 1646 | |2;audio-dft;185;184;184;186;184;182;186;184;184;184 13:59:51 INFO - PROCESS | 1646 | |3;audio-fft;80;59;59;90;62;64;78;81;86;58 13:59:51 INFO - PROCESS | 1646 | |4;audio-oscillator;88;70;87;97;97;100;82;67;68;82 13:59:51 INFO - PROCESS | 1646 | |5;imaging-gaussian-blur;87;83;86;84;86;84;87;84;86;83 13:59:51 INFO - PROCESS | 1646 | |6;imaging-darkroom;93;94;93;97;93;92;93;97;93;94 13:59:51 INFO - PROCESS | 1646 | |7;imaging-desaturate;82;86;85;88;85;85;86;85;85;104 13:59:51 INFO - PROCESS | 1646 | |8;json-parse-financial;54;54;53;54;56;57;58;57;56;54 13:59:51 INFO - PROCESS | 1646 | |9;json-stringify-tinderbox;64;67;81;74;73;68;69;69;68;69 13:59:51 INFO - PROCESS | 1646 | |10;stanford-crypto-aes;86;83;84;84;85;82;82;85;90;90 13:59:51 INFO - PROCESS | 1646 | |11;stanford-crypto-ccm;138;137;136;133;136;137;135;137;203;181 13:59:51 INFO - PROCESS | 1646 | |12;stanford-crypto-pbkdf2;165;165;168;167;168;165;165;167;165;168 13:59:51 INFO - PROCESS | 1646 | |13;stanford-crypto-sha256-iterative;64;66;65;65;65;65;66;66;66;64 13:59:51 INFO - PROCESS | 1646 | __end_tp_report 13:59:51 INFO - PROCESS | 1646 | __start_cc_report 13:59:51 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,2125 13:59:51 INFO - PROCESS | 1646 | __end_cc_report 13:59:51 INFO - PROCESS | 1646 | __startTimestamp1488578391057__endTimestamp 13:59:51 INFO - PROCESS | 1646 | 13:59:51 INFO - PROCESS | 1646 | ------- Summary: start ------- 13:59:51 INFO - PROCESS | 1646 | Number of tests: 14 13:59:51 INFO - PROCESS | 1646 | 13:59:51 INFO - PROCESS | 1646 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:1.35 (1.2%) stddev-sans-first:1.42 13:59:51 INFO - PROCESS | 1646 | Values: 113.0 114.0 114.0 114.0 116.0 113.0 111.0 112.0 113.0 114.0 13:59:51 INFO - PROCESS | 1646 | 13:59:51 INFO - PROCESS | 1646 | [#1] audio-beat-detection Cycles:10 Average:120.90 Median:131.00 stddev:15.08 (11.5%) stddev-sans-first:14.97 13:59:51 INFO - PROCESS | 1646 | Values: 136.0 107.0 108.0 143.0 107.0 108.0 133.0 133.0 129.0 105.0 13:59:51 INFO - PROCESS | 1646 | 13:59:51 INFO - PROCESS | 1646 | [#2] audio-dft Cycles:10 Average:184.30 Median:184.00 stddev:1.16 (0.6%) stddev-sans-first:1.20 13:59:51 INFO - PROCESS | 1646 | Values: 185.0 184.0 184.0 186.0 184.0 182.0 186.0 184.0 184.0 184.0 13:59:51 INFO - PROCESS | 1646 | 13:59:51 INFO - PROCESS | 1646 | [#3] audio-fft Cycles:10 Average:71.70 Median:79.00 stddev:12.46 (15.8%) stddev-sans-first:12.85 13:59:51 INFO - PROCESS | 1646 | Values: 80.0 59.0 59.0 90.0 62.0 64.0 78.0 81.0 86.0 58.0 13:59:51 INFO - PROCESS | 1646 | 13:59:51 INFO - PROCESS | 1646 | [#4] audio-oscillator Cycles:10 Average:83.80 Median:84.50 stddev:12.33 (14.6%) stddev-sans-first:12.98 13:59:51 INFO - PROCESS | 1646 | Values: 88.0 70.0 87.0 97.0 97.0 100.0 82.0 67.0 68.0 82.0 13:59:51 INFO - PROCESS | 1646 | 13:59:51 INFO - PROCESS | 1646 | [#5] imaging-gaussian-blur Cycles:10 Average:85.00 Median:86.00 stddev:1.56 (1.8%) stddev-sans-first:1.48 13:59:51 INFO - PROCESS | 1646 | Values: 87.0 83.0 86.0 84.0 86.0 84.0 87.0 84.0 86.0 83.0 13:59:51 INFO - PROCESS | 1646 | 13:59:51 INFO - PROCESS | 1646 | [#6] imaging-darkroom Cycles:10 Average:93.90 Median:93.50 stddev:1.73 (1.8%) stddev-sans-first:1.80 13:59:51 INFO - PROCESS | 1646 | Values: 93.0 94.0 93.0 97.0 93.0 92.0 93.0 97.0 93.0 94.0 13:59:51 INFO - PROCESS | 1646 | 13:59:51 INFO - PROCESS | 1646 | [#7] imaging-desaturate Cycles:10 Average:87.10 Median:85.00 stddev:6.12 (7.2%) stddev-sans-first:6.20 13:59:51 INFO - PROCESS | 1646 | Values: 82.0 86.0 85.0 88.0 85.0 85.0 86.0 85.0 85.0 104.0 13:59:51 INFO - PROCESS | 1646 | 13:59:51 INFO - PROCESS | 1646 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:56.00 stddev:1.70 (3.0%) stddev-sans-first:1.74 13:59:51 INFO - PROCESS | 1646 | Values: 54.0 54.0 53.0 54.0 56.0 57.0 58.0 57.0 56.0 54.0 13:59:51 INFO - PROCESS | 1646 | 13:59:51 INFO - PROCESS | 1646 | [#9] json-stringify-tinderbox Cycles:10 Average:70.20 Median:69.00 stddev:4.73 (6.9%) stddev-sans-first:4.46 13:59:51 INFO - PROCESS | 1646 | Values: 64.0 67.0 81.0 74.0 73.0 68.0 69.0 69.0 68.0 69.0 13:59:51 INFO - PROCESS | 1646 | 13:59:51 INFO - PROCESS | 1646 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.00 stddev:2.88 (3.4%) stddev-sans-first:3.04 13:59:51 INFO - PROCESS | 1646 | Values: 86.0 83.0 84.0 84.0 85.0 82.0 82.0 85.0 90.0 90.0 13:59:51 INFO - PROCESS | 1646 | 13:59:51 INFO - PROCESS | 1646 | [#11] stanford-crypto-ccm Cycles:10 Average:147.30 Median:137.00 stddev:24.16 (17.6%) stddev-sans-first:25.39 13:59:51 INFO - PROCESS | 1646 | Values: 138.0 137.0 136.0 133.0 136.0 137.0 135.0 137.0 203.0 181.0 13:59:51 INFO - PROCESS | 1646 | 13:59:51 INFO - PROCESS | 1646 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.30 Median:167.00 stddev:1.42 (0.8%) stddev-sans-first:1.42 13:59:51 INFO - PROCESS | 1646 | Values: 165.0 165.0 168.0 167.0 168.0 165.0 165.0 167.0 165.0 168.0 13:59:51 INFO - PROCESS | 1646 | 13:59:51 INFO - PROCESS | 1646 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.50 stddev:0.79 (1.2%) stddev-sans-first:0.71 13:59:51 INFO - PROCESS | 1646 | Values: 64.0 66.0 65.0 65.0 65.0 65.0 66.0 66.0 66.0 64.0 13:59:51 INFO - PROCESS | 1646 | -------- Summary: end -------- 13:59:51 INFO - PROCESS | 1646 | 13:59:51 INFO - TEST-INFO | 1646: exit 0 13:59:51 INFO - TEST-OK | kraken | took 58928ms 13:59:51 INFO - SUITE-END | took 1177s 13:59:52 INFO - Completed test suite (00:19:38) 13:59:52 INFO - javascript benchmark 13:59:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3370.966290337097, 3390.066894796353, 3403.778754380965, 3413.7781044232124, 3454.740894432918, 5784.768609255625, 5796.130580412941, 5820.708964551772, 5830.854228644281, 5841.53267738581, 5747.683877386742, 5788.160716696077, 5814.7092645367775, 5852.151438041481, 5869.559783016281, 5304.734763261821, 5309.230161626571, 5337.653052551591, 5338.62629615927, 5429.104197807357, 5187.93647302304, 5189.325387699594, 5217.087009773293, 5233.607479439038, 5292.947070529284, 5310.7610157543, 5335.359756829186, 5340.0, 5340.06548853951, 5344.7862085516535, 5301.496357845998, 5305.336832895888, 5307.389650190239, 5322.707251101168, 5332.68003919766, 5172.405173405032, 5276.3140791697215, 5278.709670968095, 5302.6023048271145, 5335.413104558495, 5824.30108386992, 5831.970840145772, 5839.620424672383, 5853.209816674737, 5866.941330586682, 6195.0, 6212.844678883019, 6232.158658581079, 6238.656873871935, 6258.624482531062, 6225.501959843202, 6270.561060725751, 6280.654563998978, 6302.527310451735, 6305.96847015762, 5912.231409916726, 5916.598430229085, 5920.733566989496, 5967.075103358986, 5982.042873140276, 6230.252369715663, 6294.464970477561, 6418.839529011812, 6447.903281450735, 6472.838179045561, 6144.078388241799, 6167.660778657128, 6187.969060154671, 6218.440340369389, 6248.843778905563, 6262.436380725757, 6269.0909818076125, 6272.435480806749, 6276.592021518587, 6280.780172693934, 6256.43692067707, 6268.780592679234, 6268.937310626927, 6270.9372906271265, 6280.0893870389455, 6112.144299798032, 6168.784092556739, 6208.286047104551, 6225.657588832567, 6265.310815810257, 5081.644284900095, 5081.8729531762, 5083.87290317745, 5102.872428189251, 5125.026245013435, 4441.422615060022, 4460.04109116535, 4467.329900514948, 4501.369808226851, 4510.774461276923, 5776.0, 5817.941820581825, 5826.446487583673, 5894.38108998549, 5967.701614919237, 6193.318734939153, 6214.533909956771, 6244.0321750128805, 6252.155958945576, 6267.9373206268265, 5905.40945905406, 5953.613015154001, 5970.940290597038, 5981.611195272293, 5986.461218490357, 4718.598919091915, 5517.751701173457, 5536.557075433956, 5539.889202215933, 5584.162375643686, 6274.8431289216305, 6285.874282514415, 6375.458086062737, 6429.164208652845, 6443.838904027437, 6178.443940045418, 6244.344343843831, 6260.40526150015, 6260.499160067093, 6262.812115636538, 6321.715522801577, 6329.841753956188, 6374.107624932606, 6382.489400848014, 6387.361263873761, 6238.500919926486, 6247.812565623039, 6263.812085637438, 6266.624002559861, 6283.497320214463, 6282.403171698681, 6289.182406287337, 6289.874202515833, 6290.654014029273, 6294.433500984934, 5412.242286080031, 6151.66165860864, 6162.845928851814, 6194.256689197326, 6221.688915554295, 6228.626282423069, 6244.781432649836, 6247.0629405589525, 6249.531285153541, 6254.28075771274, 6116.418940200674, 6131.570790044654, 6156.384361563808, 6174.197354343906, 6198.0, 6110.327863934875, 6146.955017646921, 6159.384061593805, 6183.443490085914, 6264.874702505833, 6117.785877494266, 6123.130109042811, 6137.9693101535995, 6140.293866205265, 6151.292601350902], "value": 5788.391546561343, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [440.4428398076433, 444.7309377826417, 471.6816149099357, 519.8076711616702, 544.5072209650268, 31018.68981310189, 41200.793996030014, 43041.35437968433, 43062.56937430625, 43398.13203735923, 44198.0, 44642.776786116025, 44672.0, 44803.655890323345, 44830.0, 9284.3500954933, 9511.191548718367, 9511.476868772215, 9516.762080947998, 9529.618815247382, 8491.490510569385, 8713.738587842376, 11328.376939268337, 11565.884341156607, 11578.073754099652, 11562.13284003699, 11606.36165010924, 11619.302841829474, 11626.534938602446, 11628.0, 11545.191836571443, 11605.303681779036, 11637.301761894314, 11637.47631356591, 11638.418079096054, 8435.11431299717, 8640.65437382504, 11171.83242251367, 11409.345644881445, 11424.02895753862, 42184.0, 42482.78758606218, 42836.57163428388, 42854.78572607148, 42964.14071718548, 3880.1463677990796, 3969.5435024972207, 3986.1629057897876, 4014.2573623879675, 4087.3664581989838, 27475.725242747518, 27687.169384918485, 27748.722512775017, 28238.858805706044, 28324.0, 2562.5131225067175, 3207.903762887117, 3345.6152542457444, 3346.9497957530657, 3347.280334728021, 478054.0, 487553.0, 487878.0, 490117.0, 491192.0880791182, 59130.70434647885, 59529.70235148796, 59552.70223648854, 59669.40330596725, 59692.0, 62210.0668489973, 62212.0, 62222.755544889755, 62292.44268893314, 62357.68821155865, 15870.44453444124, 16110.113943732973, 16128.0, 16133.193340332937, 16153.67692646164, 11254.831177532344, 12484.188527745668, 12518.624441266777, 12582.24506529611, 12593.118481706193, 15948.687440321088, 16445.342186312413, 18257.81742182561, 18666.440006799545, 18684.81315186858, 6601.834954126185, 7202.955571442217, 7893.486923349964, 8038.437309388287, 8047.315978141806, 823.5347028928636, 873.9381651293709, 899.1727610598265, 901.4861528928448, 918.6922381002439, 30763.077107686804, 30821.537676934862, 30883.382332353227, 31293.8435307822, 31610.683893160774, 789.4118881433369, 1031.9587216511256, 1058.687687132298, 1113.2819331531116, 1182.5033485935928, 15486.380544778309, 16012.119333436773, 16043.876928615118, 16145.838541614668, 16228.107454089903, 665885.0, 672691.0, 672872.0, 673022.0, 673636.0, 63905.36094639087, 64370.0, 64389.0, 64709.02936455957, 64743.676281619235, 1440.2150827798876, 1441.2217402602478, 1483.7106764181312, 1484.7253258147277, 1485.8588434098742, 27785.44429111447, 29010.12969610915, 29750.553741694326, 29912.85043574768, 30343.544846826873, 53958.46041539534, 54298.0, 54445.0, 54531.454685452634, 54596.72701636466, 547545.0, 549952.0, 550819.0, 550965.0, 551401.0, 27986.58020129659, 28238.71761282361, 28256.15231543057, 28291.43417131687, 28319.716802832532, 48720.26919596138, 48909.0, 49219.753901230266, 49256.26115608197, 50393.74015649492, 40036.999075023356, 40429.79785101055, 40527.79736101301, 41545.79227103845, 41858.1628367437, 39500.0, 39759.0, 40531.59468405278, 41193.38209926793, 41306.380404293355, 37756.811215943744, 38140.42789358217, 38219.61780382161, 38363.61636383712, 38661.80669096637, 33155.0, 33398.49902251517, 35099.0, 35249.471257930636, 35262.64737352696, 24351.0, 25622.743772562037, 25702.485950280516, 26137.869310653325, 26292.21123366302], "value": 20492.92387632575, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.90330514066335, 382.95213098362706, 392.41726036835314, 403.66899142702977, 423.6081624497341, 12340.0, 14856.702865942689, 17537.386191483285, 20471.0, 20961.16155353784, 17920.19359128839, 18609.162587683553, 21124.366269011916, 21793.891030544826, 21857.67213491795, 4628.259478483444, 5539.889202215963, 5771.826845194651, 5778.595498315099, 5781.71091445426, 4152.68854835887, 4353.934690979638, 4358.738475691453, 4765.475797662254, 4910.631702622318, 6144.5698801083945, 6419.8395040123905, 6432.807015789511, 6483.0, 6499.1876015498065, 6188.412100850434, 6392.584482008701, 6445.581037232565, 6457.45111665509, 6479.6760161991715, 5438.592105592096, 5643.520300774439, 5650.886982260332, 5654.547636189095, 5656.688882111483, 26322.47355052888, 26551.203463896112, 26577.73422265772, 26823.92704291826, 27027.72972270272, 2726.3729342251195, 2727.481778462086, 2727.836329820217, 2732.562789953598, 2739.8767055482353, 14861.628459288604, 15314.27662704246, 15441.459548915846, 15741.449049283334, 16319.347226110942, 1771.3268957796083, 1777.4934143769094, 1780.2967827707982, 1782.6630027479391, 1787.767590213277, 126240.36879815542, 126450.0, 134635.0, 146797.2660136703, 153068.0, 11472.4837382318, 11592.246503977383, 11705.297682139098, 11732.765344693058, 11937.0, 15525.068495890282, 15591.142487163315, 15611.921940390226, 15612.3755049799, 15616.375344986074, 8472.57637118154, 8747.518886461306, 8770.693025744196, 8899.110088991049, 8911.643534258557, 8618.655253789779, 8669.653213871374, 8670.089640587648, 8830.955845220862, 8832.160944710242, 4590.449146102489, 4668.5564871337165, 4676.134915040729, 4684.718916864999, 4701.553352431513, 1754.1353598263065, 1856.5729882127187, 1999.8200161985492, 2039.826614737764, 2041.7958204179463, 1021.4841505040056, 1025.6564051042985, 1032.1381646325403, 1034.99482502587, 1068.5672302717412, 16477.423290184786, 21964.89017554934, 22089.620804330203, 22119.44701382446, 22183.32161327823, 1041.13065590233, 1043.874735031801, 1053.641761800976, 1077.369738702852, 1078.5308390850005, 11203.439828008566, 11533.826992595117, 11570.305781653127, 11571.884281157249, 11602.0, 767474.0, 774029.1298543471, 795054.0, 803984.0, 806855.0, 124456.0, 125099.0, 135355.0, 142160.0, 159916.0, 995.4574756757585, 1024.4058446101392, 1050.8003479338902, 1053.7365658585354, 1054.1514081164737, 18898.433047008613, 19367.709484358027, 19561.413157605293, 19745.308914187935, 19930.00349982466, 41678.58321416747, 54363.72818135884, 55469.72265138649, 57148.71425642845, 57455.42544574501, 81116.59441702753, 81299.5935020321, 82264.47545385061, 84322.0, 85710.57144714237, 7248.782536523912, 7473.364763994904, 7626.771196864103, 8005.559694216641, 8549.230569248797, 9215.940166880626, 12191.0, 12441.37793110359, 13204.471821127046, 13482.595522134352, 10974.615888443866, 11090.057345125755, 11108.666739997812, 11307.717307067389, 11494.19540632181, 10773.299735517166, 11155.665330040112, 11236.606718764804, 11631.88368116308, 11743.823842642538, 10435.956404359504, 11053.778924421627, 11402.20184587071, 11893.345865977455, 12011.879881201075, 6697.196336439659, 7105.640451795511, 7495.938616880401, 7610.086789585285, 7622.2758837910305, 9599.760005999626, 11157.88842111601, 11284.661460156209, 11519.424028798694, 11656.941715291368], "value": 9927.157712533535, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1435.1604311477786, 1454.716330315589, 1466.963325916852, 1472.6686495538506, 1479.0977503722731, 8065.596720163998, 8499.0, 8502.319814414848, 8512.616932238048, 8518.148185181479, 7430.479866409353, 7658.693652253917, 7676.270754278348, 8030.0, 8311.002679678431, 2313.895874685639, 2347.929562113139, 2355.6819829322994, 2355.7644235576477, 2355.8115350771895, 2348.3307257431634, 2364.7280562735245, 2383.2373640435067, 2384.558856611524, 2385.33210701004, 2314.5949458844634, 2326.127702111708, 2338.707661542307, 2356.705411823522, 2360.5160942006846, 2305.2853615379204, 2306.8615883047073, 2333.230034088747, 2334.766523347652, 2337.6493525971155, 2315.6642286868478, 2376.0614557249964, 2383.0348708772804, 2383.785459308653, 2386.5823480890776, 8431.957840210822, 8472.957635211846, 8490.957545212234, 8495.575221238974, 8499.235068843835, 5070.492950704936, 5132.640715149941, 5231.372235331746, 5237.528622424, 5247.2653828464045, 3273.1817045738567, 3339.8163101029436, 3475.391806433864, 3522.3835828730125, 3552.2540266544056, 1212.672578403826, 1231.2489381477292, 1717.3559915031863, 1759.375421725282, 1836.834684878354, 10845.891541084646, 10935.726606834813, 10937.507812148473, 10950.39772812495, 10953.945230273797, 4614.676972611885, 4766.332713420124, 4801.01579176268, 4802.759862006886, 4825.30033145192, 8702.390057839193, 8784.077671844492, 8786.297096232285, 8797.0, 8797.252233560092, 5148.073346797612, 5157.716325602053, 5159.922601160985, 5162.432132465426, 5171.482851714798, 4731.455882573479, 4732.550407711262, 4790.736509491941, 4862.294967229732, 4865.5620994109995, 3072.7234548890706, 3184.2198661328125, 3737.2525494900583, 3795.3737633290198, 3821.3503704370323, 1151.1884121694352, 1156.7570810129967, 1159.3217967488945, 1166.731651720109, 1167.0022131077976, 790.3361176611559, 867.9931279715499, 911.5761171055359, 919.4988731141544, 935.4013431403907, 5750.108733146369, 5876.9118463223085, 5903.203067585907, 6036.124761909498, 6182.845428864314, 979.4906648542718, 987.2102318145598, 1005.2058873490007, 1010.0808264479289, 1061.570064124031, 3761.9059523511582, 3786.905327366838, 3901.9609803902167, 3911.6870650347905, 3946.743461674982, 9925.15636170919, 10139.493025348704, 10257.17942564593, 10283.53724082418, 10293.845592316122, 9554.426734395958, 10055.346402483961, 10070.144037756727, 10136.442495662663, 10157.9492102539, 7794.0, 8021.077576078709, 8025.31784798287, 8043.276105150565, 8050.5169689818795, 5508.20131080999, 5587.3015873015875, 5607.831765047055, 5728.1694154348215, 5831.125331200354, 9464.006279340845, 9468.337216394786, 9475.289353298393, 9481.95259023728, 9565.378250413702, 8598.871016934625, 8922.0, 9090.636374545209, 9537.952310238405, 9549.427034377959, 6753.628550429577, 7086.610236437045, 7264.745733899288, 7293.343599076109, 7332.376747976482, 7834.804129896798, 7991.560464174526, 8062.032556093071, 8102.513849169069, 8109.189081091844, 7084.22073571917, 7169.928300716926, 7186.173590037212, 7232.349088581843, 7332.413406927326, 7051.612161331176, 7052.506324557232, 7082.645867706698, 7105.0, 7124.180719217149, 6148.661823599566, 6401.7119229633845, 6425.0, 6551.377619126175, 6556.704948277244, 5030.496950304941, 5034.270030845433, 5037.143685573388, 5121.692698438105, 5156.0, 4964.92120994382, 5027.446980832178, 5076.517730815566, 5214.921776173284, 5256.421793602624], "value": 4487.725603474031, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.65505720663805, 352.3587071529816, 363.56190790097935, 363.6999475432768, 373.6226411324561, 4536.160810250106, 5295.596666883279, 5325.973370133144, 5365.302510673612, 5372.650777699447, 4628.490866004745, 4931.679440836352, 4967.453580106186, 5293.735313234342, 5340.332458442695, 3803.2013277211818, 3900.5709371969133, 3926.666233370167, 4056.8640780581336, 4116.732412393199, 4151.792410379484, 4168.228877657628, 4170.52039015514, 4173.433338496818, 4240.646441225119, 3526.5944416392185, 3799.6580307772297, 4113.56807535209, 4116.341385378325, 4144.979275103636, 3762.418921831818, 3935.763854168759, 4122.196171746511, 4178.435911151986, 4190.596150289642, 3213.373392188524, 3661.6887564557046, 3671.559412870446, 3673.9632603674154, 3685.4287585424304, 3994.900127496807, 4375.309184851325, 4787.042591481682, 4968.627352948543, 5156.561692256163, 3967.563568007517, 4058.797060146981, 4530.297803840377, 4776.498467660915, 4782.187028205213, 5617.297837770278, 5619.185218143387, 5621.8594535136945, 5630.634008789416, 5694.5159661428825, 3334.8832790852202, 4103.0, 4109.794510274504, 4116.444280022189, 4121.381792731115, 4789.137955168103, 5170.508801663836, 5641.787015791583, 5934.6142500737315, 5969.671668058255, 3385.8476368563474, 3553.680168784822, 4123.422720819088, 4158.459400277945, 4191.015111448807, 3797.6771974381936, 4232.153569286155, 4254.468191476066, 4286.678499112579, 4302.26861433557, 4857.53853383935, 4863.0, 4880.853574392774, 4885.2427873679635, 4887.29134275528, 4686.929696054562, 5273.365256770413, 5374.946250537523, 5614.803481878114, 5659.660420374791, 1381.2127087559995, 1389.805427240187, 1390.0261628487572, 1398.8601139886134, 1400.250865786799, 889.8343170446735, 900.4736970834504, 928.3832154359169, 980.4999450280409, 988.2933702402672, 5040.344755181876, 5178.508041736029, 5178.508041736029, 5265.4997775211295, 5336.038498633218, 4888.804447822047, 4956.578690811321, 5780.71096445176, 5808.332041815245, 5841.299044114733, 4771.9522804772205, 5033.062271025681, 5330.040592693274, 5353.544948679328, 5364.275822763955, 2683.6511253536914, 2787.804853660224, 2899.289674029876, 2924.947019073132, 2932.4574953633646, 4919.926201106986, 5163.974180129076, 5194.792208311701, 5543.750531226105, 5779.739911703983, 4735.692180008288, 5084.8220312288895, 5269.631125821155, 5419.349678038582, 5703.600747947687, 5760.798372057042, 5761.3950535194035, 5783.652980821164, 5802.243934131254, 5817.5055120313555, 5153.6907785532985, 5519.779208831602, 5549.500544950974, 5567.610267281251, 5580.488780048913, 4596.4254468191475, 4815.422149341961, 4896.6572339935865, 5450.754716037709, 5519.69641669712, 4983.455128910049, 5186.948130518646, 5511.614187006871, 5773.018586840331, 5802.6808525531505, 3158.0, 3571.821079239427, 3667.6882464990776, 3702.851885924533, 3711.628837116267, 4714.434267887876, 4965.8013679452415, 5083.46623604531, 5412.648177868426, 5607.859803504945, 4680.882977925443, 5338.225957236256, 5355.491228333302, 5393.244945707683, 5412.648177868426, 4845.103655823684, 4972.204447288416, 5146.716930568855, 5343.061316275955, 5364.409914909279, 4425.74287113568, 4498.200719712141, 5239.869003274948, 5253.054450199001, 5256.684598924076, 4373.825046998085, 4996.450390457119, 5034.130545588979, 5349.491798279158, 5452.209429632601, 4712.293156026486, 4746.833860814855, 5264.289320941777, 5344.625876188629, 5461.34463864323], "value": 4053.1475789251076, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.3423748794874, 744.4081954845897, 748.1060133140899, 805.532790981231, 827.0695467598952, 12985.935070324635, 14823.481178158767, 15483.612909677264, 16400.917995410036, 17215.741763873553, 16076.115813630246, 16192.75710864338, 16400.507984760447, 16402.0, 16516.66966660669, 842.8946381702272, 860.4149178558578, 862.4566523090444, 864.779481232288, 864.9697260595881, 680.4318394140898, 700.1178515071022, 701.484408959417, 867.6399294292861, 869.2654706772798, 879.5953861223845, 904.0417157812707, 908.9454632722058, 911.098012967161, 911.7583840282331, 891.1801142948503, 902.0753727429437, 903.2006674093475, 905.6830109461702, 905.8233644439337, 523.450377104043, 539.2989114151587, 671.717878491035, 672.1933679584519, 672.3310306245318, 14624.926875365662, 15257.0, 15271.236438178046, 15299.770503442458, 15494.612634684223, 13874.653133671638, 13938.0, 13939.16365018102, 13987.65030874226, 13996.370163342674, 12218.389080545938, 12404.875951240463, 12424.689382765504, 12771.680707982281, 12906.612801615873, 4436.212683973247, 4574.634029277683, 4678.391809064834, 4679.227927391977, 4717.103750287434, 89805.55097224537, 105649.47175264152, 109796.0, 110072.4496377521, 118231.40884295524, 10771.89228107709, 10927.344359338465, 11204.0, 11298.830517542243, 11375.488103035383, 23053.423664408525, 23107.306780796604, 23108.07567697307, 23122.19072332494, 23126.0, 6580.703868325937, 7472.738454154079, 7717.807054823562, 7866.72466463671, 7936.206379362133, 4059.0258337999257, 4187.476565429321, 4275.572442755762, 4332.263515202423, 4367.519572846984, 3327.101682545699, 3369.292448585775, 3499.755017148826, 3501.649835016529, 3503.3518799022263, 649.5193556768052, 658.924223714279, 659.5020759326677, 659.8518577674811, 660.2671035150978, 508.5575549272157, 521.1817446608787, 548.8627843039241, 553.1067326268048, 565.4006752842, 7974.960125199337, 9143.451392916313, 9440.57517411718, 9580.904190958141, 9639.228861691048, 632.1308201223318, 649.5355820588302, 661.9669016549153, 665.7936039827669, 678.6403206300669, 4389.561043895585, 4662.766861656972, 4667.719936803803, 4692.202325604587, 4745.311929770164, 108395.0, 110498.0, 110573.0, 111569.0, 111886.76226475424, 67143.0, 96337.51831240799, 97428.0, 98530.5073474628, 98917.01082989221, 65556.0, 77855.61072194716, 78269.60865195752, 79663.40673186503, 80644.0, 8949.59726812308, 9092.863607045767, 9160.954195228982, 9199.477607122828, 9239.39943903644, 50598.0, 52971.73514132405, 53391.39825805232, 53488.1976770341, 54434.18348724851, 70546.64726676539, 70963.64518177582, 72372.63813680898, 72413.82758517253, 72470.0, 11364.602238921598, 11599.0, 11750.412479376168, 11776.70558236051, 11947.522099115939, 11463.312201267618, 11674.357910314675, 11844.538567082278, 12172.878271217174, 12338.81491777642, 10780.137588993019, 11594.594189203337, 11599.594014209462, 11666.70833229176, 11704.239224450383, 10685.635092913253, 11491.253068550517, 11511.0, 11558.364289964133, 11724.70688232767, 10635.042846143884, 11310.830337545109, 11345.943270283926, 11373.31760094397, 11472.483738231967, 9073.863892041756, 9473.905260947578, 9541.856872147062, 9542.379745316532, 9570.760730981781, 8095.2714255717265, 8787.736367908972, 9183.173514383738, 9222.861657075015, 9223.58493867764], "value": 7277.409233896749, "unit": "score"}], "name": "dromaeo_css", "value": 7336.210267645883, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 114.0, 116.0, 113.0, 111.0, 112.0, 113.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 107.0, 108.0, 143.0, 107.0, 108.0, 133.0, 133.0, 129.0, 105.0], "value": 120.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 184.0, 186.0, 184.0, 182.0, 186.0, 184.0, 184.0, 184.0], "value": 184.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 59.0, 90.0, 62.0, 64.0, 78.0, 81.0, 86.0, 58.0], "value": 71.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 87.0, 97.0, 97.0, 100.0, 82.0, 67.0, 68.0, 82.0], "value": 83.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 86.0, 84.0, 86.0, 84.0, 87.0, 84.0, 86.0, 83.0], "value": 85.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 93.0, 97.0, 93.0, 92.0, 93.0, 97.0, 93.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 86.0, 85.0, 88.0, 85.0, 85.0, 86.0, 85.0, 85.0, 104.0], "value": 87.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 54.0, 56.0, 57.0, 58.0, 57.0, 56.0, 54.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 81.0, 74.0, 73.0, 68.0, 69.0, 69.0, 68.0, 69.0], "value": 70.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 84.0, 84.0, 85.0, 82.0, 82.0, 85.0, 90.0, 90.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 137.0, 136.0, 133.0, 136.0, 137.0, 135.0, 137.0, 203.0, 181.0], "value": 147.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 168.0, 167.0, 168.0, 165.0, 165.0, 167.0, 165.0, 168.0], "value": 166.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 65.0, 65.0, 65.0, 66.0, 66.0, 66.0, 64.0], "value": 65.2, "unit": "score"}], "name": "kraken", "value": 1429.5, "alertThreshold": 2.0}]} 13:59:52 INFO - Return code: 0 13:59:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:59:52 ERROR - # TBPL SUCCESS # 13:59:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:59:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:59:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:59:52 INFO - 2017-03-03 13:59:52.391 screenresolution[1650:9723] starting screenresolution argv=screenresolution get 13:59:52 INFO - 2017-03-03 13:59:52.393 screenresolution[1650:9723] Display 0: 1600x1200x32@60 13:59:52 INFO - 2017-03-03 13:59:52.400 screenresolution[1651:9726] starting screenresolution argv=screenresolution list 13:59:52 INFO - Available Modes on Display 0 13:59:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:59:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:59:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:59:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:59:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:59:52 INFO - Intel Iris: 13:59:52 INFO - Chipset Model: Intel Iris 13:59:52 INFO - Type: GPU 13:59:52 INFO - Bus: Built-In 13:59:52 INFO - VRAM (Dynamic, Max): 1536 MB 13:59:52 INFO - Vendor: Intel (0x8086) 13:59:52 INFO - Device ID: 0x0a2e 13:59:52 INFO - Revision ID: 0x0009 13:59:52 INFO - Displays: 13:59:52 INFO - Display: 13:59:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:59:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:59:52 INFO - Display Serial Number: 1600x1200 60 13:59:52 INFO - Main Display: Yes 13:59:52 INFO - Mirror: Off 13:59:52 INFO - Online: Yes 13:59:52 INFO - Rotation: Supported 13:59:52 INFO - Return code: 0 13:59:52 INFO - Running post-action listener: _resource_record_post_action 13:59:52 INFO - [mozharness: 2017-03-03 21:59:52.646697Z] Finished run-tests step (success) 13:59:52 INFO - Running post-run listener: _resource_record_post_run 13:59:52 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 39126016; Write bytes: 506805760; Read time: 375; Write time: 1736 13:59:52 INFO - TinderboxPrint: CPU usage
53.5% 13:59:52 INFO - TinderboxPrint: I/O read bytes / time
39,126,016 / 375 13:59:52 INFO - TinderboxPrint: I/O write bytes / time
506,805,760 / 1,736 13:59:52 INFO - TinderboxPrint: CPU idle
2,226.9 (46.5%) 13:59:52 INFO - TinderboxPrint: CPU system
950.9 (19.8%) 13:59:52 INFO - TinderboxPrint: CPU user
1,615.9 (33.7%) 13:59:52 INFO - TinderboxPrint: Swap in / out
246,902,784 / 0 13:59:52 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205703680; Write bytes: 200935424; Read time: 15588; Write time: 437 13:59:52 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 37037056; Write bytes: 294843904; Read time: 353; Write time: 1267 13:59:53 INFO - Running post-run listener: _upload_blobber_files 13:59:53 INFO - Blob upload gear active. 13:59:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:59:53 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 13:59:53 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'] 13:59:53 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 13:59:53 INFO - (blobuploader) - INFO - Open directory for files ... 13:59:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:59:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:59:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:59:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:59:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:59:54 INFO - (blobuploader) - INFO - Done attempting. 13:59:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:59:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:59:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:59:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:59:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:59:55 INFO - (blobuploader) - INFO - Done attempting. 13:59:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:59:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:59:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:59:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:59:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:59:56 INFO - (blobuploader) - INFO - Done attempting. 13:59:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:59:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:59:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:59:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:59:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:59:59 INFO - (blobuploader) - INFO - Done attempting. 13:59:59 INFO - (blobuploader) - INFO - Iteration through files over. 13:59:59 INFO - Return code: 0 13:59:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:59:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:59:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/719da7d8aacb4250e9e0a274616dbc8172b85447e6a73aed28eab97e5cf999d6554b75aaf4cfa1bc85311d262963576059a82346138c87350492821a14be98c6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/074052af3fd921d378c01917746725d633954c4c55b514f9c4a54e4653d5121521ec69d317dd6185c7556df7d3b784ffba39ff4259b8b070837a9056380f18ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01989a553ee9952c0fef44b8d8c363b1e5c9935f75df6087d8d7992bb806c9d7ffb4af6cc8c083d7615483b3fe5c16527b24332dbb816ed2587373ba1f0052ec", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/859c6e569b2922346c55872f98200d8c38d120ef0a462840dd7d052cc616a7a5d199325bdf9623dac1640a0e9f29a3db5b1d3f6b1e8d622123effc93ae94f652"} 13:59:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:59:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:59:59 INFO - Contents: 13:59:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/719da7d8aacb4250e9e0a274616dbc8172b85447e6a73aed28eab97e5cf999d6554b75aaf4cfa1bc85311d262963576059a82346138c87350492821a14be98c6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/074052af3fd921d378c01917746725d633954c4c55b514f9c4a54e4653d5121521ec69d317dd6185c7556df7d3b784ffba39ff4259b8b070837a9056380f18ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01989a553ee9952c0fef44b8d8c363b1e5c9935f75df6087d8d7992bb806c9d7ffb4af6cc8c083d7615483b3fe5c16527b24332dbb816ed2587373ba1f0052ec", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/859c6e569b2922346c55872f98200d8c38d120ef0a462840dd7d052cc616a7a5d199325bdf9623dac1640a0e9f29a3db5b1d3f6b1e8d622123effc93ae94f652"} 13:59:59 INFO - Running post-run listener: copy_logs_to_upload_dir 13:59:59 INFO - Copying logs to upload dir... 13:59:59 INFO - mkdir: /builds/slave/test/build/upload/logs 13:59:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.808383 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-03 13:59:59.081618) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-03 13:59:59.085259) ========= 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.obVQmqNfyP/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.mza1N0Gm9m/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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/719da7d8aacb4250e9e0a274616dbc8172b85447e6a73aed28eab97e5cf999d6554b75aaf4cfa1bc85311d262963576059a82346138c87350492821a14be98c6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/074052af3fd921d378c01917746725d633954c4c55b514f9c4a54e4653d5121521ec69d317dd6185c7556df7d3b784ffba39ff4259b8b070837a9056380f18ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01989a553ee9952c0fef44b8d8c363b1e5c9935f75df6087d8d7992bb806c9d7ffb4af6cc8c083d7615483b3fe5c16527b24332dbb816ed2587373ba1f0052ec", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/859c6e569b2922346c55872f98200d8c38d120ef0a462840dd7d052cc616a7a5d199325bdf9623dac1640a0e9f29a3db5b1d3f6b1e8d622123effc93ae94f652"} build_url:https://queue.taskcluster.net/v1/task/d5XDJ_MnSW6WSXn2C5vygQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011189 build_url: 'https://queue.taskcluster.net/v1/task/d5XDJ_MnSW6WSXn2C5vygQ/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/719da7d8aacb4250e9e0a274616dbc8172b85447e6a73aed28eab97e5cf999d6554b75aaf4cfa1bc85311d262963576059a82346138c87350492821a14be98c6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/074052af3fd921d378c01917746725d633954c4c55b514f9c4a54e4653d5121521ec69d317dd6185c7556df7d3b784ffba39ff4259b8b070837a9056380f18ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01989a553ee9952c0fef44b8d8c363b1e5c9935f75df6087d8d7992bb806c9d7ffb4af6cc8c083d7615483b3fe5c16527b24332dbb816ed2587373ba1f0052ec", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/859c6e569b2922346c55872f98200d8c38d120ef0a462840dd7d052cc616a7a5d199325bdf9623dac1640a0e9f29a3db5b1d3f6b1e8d622123effc93ae94f652"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-03 13:59:59.122450) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 13:59:59.122911) ========= 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.obVQmqNfyP/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.mza1N0Gm9m/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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.005170 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 13:59:59.172601) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-03 13:59:59.173054) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-03 13:59:59.173501) ========= ========= Total master_lag: 0.18 =========